builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1471539650.49 results: success (0) buildid: 20160818092656 builduid: fbcfab189f634343b718ef311a0769a4 revision: 457c3fe90f5ff7359fd90d6ed31524eab822b418 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 10:00:50.486706) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 10:00:50.487291) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 10:00:50.487657) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 10:00:50.502495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 10:00:50.502780) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 10:00:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-08-18 10:00:50 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114187 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 10:00:50.630987) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 10:00:50.631340) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015960 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 10:00:50.681447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 10:00:50.681797) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 457c3fe90f5ff7359fd90d6ed31524eab822b418 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 457c3fe90f5ff7359fd90d6ed31524eab822b418 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 10:00:50,746 truncating revision to first 12 chars 2016-08-18 10:00:50,747 Setting DEBUG logging. 2016-08-18 10:00:50,747 attempt 1/10 2016-08-18 10:00:50,747 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/457c3fe90f5f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 10:00:51,073 unpacking tar archive at: fx-team-457c3fe90f5f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.627994 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 10:00:51.323439) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 10:00:51.323761) ========= script_repo_revision: 457c3fe90f5ff7359fd90d6ed31524eab822b418 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 10:00:51.324151) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 10:00:51.324418) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 10:00:51.333791) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-18 10:00:51.334170) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:00:51 INFO - MultiFileLogger online at 20160818 10:00:51 in /builds/slave/test 10:00:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:00:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:00:51 INFO - {'append_to_log': False, 10:00:51 INFO - 'base_work_dir': '/builds/slave/test', 10:00:51 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:00:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:00:51 INFO - 'branch': 'Fx-Team-Non-PGO', 10:00:51 INFO - 'buildbot_json_path': 'buildprops.json', 10:00:51 INFO - 'config_files': ('talos/linux_config.py',), 10:00:51 INFO - 'default_actions': ('clobber', 10:00:51 INFO - 'read-buildbot-config', 10:00:51 INFO - 'download-and-extract', 10:00:51 INFO - 'populate-webroot', 10:00:51 INFO - 'create-virtualenv', 10:00:51 INFO - 'install', 10:00:51 INFO - 'run-tests'), 10:00:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:00:51 INFO - 'download_minidump_stackwalk': True, 10:00:51 INFO - 'download_symbols': 'ondemand', 10:00:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:00:51 INFO - 'tooltool.py': '/tools/tooltool.py', 10:00:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:00:51 INFO - '/tools/misc-python/virtualenv.py')}, 10:00:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:00:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:00:51 INFO - 'installer_path': 'installer.exe', 10:00:51 INFO - 'log_level': 'info', 10:00:51 INFO - 'log_name': 'talos', 10:00:51 INFO - 'log_to_console': True, 10:00:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:00:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:00:51 INFO - 'opt_config_files': (), 10:00:51 INFO - 'pip_index': False, 10:00:51 INFO - 'sps_profile': False, 10:00:51 INFO - 'sps_profile_interval': 0, 10:00:51 INFO - 'suite': 'dromaeojs', 10:00:51 INFO - 'system_bits': '32', 10:00:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:00:51 INFO - 'title': 'talos-linux64-ix-037', 10:00:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:00:51 INFO - 'use_talos_json': True, 10:00:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:00:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:00:51 INFO - 'work_dir': 'build'} 10:00:51 INFO - [mozharness: 2016-08-18 17:00:51.494372Z] Running clobber step. 10:00:51 INFO - Running pre-action listener: _resource_record_pre_action 10:00:51 INFO - Running main action method: clobber 10:00:51 INFO - rmtree: /builds/slave/test/build 10:00:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:00:51 INFO - Running post-action listener: _resource_record_post_action 10:00:51 INFO - [mozharness: 2016-08-18 17:00:51.972312Z] Finished clobber step (success) 10:00:51 INFO - [mozharness: 2016-08-18 17:00:51.972413Z] Running read-buildbot-config step. 10:00:51 INFO - Running pre-action listener: _resource_record_pre_action 10:00:51 INFO - Running main action method: read_buildbot_config 10:00:51 INFO - Using buildbot properties: 10:00:51 INFO - { 10:00:51 INFO - "project": "", 10:00:51 INFO - "product": "firefox", 10:00:51 INFO - "script_repo_revision": "production", 10:00:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:00:51 INFO - "repository": "", 10:00:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:00:51 INFO - "buildid": "20160818092656", 10:00:51 INFO - "pgo_build": "False", 10:00:51 INFO - "basedir": "/builds/slave/test", 10:00:51 INFO - "buildnumber": 2098, 10:00:51 INFO - "slavename": "talos-linux64-ix-037", 10:00:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:00:51 INFO - "platform": "ubuntu64_hw", 10:00:51 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:00:51 INFO - "branch": "fx-team", 10:00:51 INFO - "repo_path": "integration/fx-team", 10:00:51 INFO - "revision": "457c3fe90f5ff7359fd90d6ed31524eab822b418", 10:00:51 INFO - "stage_platform": "linux64", 10:00:51 INFO - "builduid": "fbcfab189f634343b718ef311a0769a4", 10:00:51 INFO - "slavebuilddir": "test" 10:00:51 INFO - } 10:00:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:00:51 INFO - Running post-action listener: _resource_record_post_action 10:00:51 INFO - [mozharness: 2016-08-18 17:00:51.974853Z] Finished read-buildbot-config step (success) 10:00:51 INFO - [mozharness: 2016-08-18 17:00:51.974941Z] Running download-and-extract step. 10:00:51 INFO - Running pre-action listener: _resource_record_pre_action 10:00:51 INFO - Running main action method: download_and_extract 10:00:51 INFO - mkdir: /builds/slave/test/build/tests 10:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:51 INFO - trying https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:00:51 INFO - Downloading https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:00:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:00:52 INFO - Downloaded 1361 bytes. 10:00:52 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:00:52 INFO - Using the following test package requirements: 10:00:52 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:00:52 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:00:52 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:00:52 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:52 INFO - u'jsshell-linux-x86_64.zip'], 10:00:52 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:00:52 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:00:52 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:00:52 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:00:52 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:00:52 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:00:52 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:52 INFO - trying https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:00:52 INFO - Downloading https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:00:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:00:53 INFO - Downloaded 20317595 bytes. 10:00:53 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 10:00:57 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:57 INFO - trying https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:00:57 INFO - Downloading https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:00:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:00:58 INFO - Downloaded 20317595 bytes. 10:00:58 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 10:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:02 INFO - trying https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:02 INFO - Downloading https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:01:03 INFO - Downloaded 14413981 bytes. 10:01:03 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 10:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:04 INFO - trying https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:01:04 INFO - Downloading https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:01:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:01:05 INFO - Downloaded 55758774 bytes. 10:01:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:01:05 INFO - mkdir: /builds/slave/test/properties 10:01:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:01:05 INFO - Writing to file /builds/slave/test/properties/build_url 10:01:05 INFO - Contents: 10:01:05 INFO - build_url:https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:01:06 INFO - Running post-action listener: _resource_record_post_action 10:01:06 INFO - Running post-action listener: set_extra_try_arguments 10:01:06 INFO - [mozharness: 2016-08-18 17:01:06.316648Z] Finished download-and-extract step (success) 10:01:06 INFO - [mozharness: 2016-08-18 17:01:06.316872Z] Running populate-webroot step. 10:01:06 INFO - Running pre-action listener: _resource_record_pre_action 10:01:06 INFO - Running main action method: populate_webroot 10:01:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:01:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:01:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:01:06 INFO - '--tppagecycles', 10:01:06 INFO - '7'], 10:01:06 INFO - 'tests': ['tsvgm']}}, 10:01:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:01:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:01:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:01:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:01:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:01:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:01:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:06 INFO - 'talos_options': ['--disable-e10s'], 10:01:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:06 INFO - 'talos_options': ['--disable-e10s'], 10:01:06 INFO - 'tests': ['damp', 'tps']}, 10:01:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:06 INFO - 'tests': ['damp', 'tps']}, 10:01:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:01:06 INFO - 'tests': ['dromaeo_dom']}, 10:01:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:01:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:01:06 INFO - 'tests': ['basic_compositor_video']}, 10:01:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:01:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:01:06 INFO - 'tests': ['a11yr', 10:01:06 INFO - 'ts_paint', 10:01:06 INFO - 'tpaint', 10:01:06 INFO - 'sessionrestore', 10:01:06 INFO - 'sessionrestore_no_auto_restore', 10:01:06 INFO - 'tabpaint']}, 10:01:06 INFO - 'other-e10s': {'tests': ['a11yr', 10:01:06 INFO - 'ts_paint', 10:01:06 INFO - 'tpaint', 10:01:06 INFO - 'sessionrestore', 10:01:06 INFO - 'sessionrestore_no_auto_restore', 10:01:06 INFO - 'tabpaint']}, 10:01:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:01:06 INFO - 'ts_paint', 10:01:06 INFO - 'tpaint', 10:01:06 INFO - 'sessionrestore', 10:01:06 INFO - 'sessionrestore_no_auto_restore', 10:01:06 INFO - 'tabpaint']}, 10:01:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:01:06 INFO - 'ts_paint', 10:01:06 INFO - 'tpaint', 10:01:06 INFO - 'sessionrestore', 10:01:06 INFO - 'sessionrestore_no_auto_restore', 10:01:06 INFO - 'tabpaint']}, 10:01:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:01:06 INFO - 'tests': ['a11yr', 10:01:06 INFO - 'ts_paint', 10:01:06 INFO - 'tpaint', 10:01:06 INFO - 'sessionrestore', 10:01:06 INFO - 'sessionrestore_no_auto_restore', 10:01:06 INFO - 'tabpaint']}, 10:01:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:01:06 INFO - 'tests': ['a11yr', 10:01:06 INFO - 'ts_paint', 10:01:06 INFO - 'tpaint', 10:01:06 INFO - 'sessionrestore', 10:01:06 INFO - 'sessionrestore_no_auto_restore', 10:01:06 INFO - 'tabpaint']}, 10:01:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:01:06 INFO - 'tests': ['tsvgx', 10:01:06 INFO - 'tsvgr_opacity', 10:01:06 INFO - 'tart', 10:01:06 INFO - 'tscrollx', 10:01:06 INFO - 'cart']}, 10:01:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:01:06 INFO - 'tsvgr_opacity', 10:01:06 INFO - 'tart', 10:01:06 INFO - 'tscrollx', 10:01:06 INFO - 'cart']}, 10:01:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:06 INFO - 'talos_options': ['--disable-e10s'], 10:01:06 INFO - 'tests': ['tp5o']}, 10:01:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:06 INFO - 'tests': ['tp5o']}, 10:01:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:06 INFO - 'talos_options': ['--disable-e10s', 10:01:06 INFO - '--xperf_path', 10:01:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:06 INFO - 'tests': ['tp5n']}, 10:01:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:06 INFO - 'talos_options': ['--xperf_path', 10:01:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:06 INFO - 'tests': ['tp5n']}}, 10:01:06 INFO - 'talos.zip': {'path': '', 10:01:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:01:06 INFO - Running post-action listener: _resource_record_post_action 10:01:06 INFO - [mozharness: 2016-08-18 17:01:06.335733Z] Finished populate-webroot step (success) 10:01:06 INFO - [mozharness: 2016-08-18 17:01:06.335822Z] Running create-virtualenv step. 10:01:06 INFO - Running pre-action listener: _resource_record_pre_action 10:01:06 INFO - Running main action method: create_virtualenv 10:01:06 INFO - Creating virtualenv /builds/slave/test/build/venv 10:01:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:01:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:01:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:01:06 INFO - Using real prefix '/usr' 10:01:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:01:06 INFO - Installing distribute.............................................................................................................................................................................................done. 10:01:08 INFO - Installing pip.................done. 10:01:08 INFO - Return code: 0 10:01:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39d959ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8de40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:01:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:01:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:01:08 INFO - Using env: {'DISPLAY': ':0', 10:01:08 INFO - 'HOME': '/home/cltbld', 10:01:08 INFO - 'LANG': 'en_US.UTF-8', 10:01:08 INFO - 'LANGUAGE': 'en_US:en', 10:01:08 INFO - 'LOGNAME': 'cltbld', 10:01:08 INFO - 'MAIL': '/var/mail/cltbld', 10:01:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:08 INFO - 'MOZ_NO_REMOTE': '1', 10:01:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:08 INFO - 'NO_EM_RESTART': '1', 10:01:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:08 INFO - 'PWD': '/builds/slave/test', 10:01:08 INFO - 'SHELL': '/bin/bash', 10:01:08 INFO - 'SHLVL': '1', 10:01:08 INFO - 'TERM': 'linux', 10:01:08 INFO - 'TMOUT': '86400', 10:01:08 INFO - 'USER': 'cltbld', 10:01:08 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 10:01:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:08 INFO - '_': '/tools/buildbot/bin/python'} 10:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:01:09 INFO - Cleaning up... 10:01:09 INFO - Return code: 0 10:01:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39d959ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8de40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:01:09 INFO - Using env: {'DISPLAY': ':0', 10:01:09 INFO - 'HOME': '/home/cltbld', 10:01:09 INFO - 'LANG': 'en_US.UTF-8', 10:01:09 INFO - 'LANGUAGE': 'en_US:en', 10:01:09 INFO - 'LOGNAME': 'cltbld', 10:01:09 INFO - 'MAIL': '/var/mail/cltbld', 10:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:09 INFO - 'MOZ_NO_REMOTE': '1', 10:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:09 INFO - 'NO_EM_RESTART': '1', 10:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:09 INFO - 'PWD': '/builds/slave/test', 10:01:09 INFO - 'SHELL': '/bin/bash', 10:01:09 INFO - 'SHLVL': '1', 10:01:09 INFO - 'TERM': 'linux', 10:01:09 INFO - 'TMOUT': '86400', 10:01:09 INFO - 'USER': 'cltbld', 10:01:09 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 10:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:09 INFO - '_': '/tools/buildbot/bin/python'} 10:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:09 INFO - Downloading/unpacking psutil>=3.1.1 10:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:01:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:11 INFO - Installing collected packages: psutil 10:01:11 INFO - Running setup.py install for psutil 10:01:11 INFO - building 'psutil._psutil_linux' extension 10:01:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:01:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:01:11 INFO - building 'psutil._psutil_posix' extension 10:01:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:01:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:01:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:11 INFO - Successfully installed psutil 10:01:11 INFO - Cleaning up... 10:01:11 INFO - Return code: 0 10:01:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:01:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39d959ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8de40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:01:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:01:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:01:11 INFO - Using env: {'DISPLAY': ':0', 10:01:11 INFO - 'HOME': '/home/cltbld', 10:01:11 INFO - 'LANG': 'en_US.UTF-8', 10:01:11 INFO - 'LANGUAGE': 'en_US:en', 10:01:11 INFO - 'LOGNAME': 'cltbld', 10:01:11 INFO - 'MAIL': '/var/mail/cltbld', 10:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:11 INFO - 'MOZ_NO_REMOTE': '1', 10:01:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:11 INFO - 'NO_EM_RESTART': '1', 10:01:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:11 INFO - 'PWD': '/builds/slave/test', 10:01:11 INFO - 'SHELL': '/bin/bash', 10:01:11 INFO - 'SHLVL': '1', 10:01:11 INFO - 'TERM': 'linux', 10:01:11 INFO - 'TMOUT': '86400', 10:01:11 INFO - 'USER': 'cltbld', 10:01:11 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 10:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:11 INFO - '_': '/tools/buildbot/bin/python'} 10:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:01:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:01:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:01:14 INFO - Installing collected packages: mozsystemmonitor 10:01:14 INFO - Running setup.py install for mozsystemmonitor 10:01:14 INFO - Successfully installed mozsystemmonitor 10:01:14 INFO - Cleaning up... 10:01:14 INFO - Return code: 0 10:01:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39d959ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8de40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:01:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:01:14 INFO - Using env: {'DISPLAY': ':0', 10:01:14 INFO - 'HOME': '/home/cltbld', 10:01:14 INFO - 'LANG': 'en_US.UTF-8', 10:01:14 INFO - 'LANGUAGE': 'en_US:en', 10:01:14 INFO - 'LOGNAME': 'cltbld', 10:01:14 INFO - 'MAIL': '/var/mail/cltbld', 10:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:14 INFO - 'MOZ_NO_REMOTE': '1', 10:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:14 INFO - 'NO_EM_RESTART': '1', 10:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:14 INFO - 'PWD': '/builds/slave/test', 10:01:14 INFO - 'SHELL': '/bin/bash', 10:01:14 INFO - 'SHLVL': '1', 10:01:14 INFO - 'TERM': 'linux', 10:01:14 INFO - 'TMOUT': '86400', 10:01:14 INFO - 'USER': 'cltbld', 10:01:14 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 10:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:14 INFO - '_': '/tools/buildbot/bin/python'} 10:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:14 INFO - Downloading/unpacking jsonschema==2.5.1 10:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:01:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:16 INFO - Downloading functools32-3.2.3-2.tar.gz 10:01:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:01:16 INFO - warning: no files found matching '*.txt' 10:01:16 INFO - no previously-included directories found matching 'build' 10:01:16 INFO - no previously-included directories found matching 'dist' 10:01:16 INFO - no previously-included directories found matching '.git*' 10:01:16 INFO - Installing collected packages: jsonschema, functools32 10:01:16 INFO - Running setup.py install for functools32 10:01:16 INFO - warning: no files found matching '*.txt' 10:01:16 INFO - no previously-included directories found matching 'build' 10:01:16 INFO - no previously-included directories found matching 'dist' 10:01:16 INFO - no previously-included directories found matching '.git*' 10:01:16 INFO - Successfully installed jsonschema functools32 10:01:16 INFO - Cleaning up... 10:01:16 INFO - Return code: 0 10:01:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39d959ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8de40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:01:16 INFO - Using env: {'DISPLAY': ':0', 10:01:16 INFO - 'HOME': '/home/cltbld', 10:01:16 INFO - 'LANG': 'en_US.UTF-8', 10:01:16 INFO - 'LANGUAGE': 'en_US:en', 10:01:16 INFO - 'LOGNAME': 'cltbld', 10:01:16 INFO - 'MAIL': '/var/mail/cltbld', 10:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:16 INFO - 'MOZ_NO_REMOTE': '1', 10:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:16 INFO - 'NO_EM_RESTART': '1', 10:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:16 INFO - 'PWD': '/builds/slave/test', 10:01:16 INFO - 'SHELL': '/bin/bash', 10:01:16 INFO - 'SHLVL': '1', 10:01:16 INFO - 'TERM': 'linux', 10:01:16 INFO - 'TMOUT': '86400', 10:01:16 INFO - 'USER': 'cltbld', 10:01:16 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 10:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:16 INFO - '_': '/tools/buildbot/bin/python'} 10:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:01:17 INFO - Cleaning up... 10:01:17 INFO - Return code: 0 10:01:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39d959ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8de40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:01:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:01:17 INFO - Using env: {'DISPLAY': ':0', 10:01:17 INFO - 'HOME': '/home/cltbld', 10:01:17 INFO - 'LANG': 'en_US.UTF-8', 10:01:17 INFO - 'LANGUAGE': 'en_US:en', 10:01:17 INFO - 'LOGNAME': 'cltbld', 10:01:17 INFO - 'MAIL': '/var/mail/cltbld', 10:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:17 INFO - 'MOZ_NO_REMOTE': '1', 10:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:17 INFO - 'NO_EM_RESTART': '1', 10:01:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:17 INFO - 'PWD': '/builds/slave/test', 10:01:17 INFO - 'SHELL': '/bin/bash', 10:01:17 INFO - 'SHLVL': '1', 10:01:17 INFO - 'TERM': 'linux', 10:01:17 INFO - 'TMOUT': '86400', 10:01:17 INFO - 'USER': 'cltbld', 10:01:17 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 10:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:17 INFO - '_': '/tools/buildbot/bin/python'} 10:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:17 INFO - Downloading/unpacking blobuploader==1.2.4 10:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:19 INFO - Downloading blobuploader-1.2.4.tar.gz 10:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:01:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:01:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:19 INFO - Downloading docopt-0.6.1.tar.gz 10:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:01:19 INFO - Installing collected packages: blobuploader, requests, docopt 10:01:19 INFO - Running setup.py install for blobuploader 10:01:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:01:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:01:20 INFO - Running setup.py install for requests 10:01:20 INFO - Running setup.py install for docopt 10:01:20 INFO - Successfully installed blobuploader requests docopt 10:01:20 INFO - Cleaning up... 10:01:20 INFO - Return code: 0 10:01:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39d959ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8de40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:01:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:01:20 INFO - Using env: {'DISPLAY': ':0', 10:01:20 INFO - 'HOME': '/home/cltbld', 10:01:20 INFO - 'LANG': 'en_US.UTF-8', 10:01:20 INFO - 'LANGUAGE': 'en_US:en', 10:01:20 INFO - 'LOGNAME': 'cltbld', 10:01:20 INFO - 'MAIL': '/var/mail/cltbld', 10:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:20 INFO - 'MOZ_NO_REMOTE': '1', 10:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:20 INFO - 'NO_EM_RESTART': '1', 10:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:20 INFO - 'PWD': '/builds/slave/test', 10:01:20 INFO - 'SHELL': '/bin/bash', 10:01:20 INFO - 'SHLVL': '1', 10:01:20 INFO - 'TERM': 'linux', 10:01:20 INFO - 'TMOUT': '86400', 10:01:20 INFO - 'USER': 'cltbld', 10:01:20 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 10:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:20 INFO - '_': '/tools/buildbot/bin/python'} 10:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:01:20 INFO - Running setup.py (path:/tmp/pip-pcIShR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:01:20 INFO - Running setup.py (path:/tmp/pip-EJRyIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:01:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:01:20 INFO - Running setup.py (path:/tmp/pip-pmrMC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:01:21 INFO - Running setup.py (path:/tmp/pip-HRzUSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:01:21 INFO - Running setup.py (path:/tmp/pip-zjNrtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:01:21 INFO - Running setup.py (path:/tmp/pip-cdL9_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:01:21 INFO - Running setup.py (path:/tmp/pip-Qg67Ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:01:21 INFO - Running setup.py (path:/tmp/pip-33t3JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:01:21 INFO - Running setup.py (path:/tmp/pip-r4CAFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:01:21 INFO - Running setup.py (path:/tmp/pip-N9AZUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:01:21 INFO - Running setup.py (path:/tmp/pip-LMnDLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:01:21 INFO - Running setup.py (path:/tmp/pip-Vnd3LW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:01:21 INFO - Running setup.py (path:/tmp/pip-R1qemQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:01:21 INFO - Running setup.py (path:/tmp/pip-Gj3Bbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:21 INFO - Running setup.py (path:/tmp/pip-ouu5JJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:01:21 INFO - Running setup.py (path:/tmp/pip-uyMjsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:01:21 INFO - Running setup.py (path:/tmp/pip-cKdEFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:01:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:01:22 INFO - Running setup.py install for manifestparser 10:01:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:01:22 INFO - Running setup.py install for mozcrash 10:01:22 INFO - Running setup.py install for mozdebug 10:01:22 INFO - Running setup.py install for mozdevice 10:01:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:01:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:01:22 INFO - Running setup.py install for mozfile 10:01:22 INFO - Running setup.py install for mozhttpd 10:01:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:01:22 INFO - Running setup.py install for mozinfo 10:01:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:01:22 INFO - Running setup.py install for mozInstall 10:01:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:01:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:01:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:01:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:01:22 INFO - Running setup.py install for mozleak 10:01:22 INFO - Running setup.py install for mozlog 10:01:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:01:23 INFO - Running setup.py install for moznetwork 10:01:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:01:23 INFO - Running setup.py install for mozprocess 10:01:23 INFO - Running setup.py install for mozprofile 10:01:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:01:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:01:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:01:23 INFO - Running setup.py install for mozrunner 10:01:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:01:23 INFO - Running setup.py install for mozscreenshot 10:01:23 INFO - Running setup.py install for moztest 10:01:23 INFO - Running setup.py install for mozversion 10:01:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:01:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:01:23 INFO - Cleaning up... 10:01:23 INFO - Return code: 0 10:01:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39d959ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8de40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:01:23 INFO - Using env: {'DISPLAY': ':0', 10:01:23 INFO - 'HOME': '/home/cltbld', 10:01:23 INFO - 'LANG': 'en_US.UTF-8', 10:01:23 INFO - 'LANGUAGE': 'en_US:en', 10:01:23 INFO - 'LOGNAME': 'cltbld', 10:01:23 INFO - 'MAIL': '/var/mail/cltbld', 10:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:23 INFO - 'MOZ_NO_REMOTE': '1', 10:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:23 INFO - 'NO_EM_RESTART': '1', 10:01:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:23 INFO - 'PWD': '/builds/slave/test', 10:01:23 INFO - 'SHELL': '/bin/bash', 10:01:23 INFO - 'SHLVL': '1', 10:01:23 INFO - 'TERM': 'linux', 10:01:23 INFO - 'TMOUT': '86400', 10:01:23 INFO - 'USER': 'cltbld', 10:01:23 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 10:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:23 INFO - '_': '/tools/buildbot/bin/python'} 10:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:01:24 INFO - Running setup.py (path:/tmp/pip-vTbrSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:01:24 INFO - Running setup.py (path:/tmp/pip-bHBMt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:01:24 INFO - Running setup.py (path:/tmp/pip-LPP4gK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:01:24 INFO - Running setup.py (path:/tmp/pip-324qnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:01:24 INFO - Running setup.py (path:/tmp/pip-eqe4GR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:01:24 INFO - Running setup.py (path:/tmp/pip-0O5ril-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:01:24 INFO - Running setup.py (path:/tmp/pip-TNB49Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:01:24 INFO - Running setup.py (path:/tmp/pip-a6ly1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:01:24 INFO - Running setup.py (path:/tmp/pip-f90fX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:01:24 INFO - Running setup.py (path:/tmp/pip-UoIPQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:01:24 INFO - Running setup.py (path:/tmp/pip-hpoYmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:01:24 INFO - Running setup.py (path:/tmp/pip-N8A6of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:01:24 INFO - Running setup.py (path:/tmp/pip-OxlbbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:01:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:01:24 INFO - Running setup.py (path:/tmp/pip-Ugwp0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:25 INFO - Running setup.py (path:/tmp/pip-qSkF_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:01:25 INFO - Running setup.py (path:/tmp/pip-PVM0er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:01:25 INFO - Running setup.py (path:/tmp/pip-Z073TX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:01:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:27 INFO - Downloading blessings-1.6.tar.gz 10:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:01:27 INFO - Installing collected packages: blessings 10:01:27 INFO - Running setup.py install for blessings 10:01:27 INFO - Successfully installed blessings 10:01:27 INFO - Cleaning up... 10:01:27 INFO - Return code: 0 10:01:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:01:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:01:27 INFO - Reading from file tmpfile_stdout 10:01:27 INFO - Current package versions: 10:01:27 INFO - argparse == 1.2.1 10:01:27 INFO - blessings == 1.6 10:01:27 INFO - blobuploader == 1.2.4 10:01:27 INFO - docopt == 0.6.1 10:01:27 INFO - functools32 == 3.2.3-2 10:01:27 INFO - jsonschema == 2.5.1 10:01:27 INFO - manifestparser == 1.1 10:01:27 INFO - mozInstall == 1.12 10:01:27 INFO - mozcrash == 0.17 10:01:27 INFO - mozdebug == 0.1 10:01:27 INFO - mozdevice == 0.48 10:01:27 INFO - mozfile == 1.2 10:01:27 INFO - mozhttpd == 0.7 10:01:27 INFO - mozinfo == 0.9 10:01:27 INFO - mozleak == 0.1 10:01:27 INFO - mozlog == 3.3 10:01:27 INFO - moznetwork == 0.27 10:01:27 INFO - mozprocess == 0.23 10:01:27 INFO - mozprofile == 0.28 10:01:27 INFO - mozrunner == 6.12 10:01:27 INFO - mozscreenshot == 0.1 10:01:27 INFO - mozsystemmonitor == 0.3 10:01:27 INFO - moztest == 0.7 10:01:27 INFO - mozversion == 1.4 10:01:27 INFO - psutil == 3.1.1 10:01:27 INFO - requests == 1.2.3 10:01:27 INFO - wsgiref == 0.1.2 10:01:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39d959ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8de40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:01:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:01:27 INFO - Using env: {'DISPLAY': ':0', 10:01:27 INFO - 'HOME': '/home/cltbld', 10:01:27 INFO - 'LANG': 'en_US.UTF-8', 10:01:27 INFO - 'LANGUAGE': 'en_US:en', 10:01:27 INFO - 'LOGNAME': 'cltbld', 10:01:27 INFO - 'MAIL': '/var/mail/cltbld', 10:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:27 INFO - 'MOZ_NO_REMOTE': '1', 10:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:27 INFO - 'NO_EM_RESTART': '1', 10:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:27 INFO - 'PWD': '/builds/slave/test', 10:01:27 INFO - 'SHELL': '/bin/bash', 10:01:27 INFO - 'SHLVL': '1', 10:01:27 INFO - 'TERM': 'linux', 10:01:27 INFO - 'TMOUT': '86400', 10:01:27 INFO - 'USER': 'cltbld', 10:01:27 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 10:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:27 INFO - '_': '/tools/buildbot/bin/python'} 10:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:01:27 INFO - Cleaning up... 10:01:27 INFO - Return code: 0 10:01:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39d959ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8de40>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:01:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:01:27 INFO - Using env: {'DISPLAY': ':0', 10:01:27 INFO - 'HOME': '/home/cltbld', 10:01:27 INFO - 'LANG': 'en_US.UTF-8', 10:01:27 INFO - 'LANGUAGE': 'en_US:en', 10:01:27 INFO - 'LOGNAME': 'cltbld', 10:01:27 INFO - 'MAIL': '/var/mail/cltbld', 10:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:27 INFO - 'MOZ_NO_REMOTE': '1', 10:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:27 INFO - 'NO_EM_RESTART': '1', 10:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:27 INFO - 'PWD': '/builds/slave/test', 10:01:27 INFO - 'SHELL': '/bin/bash', 10:01:27 INFO - 'SHLVL': '1', 10:01:27 INFO - 'TERM': 'linux', 10:01:27 INFO - 'TMOUT': '86400', 10:01:27 INFO - 'USER': 'cltbld', 10:01:27 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 10:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:27 INFO - '_': '/tools/buildbot/bin/python'} 10:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:01:28 INFO - Cleaning up... 10:01:28 INFO - Return code: 0 10:01:28 INFO - Running post-action listener: _resource_record_post_action 10:01:28 INFO - Running post-action listener: _start_resource_monitoring 10:01:28 INFO - Starting resource monitoring. 10:01:28 INFO - [mozharness: 2016-08-18 17:01:28.064994Z] Finished create-virtualenv step (success) 10:01:28 INFO - [mozharness: 2016-08-18 17:01:28.065463Z] Running install step. 10:01:28 INFO - Running pre-action listener: _resource_record_pre_action 10:01:28 INFO - Running main action method: install 10:01:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:01:28 INFO - Reading from file tmpfile_stdout 10:01:28 INFO - Detecting whether we're running mozinstall >=1.0... 10:01:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:01:28 INFO - Reading from file tmpfile_stdout 10:01:28 INFO - Output received: 10:01:28 INFO - Usage: mozinstall [options] installer 10:01:28 INFO - Options: 10:01:28 INFO - -h, --help show this help message and exit 10:01:28 INFO - -d DEST, --destination=DEST 10:01:28 INFO - Directory to install application into. [default: 10:01:28 INFO - "/builds/slave/test"] 10:01:28 INFO - --app=APP Application being installed. [default: firefox] 10:01:28 INFO - mkdir: /builds/slave/test/build/application 10:01:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:01:44 INFO - Reading from file tmpfile_stdout 10:01:44 INFO - Output received: 10:01:44 INFO - /builds/slave/test/build/application/firefox/firefox 10:01:44 INFO - Running post-action listener: _resource_record_post_action 10:01:44 INFO - [mozharness: 2016-08-18 17:01:44.439594Z] Finished install step (success) 10:01:44 INFO - [mozharness: 2016-08-18 17:01:44.439844Z] Running run-tests step. 10:01:44 INFO - Running pre-action listener: _resource_record_pre_action 10:01:44 INFO - Running main action method: run_tests 10:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:01:44 INFO - Python 2.7.3 10:01:44 INFO - Return code: 0 10:01:44 INFO - grabbing minidump binary from tooltool 10:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8a090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8de40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:01:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:01:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:01:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:01:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:01:44 INFO - Return code: 0 10:01:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:01:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:01:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:01:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:01:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:01:44 INFO - Using env: {'DISPLAY': ':0', 10:01:44 INFO - 'HOME': '/home/cltbld', 10:01:44 INFO - 'LANG': 'en_US.UTF-8', 10:01:44 INFO - 'LANGUAGE': 'en_US:en', 10:01:44 INFO - 'LOGNAME': 'cltbld', 10:01:44 INFO - 'MAIL': '/var/mail/cltbld', 10:01:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:01:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:44 INFO - 'MOZ_NO_REMOTE': '1', 10:01:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:44 INFO - 'NO_EM_RESTART': '1', 10:01:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:44 INFO - 'PWD': '/builds/slave/test', 10:01:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:01:44 INFO - 'SHELL': '/bin/bash', 10:01:44 INFO - 'SHLVL': '1', 10:01:44 INFO - 'TERM': 'linux', 10:01:44 INFO - 'TMOUT': '86400', 10:01:44 INFO - 'USER': 'cltbld', 10:01:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456', 10:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:44 INFO - '_': '/tools/buildbot/bin/python'} 10:01:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:01:44 INFO - mozversion application_buildid: 20160818092656 10:01:44 INFO - mozversion application_changeset: 457c3fe90f5ff7359fd90d6ed31524eab822b418 10:01:44 INFO - mozversion application_display_name: Nightly 10:01:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:01:44 INFO - mozversion application_name: Firefox 10:01:44 INFO - mozversion application_remotingname: firefox 10:01:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:01:44 INFO - mozversion application_vendor: Mozilla 10:01:44 INFO - mozversion application_version: 51.0a1 10:01:44 INFO - mozversion platform_buildid: 20160818092656 10:01:44 INFO - mozversion platform_changeset: 457c3fe90f5ff7359fd90d6ed31524eab822b418 10:01:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:01:44 INFO - mozversion platform_version: 51.0a1 10:01:44 INFO - using testdate: 1471539704 10:01:44 INFO - actual date: 1471539704 10:01:44 INFO - starting webserver on 'localhost:58377' 10:01:44 INFO - SUITE-START | Running 2 tests 10:01:44 INFO - TEST-START | dromaeo_css 10:01:44 INFO - operating with platform_type : linux_ 10:01:44 INFO - Initialising browser for dromaeo_css test... 10:01:44 INFO - TEST-INFO | started process 5073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuXG6aN/profile http://localhost:58377/getInfo.html) 10:01:48 INFO - PROCESS | 5073 | __metrics Screen width/height:1600/1200 10:01:48 INFO - PROCESS | 5073 | colorDepth:24 10:01:48 INFO - PROCESS | 5073 | Browser inner width/height: 1024/697 10:01:48 INFO - PROCESS | 5073 | __metrics 10:01:49 INFO - PROCESS | 5073 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:01:49 INFO - PROCESS | 5073 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:01:49 INFO - PROCESS | 5073 | console.error: PushService: 10:01:49 INFO - PROCESS | 5073 | stateChangeProcessEnqueue: Error transitioning state 10:01:49 INFO - PROCESS | 5073 | UnknownError 10:01:50 INFO - TEST-INFO | 5073: exit 0 10:01:50 INFO - Browser initialized. 10:01:50 INFO - Running cycle 1/1 for dromaeo_css test... 10:01:50 INFO - TEST-INFO | started process 5152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuXG6aN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:02:02 INFO - PROCESS | 5152 | RSS: Main: 157249536 10:02:02 INFO - PROCESS | 5152 | 10:02:54 INFO - PROCESS | 5152 | 1471539774074 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:05:06 INFO - PROCESS | 5152 | Cycle 1(1): loaded http://localhost:58377/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58377/tests/dromaeo/cssquery-ext.html) 10:05:07 INFO - PROCESS | 5152 | RSS: Main: 235708416 10:05:07 INFO - PROCESS | 5152 | 10:08:10 INFO - PROCESS | 5152 | Cycle 1(1): loaded http://localhost:58377/tests/dromaeo/cssquery-ext.html (next: http://localhost:58377/tests/dromaeo/cssquery-jquery.html) 10:08:10 INFO - PROCESS | 5152 | RSS: Main: 249511936 10:08:10 INFO - PROCESS | 5152 | 10:11:13 INFO - PROCESS | 5152 | Cycle 1(1): loaded http://localhost:58377/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58377/tests/dromaeo/cssquery-mootools.html) 10:11:13 INFO - PROCESS | 5152 | RSS: Main: 189046784 10:11:13 INFO - PROCESS | 5152 | 10:14:16 INFO - PROCESS | 5152 | Cycle 1(1): loaded http://localhost:58377/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58377/tests/dromaeo/cssquery-prototype.html) 10:14:16 INFO - PROCESS | 5152 | RSS: Main: 189128704 10:14:16 INFO - PROCESS | 5152 | 10:17:19 INFO - PROCESS | 5152 | Cycle 1(1): loaded http://localhost:58377/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58377/tests/dromaeo/cssquery-yui.html) 10:17:20 INFO - PROCESS | 5152 | RSS: Main: 189218816 10:17:20 INFO - PROCESS | 5152 | 10:20:23 INFO - PROCESS | 5152 | Cycle 1(1): loaded http://localhost:58377/tests/dromaeo/cssquery-yui.html (next: http://localhost:58377/tests/dromaeo/cssquery-dojo.html) 10:20:23 INFO - PROCESS | 5152 | RSS: Main: 280866816 10:20:23 INFO - PROCESS | 5152 | 10:20:23 INFO - PROCESS | 5152 | __start_tp_report 10:20:23 INFO - PROCESS | 5152 | _x_x_mozilla_page_load 10:20:23 INFO - PROCESS | 5152 | _x_x_mozilla_page_load_details 10:20:23 INFO - PROCESS | 5152 | |i|pagename|runs| 10:20:23 INFO - PROCESS | 5152 | |0;dojo.html;2545.681789776278;2566.3199252198165;2567.1656711568744;2588;2592.9740702592967;4637.2812214106825;4645.396098507198;4653.046125544264;4665.136949664306;4723.244280915054;4670.346151538787;4710.152172608929;4717.716936983775;4764.928526072112;4765.690230135047;4293.914121717564;4322.1787860306595;4343.9348409773875;4353.782310884443;4422.402975598286;4464.620507256887;4468.75421851798;4476.507584165755;4491.371208030879;4499.257622492285;4289.463817022872;4378.387025816388;4411.669124815651;4438.800253988578;4509.6392288617;4303.33298338758;4316.072044510414;4352.73883566987;4366.323219900921;4390.319500477399;4248.681348898845;4250.91498170038;4257.808398622069;4258.957410425918;4288.528261891221;4695.413073365829;4725.929111063337;4737.526247375269;4740.739259340735;4747.074320507502;4938.950610493885;5032.672876263068;5059.215821547666;5061.114304996611;5109.616778741609;5153.175491921274;5171;5191.506806853343;5218.947810521884;5220.086484865134;4799.640026997954;4850.830220942321;4855.344528488679;4855.975720121447;4859.441164266084;5099.87250318745;5180.222966555047;5238.842834714965;5244.580433565306;5331.4401987790725;5074.23886417033;5079.542841144241;5113.795448182031;5118.488151184852;5119.59043276537;5158.097332966716;5205.765740541685;5218.452062533379;5220.504052115043;5225.738713064332;4958.553730164303;5023.773930173151;5070.112730272262;5083.74581270935;5161.045206636784;5101.9744901276;5105.132127538327;5105.438401775802;5109.155559087065;5109.693418394908;4389.495208051115;4396.978015109968;4402.4056752338665;4425.402570652985;4446.510883802779;3724.795136267477;3753.887383378503;3777.8866634001024;3784.2242340320167;3826.6938644908896;4354.150940566559;4361.280388735823;4368.322909948963;4395.27477966132;4413.0070734084575;5152.768125434364;5157.638965272395;5159.535641792257;5162.716050617177;5196.53231209193;4237.173751118564;4291.806868690916;4336.3278691802825;4349.869503914888;4390.8024138913825;4651.744154071491;4655.3947986761505;4658.254679251304;4675.13510000651;4702.929456058094;4787.760611969457;4795.832145874878;4803.543663351976;4837.7581120944515;4840.540148685869;4901.387326584177;5064.215046667772;5067.898642027065;5113.53978141969;5139.820106296262;4798.760061996816;4809.591184749335;4818.759062046814;4843.24929635907;4859.586935110555;5076.441591424867;5084.237364395371;5084.339035925306;5088.007838471611;5117.488251175002;4936.358273424432;5082.313887625123;5122.718250496109;5158.148905430562;5222.9216561750845;5018.322526458881;5024.6231532634465;5029.547340739351;5049.84850454487;5052.797888084436;5007.37407824022;5012;5014.7994080236385;5018.548330650259;5063.8480845574695;4737.289406588901;4770.427548694179;4799.1601469743355;4905.435874874435;4964.35463389757;4970.9254361183885;4989.775460104232;4997.075541024922;5021.548060674557;5029.899402011866;4863.076015557032;4873.1959226727195;4879.536444037811;4890.144224760724;4891.070696567641 10:20:23 INFO - PROCESS | 5152 | |1;ext.html;567.4722508067497;572.2932178759235;580.3181262017129;585.9150423188638;587.6914619824594;28697.569536456944;37662.81168594157;39015.41476877849;39094;43314.35028474576;41062.38406423906;41411.58588414115;41421.79289103558;41450.37824432628;41473.377899331455;7629.198934111908;7811.648475818602;7817.8827317590285;7819.765407037798;7822.6088695564995;7760.417968652346;7851.097123830747;7854.7250846220395;7866.370690344758;7869.724559640414;7881;7930.088039875402;7941.960290198541;7954.840903181933;7956.6817327306835;7899.644515996794;7928.445008849383;7934.246246606564;7935.047794264697;7937.48406353591;7674.846503069907;7734.265244801735;7736.342410895025;7737.57443340616;7744.961275193645;38349.616503834884;38628;38631.42052869209;38641.806790965864;38689.80655096706;2904.7530959868436;3099.0857696979447;3263.902082937516;3318.883839065645;3407.319132032385;28759.712402875914;29244.122676319745;29250;29272.70727292721;29410;3446.138465383654;3521.8921694736014;3602.6937710294656;3637.399829028207;3746.83139258734;248961;250371;252026;252471;253104;30601.38797224043;51793.7410312946;52268.73865630647;52281.477185228425;52342.73828630909;30549.541756873663;32602.39180865525;32704;32713.509297360557;32741.181470462954;12559.183653062704;12679.429425675868;12710.491580336682;12722.618321450187;12749.235045897276;10774.676759697222;10912.399818010086;10917.836232456519;10937.507812148473;10944.124470042378;7730.690772369155;7764.417668674872;7795.4543181976715;7807.258310460497;7836.333911617577;2997.925051873721;3035.3929214157256;3047.679993600684;3085.6142982127235;3111.828849413259;841.5497708725925;846.3652260804397;892.6295587331315;900.3607438718583;938.9154976052188;25701.8714906428;26711.332216694736;27118.1864544064;27455.17634470969;29219.415611688073;795.367682692261;886.5744442667427;887.9289656827439;925.0656836595087;942.4204114469688;13375.53185638498;14378.928105359615;14475.493357732428;14559.272036398137;14693.191874446795;385435;386115;387027;387557;387797;46965.53034469612;47433;47478.287825682644;47540;47544.5245547547;1030.3766221435924;1100.6202860013282;1127.1996882213557;1137.3517095255625;1142.497301187475;27029.86485067562;28307.292317692223;28908.58399708716;29326;29713.405731885672;41392.79303603463;47077.29384059173;48792.512074878796;48834;52622;373727;374019;377984;378415;379941;39357.80321098376;40191.1961760769;40670.38994415027;43736.781316094486;43836.561634384525;40644;41500.56741205118;44697.32954005628;44842.10315793731;44850.775746121064;36521.634783651825;37235;37755.24489510249;40487;42001;37542.2491550162;37802.432963505016;38165.809170953966;38283;38740.22519549537;37160.6283937168;38196.04509887275;38431.423528647654;38556.42165367465;38729.225415492096;32503.220266208635;32803.73551438298;34748.47877281792;35380.22366980425;36906.63093369139;25396.619050714624;25661.615075773505;25862.353441164123;26081.73918260793;26288 10:20:23 INFO - PROCESS | 5152 | |2;jquery.html;338.17147987430803;360.6411620437663;363.3187772925763;364.8668236093826;387.6317498376543;12751.489940402384;16092.75860862088;16667.58331041723;17289;17547.73678394825;16005.519834404957;16150.83849161508;16341.509754707378;16376.099314537696;16380.754288685679;4969.329140566031;5150.768215430315;5182.3262975813095;5382.1926710993275;5435.945640543583;3398.11648971268;3582.6775590196876;5481.643693159932;5498.945010549904;5512.614117011811;3619.276144771043;3621.619729928359;4222;5878.588498805086;5947.286325640929;6011.368806275365;6013.308469526017;6028.216331876828;6028.367021462771;6029.21620189377;5147.948520514784;5204.9739751301;5231.476852314776;5241.056609810233;5242.18746094356;11338.829917551244;11385;11407;11557.24877882935;11564;1746.1356628468989;1840.6962851129547;1861.0973677766272;1880.2103116691023;1892.5552495163627;8823.823523529558;8931.955340223321;8970.50662213578;9637.18083962864;11649.708757281136;1575.8424157584263;1645.8354164583445;1704.480133559264;1717.0899423305543;1725.8964462132312;62790.68604656948;64391.67804160949;70379;70962.29037709661;72168.27831721668;9805.166560842408;9985.20118390527;10147.34042287249;10163.390196588229;10208.234382421348;13450.798238026437;13479.663008424868;13481.393337299845;13539.661508462368;13553.186808791505;5798.10129429939;5870.73581688825;5909.527237820964;6501.512386571026;7532.359749421361;6583.012548117821;6647.534672572873;6753.109129443764;6787.355201255873;6796.286389929085;3845.250176215611;4075.1849630074103;4106.3635136553885;4254.468191476066;4351.303791393362;1696.414736915762;1726.620143568413;1740.7736994190675;1766.5406994181606;1770.3957948299253;801.1867954026668;843.2832092721261;859.8452278589914;907.2877790934085;932.7481579973369;15925.522234332988;16580.917095414447;16695.74956375655;17109.315627375014;17338.653226935392;813.2599334605599;823.0617096509983;825.331481499975;832.8709050097244;877.9078196789372;9006.414583052081;9765.267604929659;9833.4099954003;9840.557174927146;10023.047810457994;364864;366669;384288;395500;395998;48923.266151007054;51957;79353;81388.59305703433;86516.61243320722;885.1148851148852;898.7797989492616;911.7128104647015;919.3518569408551;936.3305236755616;15423.61440963985;15619.76570351423;15762.369505219664;15787.447439339569;16429.753553696944;36115.458268126524;36980;37117.62882371142;37187.25625487529;37204.255914882095;51553;51613;52374.47625523696;52518.73740631272;52590.73704631453;7191.568505889663;7228.63856807147;7281.963590182015;7330.230325815713;7435.665395057344;10598.682039538826;11244.156688248251;11827;11853;12084.75830483403;9067.773305667411;9517.799915534135;9747.268954828274;10155.847662284923;10435.165186784887;9118.589663465027;10058.396496210251;10165;10188.388696678223;10245.180385569285;10050.296479246676;10203.795924081329;10380.273380863267;10614.363138211424;10688.946555267174;7289.343959043712;7471.775846724607;7530.209328020479;7692.230776922487;7694.961525192338;9395.765105872408;9510.572024258787;9706.272029597667;9787.119159275699;10495.947520262349 10:20:23 INFO - PROCESS | 5152 | |3;mootools.html;1351.8310211223593;1388.4168649167348;1421.5948454690415;1628.1452237575272;1630.2826756227253;6717.865642687156;7363.963180184098;7480.13978392485;7971.202879712033;7983.441159118864;7712.383009359251;7808.102068262137;7816.882746758789;7817.491863028899;7820.92179078209;2121.299971009567;2162.7837216278404;2165.1664109317867;2166.360923527563;2168.4253672776726;1809.8371146596803;2060.5054786851124;2069.9068541915576;2113.6301147299237;2147.1733382647717;2118.05746442833;2136.594047131048;2139.70044193813;2142.6678864775986;2144.7640759516516;2100.768915419295;2120.035383900329;2144.8176904963098;2145.4850835799452;2146.399008277685;2033.1359172351692;2079.656856618671;2129.318618042227;2140.304401069643;2147.3987283560627;7881.290683838425;7934.404919631051;7937.72217972374;7938.24586664266;7950.56271905045;4411.228035093878;4525.977370113128;4528.117017181651;4528.954710452919;4542.500324964251;2765.3224959884756;2863.4273145371008;2911.3595009097967;2916.0377075565225;2920.7517361024125;878.3368556739684;902.8510295801185;928.373347990104;930.4882314726941;939.3377668743519;10441.582336706599;10548.94725526375;10676.199285053573;10677.786444271149;10682.572697092108;3902.6292502212245;3940.7832569208967;3987.1626958339075;4131.5248746394545;4132.173565286955;8390.580470976427;8391.454555453876;8398.412111152284;8398.916010839814;8413.200745929127;4315.568443155722;4327.891802704958;4338.566143385636;4342.044750154961;4363.127374525107;3975.900602484903;4021.1153546219784;4032.052467670095;4034.899127521777;4046.615571520701;3251.430999575065;3285.227971426713;3339.532465454838;3354.0943945134677;3395.5076513905346;928.800307933784;972.776261459854;977.7946631207526;1029.2023681646633;1075.4407707991957;580.901246788047;702.6697452197459;719.5574721546211;725.2855936902147;730.1092666946317;4875.07373599015;5045.565459887441;5087.287779710843;5099.56653684441;5254.028004819121;816.4896939412866;855.9871601925976;864.4726716702806;891.919727224553;892.9553522323857;3198.3603279344225;3300.6864347886913;3314.668533146666;3337.199072222698;3385.559877215946;9199.908000920039;9546.713598592054;9558.044195580525;9562.56968436422;9572.76068098303;9509.5720692569;9522.714318570454;9522.85715714265;9529.857052144223;9541.856872146924;7233.276672332725;7323.853522929511;7340;7342.486025978237;7436.702531898772;4824.734639594856;4846.079244943449;4877.3903262092235;4933.975330123327;4959.851204463727;8664.046954835088;8800.16398442147;8828.646854125764;8844.95577522134;8884.200421962054;8834.779130521789;8887.911120888966;9222.769430764285;9244.306676999118;9245.953770231106;6112.847178820565;6187.16473276102;6198.783042593487;6204.968975155095;6218.782342617987;7239.565626062453;7240.348368646847;7279.417646588367;7287.635618219174;7293.744718934812;6160.630362178284;6266.248050234001;6371.713272902638;6398.87202255943;6437.130987316652;6055.333913269449;6086.087086936995;6140.785072522441;6290.433860952537;6371.39471750183;6078.635281882925;6166.414190651881;6190.473809726223;6197.380261973766;6200.968995154995;4292.463442069741;4339.978300108479;4403.873741059046;4485;4645.047765208192;4275.209086319041;4318.654507639444;4334.133173365402;4341.8046187922255;4386.0789234261165 10:20:23 INFO - PROCESS | 5152 | |4;prototype.html;297.7617905675459;302.995455068174;305.04672897196264;306.12295772611475;309.645455952934;4953.529414705602;4953.87615309617;4958.975205123978;4965.453800081988;4968.627352948525;4890.948446084091;4900.6569540132205;4923.5076492350745;4929.852104436873;4933.7533123343865;3639.181184233546;3753.530808648919;3765.755225910321;3773;3774;3692.2615476904593;3762.7366084374103;3805.3340665383585;3861.362875125601;3871.1096447817017;3796.297684928283;3810.390337545993;3815.751976121557;3816.0650640592953;3826;3607.4047782115917;3781.810909454516;3816.103215744298;3820.2168555446065;3831.540215174169;3308.4375656138272;3324.1357247115925;3325.6009278886445;3330.60196658408;3336.1326055225572;4790.80836766529;4790.9816815406075;4795.4964728703335;4802.327674125625;4808.2547205183255;4347;4350.58669426404;4353.020570371673;4353.129374125156;4353.129374125156;4987.7755501002175;5095.847124586268;5124.231365295198;5124.333836601218;5131.512506311894;3595.82020898954;3601.3697602919647;3613.2114603271284;3614;3615.168511242429;5375.408705042442;5406.783728650849;5410.675359478444;5413.133898576249;5415.431379705114;3574.7140228782155;3724.7206459515646;3737.383331750285;3752.1557649528636;3759.9436008459893;3798.772073675588;3799.259144466858;3801.9809900950872;3803.3344164771056;3807.809609519513;4345.130973805189;4364;4367.781610919441;4371.672124590668;4374.671899607542;4971.726555039508;5111.667741596784;5123.718195499283;5165.1219292720325;5166.793328266903;1268.4545645372577;1292.134270039076;1292.7414517096431;1295.1710905020793;1299.6490947444138;797.3063434811751;809.9794259233408;824.282873899711;829.639106988462;831.5468069901918;4293.291606884829;4429.756363400044;4439.42287502629;4440.400545926259;4441.578050085237;5177.974110129425;5283.101872681654;5288.418273989858;5297.125974214211;5325.813596524103;4482.8792801799555;4496.7301961882395;4505.702091933073;4510.842120525832;4515.5484451554585;2659.2819938616854;2795.762360199365;2808.6208361871295;2810.564362523812;2813.971860281412;4978.087818626072;4984.759906061016;4985.750712464363;4988.401391832931;4995.725235112031;5179.48205179479;5404.270423492857;5414.781674123369;5426.728663566806;5432.940576587606;5046.949530504721;5050.242463630411;5053.343065401547;5054.346468104275;5085.389753229636;5332.520073193431;5373.382061062872;5392.379876314118;5397.379301380392;5419.34967803866;5146.536811686966;5232.895342093061;5247.16045432729;5309.6460402597095;5328.706921119376;5035.4712755161645;5038.790690234244;5045.495450454925;5056.57019153376;5060.873478163076;3755.361588530011;3764.6988240941205;3772.4529943158636;3790.696744260508;3792.582815890305;5057.367829021372;5266;5397.487238712316;5400.651596010342;5405.162199859028;5128.564072053917;5153.2270159476375;5154.046501397253;5159.716215608178;5175.482451754794;5173.81891633791;5176;5200.297959775533;5201.843944681515;5202.531772140525;4815.470298267258;5046.410380730058;5057.241413787961;5059.949400506095;5073.44192138857;4978.60171186297;5079.974600126976;5221.9216711748595;5223.817166399158;5238.869028274171;5082.475257422832;5115.335006449138;5118.820841270538;5121.359830021247;5128.948710512847 10:20:23 INFO - PROCESS | 5152 | |5;yui.html;523.8821265215327;560.627182923356;569.3424095170079;570.6005795942841;613.5306490534739;13208.471661133555;14072.718545629106;14074.085184463003;14332.4983625573;14347.282635868218;13353.198808071522;13543.322833858292;13616.523421680244;13619.319034048283;13669.65825854354;757.3486801350834;775.6083177995105;776.953382797034;777.5490215674895;777.9688812447523;634.058423241486;742.476554029408;765.039874956931;767.3899250096159;777.5218240781907;822.7696245051366;824.2746383182791;825.3314814999869;825.471698113205;825.896762904637;822.0998007182126;822.4078663362429;822.5887056471735;822.62159406673;822.6462621072936;485.958693511052;495.5193462341523;497.5546885537424;500.469502327534;579.7912751409489;12335.568255111028;12811.423485943154;12831.615051548468;12849;12852.036097292741;11610.477528511237;11979.640610781691;12004.639860804102;12144.453499592539;12418.81371779424;10492.317999330095;10587.84118238227;10675.039246467777;10830.945845270802;10843.240973131884;3858.5562660294145;3871.380579107329;3955.0903292242656;4039.4344791728886;4085.9387109193385;63164.684176579285;63685.36314636841;63901.680491597246;64032.3596764031;64219;9447.763805904908;9579.712608621752;9625.278104142217;9639.325247232626;9653;18263;18443.354482593044;18726.25094996185;19209.615807683767;19356.516087097934;6822.215445223764;6910.792676219721;6960.825979350456;6963.4777391694815;6981.0924579804305;3656.4515322701277;3681.153334732973;3691.2617476504806;3730.925381492355;3763.5295588051495;2577.4845030993874;2668.4396276781704;2670.8664566771586;2671.131882138274;2674.665666791651;458.76832199739584;470.2569939495589;472.3127848979726;509.4828748819951;538.4400223767238;387.43047719851774;421.1030505024279;454.1190091223017;467.87601285659326;475.1447394689545;7512.272177399229;7651.885221721679;7931.167227441036;7976.800579985431;8052.235037671529;499.35598929951306;519.9272101905736;524.2346174585073;531.2933798048587;534.4682041368862;3644.7448678592773;3707.8516859325864;3714.925701485955;3803.847846086181;3822;100131;103245;103367.48316258371;105212;106035.4698226504;68481.65759171173;75843.62078189573;78166;79974;80875.52995760326;63626.36373636297;65246;67506.66246668833;70969;72427;7460.253974602496;7569.697212111454;7666.373715857611;7850.175731548105;8397.95801020991;37285.62714372821;37359.25281494301;37733.622663773014;43353;44522;38984.220315594095;47308.763456182496;51061.744691276304;53191.734041329546;53329.466705334;8510.82978340442;8808.251298639687;10511.789764204826;10635.89364106349;10727.517261723086;9961.808402151515;9991.25065620096;9991.701078859702;11526.366049867338;12557.183783054072;11350.432478376213;11455.828162577734;11474.196806223485;11870.58452954177;11878.881211187778;11179.105671546095;11227.157963152633;11473.942630286796;11617.850697620966;12009.339486327986;10501.737456563647;10640.946795265974;10759.731006724895;10823.945880270549;10989.395583242998;8561.2330574547;8744.78138046554;8791.648334066822;8797.38418310712;9040.276777857887;8349.206825351583;8488.10874858131;8944.150305720947;8958.148975847284;9237.07629237071 10:20:23 INFO - PROCESS | 5152 | __end_tp_report 10:20:23 INFO - PROCESS | 5152 | __start_cc_report 10:20:23 INFO - PROCESS | 5152 | _x_x_mozilla_cycle_collect,901 10:20:23 INFO - PROCESS | 5152 | __end_cc_report 10:20:23 INFO - PROCESS | 5152 | __startTimestamp1471540823623__endTimestamp 10:20:23 INFO - PROCESS | 5152 | 10:20:23 INFO - PROCESS | 5152 | ------- Summary: start ------- 10:20:23 INFO - PROCESS | 5152 | Number of tests: 6 10:20:23 INFO - PROCESS | 5152 | 10:20:23 INFO - PROCESS | 5152 | [#0] dojo.html Cycles:165 Average:4717.71 Median:4843.25 stddev:516.54 (10.7%) stddev-sans-first:489.21 10:20:23 INFO - PROCESS | 5152 | Values: 2545.7 2566.3 2567.2 2588.0 2593.0 4637.3 4645.4 4653.0 4665.1 4723.2 4670.3 4710.2 4717.7 4764.9 4765.7 4293.9 4322.2 4343.9 4353.8 4422.4 4464.6 4468.8 4476.5 4491.4 4499.3 4289.5 4378.4 4411.7 4438.8 4509.6 4303.3 4316.1 4352.7 4366.3 4390.3 4248.7 4250.9 4257.8 4259.0 4288.5 4695.4 4725.9 4737.5 4740.7 4747.1 4939.0 5032.7 5059.2 5061.1 5109.6 5153.2 5171.0 5191.5 5218.9 5220.1 4799.6 4850.8 4855.3 4856.0 4859.4 5099.9 5180.2 5238.8 5244.6 5331.4 5074.2 5079.5 5113.8 5118.5 5119.6 5158.1 5205.8 5218.5 5220.5 5225.7 4958.6 5023.8 5070.1 5083.7 5161.0 5102.0 5105.1 5105.4 5109.2 5109.7 4389.5 4397.0 4402.4 4425.4 4446.5 3724.8 3753.9 3777.9 3784.2 3826.7 4354.2 4361.3 4368.3 4395.3 4413.0 5152.8 5157.6 5159.5 5162.7 5196.5 4237.2 4291.8 4336.3 4349.9 4390.8 4651.7 4655.4 4658.3 4675.1 4702.9 4787.8 4795.8 4803.5 4837.8 4840.5 4901.4 5064.2 5067.9 5113.5 5139.8 4798.8 4809.6 4818.8 4843.2 4859.6 5076.4 5084.2 5084.3 5088.0 5117.5 4936.4 5082.3 5122.7 5158.1 5222.9 5018.3 5024.6 5029.5 5049.8 5052.8 5007.4 5012.0 5014.8 5018.5 5063.8 4737.3 4770.4 4799.2 4905.4 4964.4 4970.9 4989.8 4997.1 5021.5 5029.9 4863.1 4873.2 4879.5 4890.1 4891.1 10:20:23 INFO - PROCESS | 5152 | 10:20:23 INFO - PROCESS | 5152 | [#1] ext.html Cycles:180 Average:48648.00 Median:212335.71 stddev:90833.67 (42.8%) stddev-sans-first:91016.75 10:20:23 INFO - PROCESS | 5152 | Values: 567.5 572.3 580.3 585.9 587.7 28697.6 37662.8 39015.4 39094.0 43314.4 41062.4 41411.6 41421.8 41450.4 41473.4 7629.2 7811.6 7817.9 7819.8 7822.6 7760.4 7851.1 7854.7 7866.4 7869.7 7881.0 7930.1 7942.0 7954.8 7956.7 7899.6 7928.4 7934.2 7935.0 7937.5 7674.8 7734.3 7736.3 7737.6 7745.0 38349.6 38628.0 38631.4 38641.8 38689.8 2904.8 3099.1 3263.9 3318.9 3407.3 28759.7 29244.1 29250.0 29272.7 29410.0 3446.1 3521.9 3602.7 3637.4 3746.8 248961.0 250371.0 252026.0 252471.0 253104.0 30601.4 51793.7 52268.7 52281.5 52342.7 30549.5 32602.4 32704.0 32713.5 32741.2 12559.2 12679.4 12710.5 12722.6 12749.2 10774.7 10912.4 10917.8 10937.5 10944.1 7730.7 7764.4 7795.5 7807.3 7836.3 2997.9 3035.4 3047.7 3085.6 3111.8 841.5 846.4 892.6 900.4 938.9 25701.9 26711.3 27118.2 27455.2 29219.4 795.4 886.6 887.9 925.1 942.4 13375.5 14378.9 14475.5 14559.3 14693.2 385435.0 386115.0 387027.0 387557.0 387797.0 46965.5 47433.0 47478.3 47540.0 47544.5 1030.4 1100.6 1127.2 1137.4 1142.5 27029.9 28307.3 28908.6 29326.0 29713.4 41392.8 47077.3 48792.5 48834.0 52622.0 373727.0 374019.0 377984.0 378415.0 379941.0 39357.8 40191.2 40670.4 43736.8 43836.6 40644.0 41500.6 44697.3 44842.1 44850.8 36521.6 37235.0 37755.2 40487.0 42001.0 37542.2 37802.4 38165.8 38283.0 38740.2 37160.6 38196.0 38431.4 38556.4 38729.2 32503.2 32803.7 34748.5 35380.2 36906.6 25396.6 25661.6 25862.4 26081.7 26288.0 10:20:23 INFO - PROCESS | 5152 | 10:20:23 INFO - PROCESS | 5152 | [#2] jquery.html Cycles:180 Average:23469.79 Median:4302.89 stddev:63036.58 (1465.0%) stddev-sans-first:63189.48 10:20:23 INFO - PROCESS | 5152 | Values: 338.2 360.6 363.3 364.9 387.6 12751.5 16092.8 16667.6 17289.0 17547.7 16005.5 16150.8 16341.5 16376.1 16380.8 4969.3 5150.8 5182.3 5382.2 5435.9 3398.1 3582.7 5481.6 5498.9 5512.6 3619.3 3621.6 4222.0 5878.6 5947.3 6011.4 6013.3 6028.2 6028.4 6029.2 5147.9 5205.0 5231.5 5241.1 5242.2 11338.8 11385.0 11407.0 11557.2 11564.0 1746.1 1840.7 1861.1 1880.2 1892.6 8823.8 8932.0 8970.5 9637.2 11649.7 1575.8 1645.8 1704.5 1717.1 1725.9 62790.7 64391.7 70379.0 70962.3 72168.3 9805.2 9985.2 10147.3 10163.4 10208.2 13450.8 13479.7 13481.4 13539.7 13553.2 5798.1 5870.7 5909.5 6501.5 7532.4 6583.0 6647.5 6753.1 6787.4 6796.3 3845.3 4075.2 4106.4 4254.5 4351.3 1696.4 1726.6 1740.8 1766.5 1770.4 801.2 843.3 859.8 907.3 932.7 15925.5 16580.9 16695.7 17109.3 17338.7 813.3 823.1 825.3 832.9 877.9 9006.4 9765.3 9833.4 9840.6 10023.0 364864.0 366669.0 384288.0 395500.0 395998.0 48923.3 51957.0 79353.0 81388.6 86516.6 885.1 898.8 911.7 919.4 936.3 15423.6 15619.8 15762.4 15787.4 16429.8 36115.5 36980.0 37117.6 37187.3 37204.3 51553.0 51613.0 52374.5 52518.7 52590.7 7191.6 7228.6 7282.0 7330.2 7435.7 10598.7 11244.2 11827.0 11853.0 12084.8 9067.8 9517.8 9747.3 10155.8 10435.2 9118.6 10058.4 10165.0 10188.4 10245.2 10050.3 10203.8 10380.3 10614.4 10688.9 7289.3 7471.8 7530.2 7692.2 7695.0 9395.8 9510.6 9706.3 9787.1 10495.9 10:20:23 INFO - PROCESS | 5152 | 10:20:23 INFO - PROCESS | 5152 | [#3] mootools.html Cycles:180 Average:4979.13 Median:5176.80 stddev:2847.70 (55.0%) stddev-sans-first:2842.64 10:20:23 INFO - PROCESS | 5152 | Values: 1351.8 1388.4 1421.6 1628.1 1630.3 6717.9 7364.0 7480.1 7971.2 7983.4 7712.4 7808.1 7816.9 7817.5 7820.9 2121.3 2162.8 2165.2 2166.4 2168.4 1809.8 2060.5 2069.9 2113.6 2147.2 2118.1 2136.6 2139.7 2142.7 2144.8 2100.8 2120.0 2144.8 2145.5 2146.4 2033.1 2079.7 2129.3 2140.3 2147.4 7881.3 7934.4 7937.7 7938.2 7950.6 4411.2 4526.0 4528.1 4529.0 4542.5 2765.3 2863.4 2911.4 2916.0 2920.8 878.3 902.9 928.4 930.5 939.3 10441.6 10548.9 10676.2 10677.8 10682.6 3902.6 3940.8 3987.2 4131.5 4132.2 8390.6 8391.5 8398.4 8398.9 8413.2 4315.6 4327.9 4338.6 4342.0 4363.1 3975.9 4021.1 4032.1 4034.9 4046.6 3251.4 3285.2 3339.5 3354.1 3395.5 928.8 972.8 977.8 1029.2 1075.4 580.9 702.7 719.6 725.3 730.1 4875.1 5045.6 5087.3 5099.6 5254.0 816.5 856.0 864.5 891.9 893.0 3198.4 3300.7 3314.7 3337.2 3385.6 9199.9 9546.7 9558.0 9562.6 9572.8 9509.6 9522.7 9522.9 9529.9 9541.9 7233.3 7323.9 7340.0 7342.5 7436.7 4824.7 4846.1 4877.4 4934.0 4959.9 8664.0 8800.2 8828.6 8845.0 8884.2 8834.8 8887.9 9222.8 9244.3 9246.0 6112.8 6187.2 6198.8 6205.0 6218.8 7239.6 7240.3 7279.4 7287.6 7293.7 6160.6 6266.2 6371.7 6398.9 6437.1 6055.3 6086.1 6140.8 6290.4 6371.4 6078.6 6166.4 6190.5 6197.4 6201.0 4292.5 4340.0 4403.9 4485.0 4645.0 4275.2 4318.7 4334.1 4341.8 4386.1 10:20:23 INFO - PROCESS | 5152 | 10:20:23 INFO - PROCESS | 5152 | [#4] prototype.html Cycles:180 Average:4270.47 Median:4943.64 stddev:1258.87 (25.5%) stddev-sans-first:1226.58 10:20:23 INFO - PROCESS | 5152 | Values: 297.8 303.0 305.0 306.1 309.6 4953.5 4953.9 4959.0 4965.5 4968.6 4890.9 4900.7 4923.5 4929.9 4933.8 3639.2 3753.5 3765.8 3773.0 3774.0 3692.3 3762.7 3805.3 3861.4 3871.1 3796.3 3810.4 3815.8 3816.1 3826.0 3607.4 3781.8 3816.1 3820.2 3831.5 3308.4 3324.1 3325.6 3330.6 3336.1 4790.8 4791.0 4795.5 4802.3 4808.3 4347.0 4350.6 4353.0 4353.1 4353.1 4987.8 5095.8 5124.2 5124.3 5131.5 3595.8 3601.4 3613.2 3614.0 3615.2 5375.4 5406.8 5410.7 5413.1 5415.4 3574.7 3724.7 3737.4 3752.2 3759.9 3798.8 3799.3 3802.0 3803.3 3807.8 4345.1 4364.0 4367.8 4371.7 4374.7 4971.7 5111.7 5123.7 5165.1 5166.8 1268.5 1292.1 1292.7 1295.2 1299.6 797.3 810.0 824.3 829.6 831.5 4293.3 4429.8 4439.4 4440.4 4441.6 5178.0 5283.1 5288.4 5297.1 5325.8 4482.9 4496.7 4505.7 4510.8 4515.5 2659.3 2795.8 2808.6 2810.6 2814.0 4978.1 4984.8 4985.8 4988.4 4995.7 5179.5 5404.3 5414.8 5426.7 5432.9 5046.9 5050.2 5053.3 5054.3 5085.4 5332.5 5373.4 5392.4 5397.4 5419.3 5146.5 5232.9 5247.2 5309.6 5328.7 5035.5 5038.8 5045.5 5056.6 5060.9 3755.4 3764.7 3772.5 3790.7 3792.6 5057.4 5266.0 5397.5 5400.7 5405.2 5128.6 5153.2 5154.0 5159.7 5175.5 5173.8 5176.0 5200.3 5201.8 5202.5 4815.5 5046.4 5057.2 5059.9 5073.4 4978.6 5080.0 5221.9 5223.8 5238.9 5082.5 5115.3 5118.8 5121.4 5128.9 10:20:23 INFO - PROCESS | 5152 | 10:20:23 INFO - PROCESS | 5152 | [#5] yui.html Cycles:180 Average:16850.67 Median:490.74 stddev:24425.43 (4977.3%) stddev-sans-first:24463.18 10:20:23 INFO - PROCESS | 5152 | Values: 523.9 560.6 569.3 570.6 613.5 13208.5 14072.7 14074.1 14332.5 14347.3 13353.2 13543.3 13616.5 13619.3 13669.7 757.3 775.6 777.0 777.5 778.0 634.1 742.5 765.0 767.4 777.5 822.8 824.3 825.3 825.5 825.9 822.1 822.4 822.6 822.6 822.6 486.0 495.5 497.6 500.5 579.8 12335.6 12811.4 12831.6 12849.0 12852.0 11610.5 11979.6 12004.6 12144.5 12418.8 10492.3 10587.8 10675.0 10830.9 10843.2 3858.6 3871.4 3955.1 4039.4 4085.9 63164.7 63685.4 63901.7 64032.4 64219.0 9447.8 9579.7 9625.3 9639.3 9653.0 18263.0 18443.4 18726.3 19209.6 19356.5 6822.2 6910.8 6960.8 6963.5 6981.1 3656.5 3681.2 3691.3 3730.9 3763.5 2577.5 2668.4 2670.9 2671.1 2674.7 458.8 470.3 472.3 509.5 538.4 387.4 421.1 454.1 467.9 475.1 7512.3 7651.9 7931.2 7976.8 8052.2 499.4 519.9 524.2 531.3 534.5 3644.7 3707.9 3714.9 3803.8 3822.0 100131.0 103245.0 103367.5 105212.0 106035.5 68481.7 75843.6 78166.0 79974.0 80875.5 63626.4 65246.0 67506.7 70969.0 72427.0 7460.3 7569.7 7666.4 7850.2 8398.0 37285.6 37359.3 37733.6 43353.0 44522.0 38984.2 47308.8 51061.7 53191.7 53329.5 8510.8 8808.3 10511.8 10635.9 10727.5 9961.8 9991.3 9991.7 11526.4 12557.2 11350.4 11455.8 11474.2 11870.6 11878.9 11179.1 11227.2 11473.9 11617.9 12009.3 10501.7 10640.9 10759.7 10823.9 10989.4 8561.2 8744.8 8791.6 8797.4 9040.3 8349.2 8488.1 8944.2 8958.1 9237.1 10:20:23 INFO - PROCESS | 5152 | -------- Summary: end -------- 10:20:23 INFO - PROCESS | 5152 | 10:20:24 INFO - TEST-INFO | 5152: exit 0 10:20:24 INFO - TEST-OK | dromaeo_css | took 1119750ms 10:20:24 INFO - TEST-START | kraken 10:20:24 INFO - operating with platform_type : linux_ 10:20:24 INFO - Initialising browser for kraken test... 10:20:24 INFO - TEST-INFO | started process 5458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT5umVw/profile http://localhost:58377/getInfo.html) 10:20:28 INFO - PROCESS | 5458 | __metrics Screen width/height:1600/1200 10:20:28 INFO - PROCESS | 5458 | colorDepth:24 10:20:28 INFO - PROCESS | 5458 | Browser inner width/height: 1024/697 10:20:28 INFO - PROCESS | 5458 | __metrics 10:20:29 INFO - PROCESS | 5458 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:20:29 INFO - PROCESS | 5458 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:20:29 INFO - PROCESS | 5458 | console.error: PushService: 10:20:29 INFO - PROCESS | 5458 | stateChangeProcessEnqueue: Error transitioning state 10:20:29 INFO - PROCESS | 5458 | UnknownError 10:20:30 INFO - TEST-INFO | 5458: exit 0 10:20:30 INFO - Browser initialized. 10:20:30 INFO - Running cycle 1/1 for kraken test... 10:20:30 INFO - TEST-INFO | started process 5541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT5umVw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:42 INFO - PROCESS | 5541 | RSS: Main: 157347840 10:20:42 INFO - PROCESS | 5541 | 10:20:45 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58377/tests/kraken/driver.html?testName=audio-beat-detection) 10:20:45 INFO - PROCESS | 5541 | RSS: Main: 204431360 10:20:45 INFO - PROCESS | 5541 | 10:20:48 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58377/tests/kraken/driver.html?testName=audio-dft) 10:20:49 INFO - PROCESS | 5541 | RSS: Main: 195993600 10:20:49 INFO - PROCESS | 5541 | 10:20:52 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58377/tests/kraken/driver.html?testName=audio-fft) 10:20:53 INFO - PROCESS | 5541 | RSS: Main: 276783104 10:20:53 INFO - PROCESS | 5541 | 10:20:55 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58377/tests/kraken/driver.html?testName=audio-oscillator) 10:20:55 INFO - PROCESS | 5541 | RSS: Main: 186994688 10:20:55 INFO - PROCESS | 5541 | 10:20:58 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58377/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:20:58 INFO - PROCESS | 5541 | RSS: Main: 191877120 10:20:58 INFO - PROCESS | 5541 | 10:21:02 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58377/tests/kraken/driver.html?testName=imaging-darkroom) 10:21:02 INFO - PROCESS | 5541 | RSS: Main: 227901440 10:21:02 INFO - PROCESS | 5541 | 10:21:06 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58377/tests/kraken/driver.html?testName=imaging-desaturate) 10:21:06 INFO - PROCESS | 5541 | RSS: Main: 222003200 10:21:06 INFO - PROCESS | 5541 | 10:21:09 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58377/tests/kraken/driver.html?testName=json-parse-financial) 10:21:10 INFO - PROCESS | 5541 | RSS: Main: 225542144 10:21:10 INFO - PROCESS | 5541 | 10:21:11 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58377/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:21:12 INFO - PROCESS | 5541 | RSS: Main: 189018112 10:21:12 INFO - PROCESS | 5541 | 10:21:14 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58377/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:21:15 INFO - PROCESS | 5541 | RSS: Main: 196976640 10:21:15 INFO - PROCESS | 5541 | 10:21:17 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58377/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:21:18 INFO - PROCESS | 5541 | RSS: Main: 193441792 10:21:18 INFO - PROCESS | 5541 | 10:21:20 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:21:21 INFO - PROCESS | 5541 | RSS: Main: 188469248 10:21:21 INFO - PROCESS | 5541 | 10:21:24 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:21:24 INFO - PROCESS | 5541 | RSS: Main: 191954944 10:21:24 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58377/tests/kraken/driver.html?testName=ai-astar) 10:21:26 INFO - PROCESS | 5541 | RSS: Main: 242049024 10:21:26 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | __start_tp_report 10:21:26 INFO - PROCESS | 5541 | _x_x_mozilla_page_load 10:21:26 INFO - PROCESS | 5541 | _x_x_mozilla_page_load_details 10:21:26 INFO - PROCESS | 5541 | |i|pagename|runs| 10:21:26 INFO - PROCESS | 5541 | |0;ai-astar;107;113;114;116;111;115;115;114;114;116 10:21:26 INFO - PROCESS | 5541 | |1;audio-beat-detection;155;122;123;179;130;129;151;126;160;124 10:21:26 INFO - PROCESS | 5541 | |2;audio-dft;160;160;160;160;160;161;162;161;160;160 10:21:26 INFO - PROCESS | 5541 | |3;audio-fft;76;76;74;109;77;77;74;74;100;75 10:21:26 INFO - PROCESS | 5541 | |4;audio-oscillator;86;87;143;85;86;87;121;86;86;137 10:21:26 INFO - PROCESS | 5541 | |5;imaging-gaussian-blur;118;117;117;117;117;118;118;119;117;117 10:21:26 INFO - PROCESS | 5541 | |6;imaging-darkroom;146;147;147;146;147;147;147;148;147;148 10:21:26 INFO - PROCESS | 5541 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;94;95 10:21:26 INFO - PROCESS | 5541 | |8;json-parse-financial;65;64;67;65;66;68;65;66;67;65 10:21:26 INFO - PROCESS | 5541 | |9;json-stringify-tinderbox;65;66;65;66;66;65;66;66;66;66 10:21:26 INFO - PROCESS | 5541 | |10;stanford-crypto-aes;82;83;82;82;82;82;82;85;81;82 10:21:26 INFO - PROCESS | 5541 | |11;stanford-crypto-ccm;132;131;145;132;130;136;129;137;155;137 10:21:26 INFO - PROCESS | 5541 | |12;stanford-crypto-pbkdf2;173;171;171;172;173;175;168;171;174;174 10:21:26 INFO - PROCESS | 5541 | |13;stanford-crypto-sha256-iterative;70;68;70;68;73;73;68;69;69;70 10:21:26 INFO - PROCESS | 5541 | __end_tp_report 10:21:26 INFO - PROCESS | 5541 | __start_cc_report 10:21:26 INFO - PROCESS | 5541 | _x_x_mozilla_cycle_collect,1939 10:21:26 INFO - PROCESS | 5541 | __end_cc_report 10:21:26 INFO - PROCESS | 5541 | __startTimestamp1471540886965__endTimestamp 10:21:26 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | ------- Summary: start ------- 10:21:26 INFO - PROCESS | 5541 | Number of tests: 14 10:21:26 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.50 stddev:2.72 (2.4%) stddev-sans-first:1.56 10:21:26 INFO - PROCESS | 5541 | Values: 107.0 113.0 114.0 116.0 111.0 115.0 115.0 114.0 114.0 116.0 10:21:26 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:140.50 stddev:19.87 (14.1%) stddev-sans-first:20.31 10:21:26 INFO - PROCESS | 5541 | Values: 155.0 122.0 123.0 179.0 130.0 129.0 151.0 126.0 160.0 124.0 10:21:26 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 10:21:26 INFO - PROCESS | 5541 | Values: 160.0 160.0 160.0 160.0 160.0 161.0 162.0 161.0 160.0 160.0 10:21:26 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.50 stddev:12.51 (16.6%) stddev-sans-first:13.13 10:21:26 INFO - PROCESS | 5541 | Values: 76.0 76.0 74.0 109.0 77.0 77.0 74.0 74.0 100.0 75.0 10:21:26 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | [#4] audio-oscillator Cycles:10 Average:100.40 Median:86.00 stddev:23.58 (27.4%) stddev-sans-first:24.43 10:21:26 INFO - PROCESS | 5541 | Values: 86.0 87.0 143.0 85.0 86.0 87.0 121.0 86.0 86.0 137.0 10:21:26 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 10:21:26 INFO - PROCESS | 5541 | Values: 118.0 117.0 117.0 117.0 117.0 118.0 118.0 119.0 117.0 117.0 10:21:26 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 10:21:26 INFO - PROCESS | 5541 | Values: 146.0 147.0 147.0 146.0 147.0 147.0 147.0 148.0 147.0 148.0 10:21:26 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 10:21:26 INFO - PROCESS | 5541 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 94.0 95.0 10:21:26 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.00 stddev:1.23 (1.9%) stddev-sans-first:1.27 10:21:26 INFO - PROCESS | 5541 | Values: 65.0 64.0 67.0 65.0 66.0 68.0 65.0 66.0 67.0 65.0 10:21:26 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 10:21:26 INFO - PROCESS | 5541 | Values: 65.0 66.0 65.0 66.0 66.0 65.0 66.0 66.0 66.0 66.0 10:21:26 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:1.06 (1.3%) stddev-sans-first:1.12 10:21:26 INFO - PROCESS | 5541 | Values: 82.0 83.0 82.0 82.0 82.0 82.0 82.0 85.0 81.0 82.0 10:21:26 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:136.50 stddev:8.06 (5.9%) stddev-sans-first:8.39 10:21:26 INFO - PROCESS | 5541 | Values: 132.0 131.0 145.0 132.0 130.0 136.0 129.0 137.0 155.0 137.0 10:21:26 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:173.00 stddev:2.04 (1.2%) stddev-sans-first:2.15 10:21:26 INFO - PROCESS | 5541 | Values: 173.0 171.0 171.0 172.0 173.0 175.0 168.0 171.0 174.0 174.0 10:21:26 INFO - PROCESS | 5541 | 10:21:26 INFO - PROCESS | 5541 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.87 (2.7%) stddev-sans-first:1.99 10:21:26 INFO - PROCESS | 5541 | Values: 70.0 68.0 70.0 68.0 73.0 73.0 68.0 69.0 69.0 70.0 10:21:26 INFO - PROCESS | 5541 | -------- Summary: end -------- 10:21:26 INFO - PROCESS | 5541 | 10:21:28 INFO - TEST-INFO | 5541: exit 0 10:21:28 INFO - TEST-OK | kraken | took 63622ms 10:21:28 INFO - SUITE-END | took 1183s 10:21:28 INFO - Completed test suite (00:19:43) 10:21:28 INFO - javascript benchmark 10:21:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2545.681789776278, 2566.3199252198165, 2567.1656711568744, 2588.0, 2592.9740702592967, 4637.2812214106825, 4645.396098507198, 4653.046125544264, 4665.136949664306, 4723.244280915054, 4670.346151538787, 4710.152172608929, 4717.716936983775, 4764.928526072112, 4765.690230135047, 4293.914121717564, 4322.1787860306595, 4343.9348409773875, 4353.782310884443, 4422.402975598286, 4464.620507256887, 4468.75421851798, 4476.507584165755, 4491.371208030879, 4499.257622492285, 4289.463817022872, 4378.387025816388, 4411.669124815651, 4438.800253988578, 4509.6392288617, 4303.33298338758, 4316.072044510414, 4352.73883566987, 4366.323219900921, 4390.319500477399, 4248.681348898845, 4250.91498170038, 4257.808398622069, 4258.957410425918, 4288.528261891221, 4695.413073365829, 4725.929111063337, 4737.526247375269, 4740.739259340735, 4747.074320507502, 4938.950610493885, 5032.672876263068, 5059.215821547666, 5061.114304996611, 5109.616778741609, 5153.175491921274, 5171.0, 5191.506806853343, 5218.947810521884, 5220.086484865134, 4799.640026997954, 4850.830220942321, 4855.344528488679, 4855.975720121447, 4859.441164266084, 5099.87250318745, 5180.222966555047, 5238.842834714965, 5244.580433565306, 5331.4401987790725, 5074.23886417033, 5079.542841144241, 5113.795448182031, 5118.488151184852, 5119.59043276537, 5158.097332966716, 5205.765740541685, 5218.452062533379, 5220.504052115043, 5225.738713064332, 4958.553730164303, 5023.773930173151, 5070.112730272262, 5083.74581270935, 5161.045206636784, 5101.9744901276, 5105.132127538327, 5105.438401775802, 5109.155559087065, 5109.693418394908, 4389.495208051115, 4396.978015109968, 4402.4056752338665, 4425.402570652985, 4446.510883802779, 3724.795136267477, 3753.887383378503, 3777.8866634001024, 3784.2242340320167, 3826.6938644908896, 4354.150940566559, 4361.280388735823, 4368.322909948963, 4395.27477966132, 4413.0070734084575, 5152.768125434364, 5157.638965272395, 5159.535641792257, 5162.716050617177, 5196.53231209193, 4237.173751118564, 4291.806868690916, 4336.3278691802825, 4349.869503914888, 4390.8024138913825, 4651.744154071491, 4655.3947986761505, 4658.254679251304, 4675.13510000651, 4702.929456058094, 4787.760611969457, 4795.832145874878, 4803.543663351976, 4837.7581120944515, 4840.540148685869, 4901.387326584177, 5064.215046667772, 5067.898642027065, 5113.53978141969, 5139.820106296262, 4798.760061996816, 4809.591184749335, 4818.759062046814, 4843.24929635907, 4859.586935110555, 5076.441591424867, 5084.237364395371, 5084.339035925306, 5088.007838471611, 5117.488251175002, 4936.358273424432, 5082.313887625123, 5122.718250496109, 5158.148905430562, 5222.9216561750845, 5018.322526458881, 5024.6231532634465, 5029.547340739351, 5049.84850454487, 5052.797888084436, 5007.37407824022, 5012.0, 5014.7994080236385, 5018.548330650259, 5063.8480845574695, 4737.289406588901, 4770.427548694179, 4799.1601469743355, 4905.435874874435, 4964.35463389757, 4970.9254361183885, 4989.775460104232, 4997.075541024922, 5021.548060674557, 5029.899402011866, 4863.076015557032, 4873.1959226727195, 4879.536444037811, 4890.144224760724, 4891.070696567641], "value": 4682.754426120234, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.4722508067497, 572.2932178759235, 580.3181262017129, 585.9150423188638, 587.6914619824594, 28697.569536456944, 37662.81168594157, 39015.41476877849, 39094.0, 43314.35028474576, 41062.38406423906, 41411.58588414115, 41421.79289103558, 41450.37824432628, 41473.377899331455, 7629.198934111908, 7811.648475818602, 7817.8827317590285, 7819.765407037798, 7822.6088695564995, 7760.417968652346, 7851.097123830747, 7854.7250846220395, 7866.370690344758, 7869.724559640414, 7881.0, 7930.088039875402, 7941.960290198541, 7954.840903181933, 7956.6817327306835, 7899.644515996794, 7928.445008849383, 7934.246246606564, 7935.047794264697, 7937.48406353591, 7674.846503069907, 7734.265244801735, 7736.342410895025, 7737.57443340616, 7744.961275193645, 38349.616503834884, 38628.0, 38631.42052869209, 38641.806790965864, 38689.80655096706, 2904.7530959868436, 3099.0857696979447, 3263.902082937516, 3318.883839065645, 3407.319132032385, 28759.712402875914, 29244.122676319745, 29250.0, 29272.70727292721, 29410.0, 3446.138465383654, 3521.8921694736014, 3602.6937710294656, 3637.399829028207, 3746.83139258734, 248961.0, 250371.0, 252026.0, 252471.0, 253104.0, 30601.38797224043, 51793.7410312946, 52268.73865630647, 52281.477185228425, 52342.73828630909, 30549.541756873663, 32602.39180865525, 32704.0, 32713.509297360557, 32741.181470462954, 12559.183653062704, 12679.429425675868, 12710.491580336682, 12722.618321450187, 12749.235045897276, 10774.676759697222, 10912.399818010086, 10917.836232456519, 10937.507812148473, 10944.124470042378, 7730.690772369155, 7764.417668674872, 7795.4543181976715, 7807.258310460497, 7836.333911617577, 2997.925051873721, 3035.3929214157256, 3047.679993600684, 3085.6142982127235, 3111.828849413259, 841.5497708725925, 846.3652260804397, 892.6295587331315, 900.3607438718583, 938.9154976052188, 25701.8714906428, 26711.332216694736, 27118.1864544064, 27455.17634470969, 29219.415611688073, 795.367682692261, 886.5744442667427, 887.9289656827439, 925.0656836595087, 942.4204114469688, 13375.53185638498, 14378.928105359615, 14475.493357732428, 14559.272036398137, 14693.191874446795, 385435.0, 386115.0, 387027.0, 387557.0, 387797.0, 46965.53034469612, 47433.0, 47478.287825682644, 47540.0, 47544.5245547547, 1030.3766221435924, 1100.6202860013282, 1127.1996882213557, 1137.3517095255625, 1142.497301187475, 27029.86485067562, 28307.292317692223, 28908.58399708716, 29326.0, 29713.405731885672, 41392.79303603463, 47077.29384059173, 48792.512074878796, 48834.0, 52622.0, 373727.0, 374019.0, 377984.0, 378415.0, 379941.0, 39357.80321098376, 40191.1961760769, 40670.38994415027, 43736.781316094486, 43836.561634384525, 40644.0, 41500.56741205118, 44697.32954005628, 44842.10315793731, 44850.775746121064, 36521.634783651825, 37235.0, 37755.24489510249, 40487.0, 42001.0, 37542.2491550162, 37802.432963505016, 38165.809170953966, 38283.0, 38740.22519549537, 37160.6283937168, 38196.04509887275, 38431.423528647654, 38556.42165367465, 38729.225415492096, 32503.220266208635, 32803.73551438298, 34748.47877281792, 35380.22366980425, 36906.63093369139, 25396.619050714624, 25661.615075773505, 25862.353441164123, 26081.73918260793, 26288.0], "value": 16796.532566575002, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.17147987430803, 360.6411620437663, 363.3187772925763, 364.8668236093826, 387.6317498376543, 12751.489940402384, 16092.75860862088, 16667.58331041723, 17289.0, 17547.73678394825, 16005.519834404957, 16150.83849161508, 16341.509754707378, 16376.099314537696, 16380.754288685679, 4969.329140566031, 5150.768215430315, 5182.3262975813095, 5382.1926710993275, 5435.945640543583, 3398.11648971268, 3582.6775590196876, 5481.643693159932, 5498.945010549904, 5512.614117011811, 3619.276144771043, 3621.619729928359, 4222.0, 5878.588498805086, 5947.286325640929, 6011.368806275365, 6013.308469526017, 6028.216331876828, 6028.367021462771, 6029.21620189377, 5147.948520514784, 5204.9739751301, 5231.476852314776, 5241.056609810233, 5242.18746094356, 11338.829917551244, 11385.0, 11407.0, 11557.24877882935, 11564.0, 1746.1356628468989, 1840.6962851129547, 1861.0973677766272, 1880.2103116691023, 1892.5552495163627, 8823.823523529558, 8931.955340223321, 8970.50662213578, 9637.18083962864, 11649.708757281136, 1575.8424157584263, 1645.8354164583445, 1704.480133559264, 1717.0899423305543, 1725.8964462132312, 62790.68604656948, 64391.67804160949, 70379.0, 70962.29037709661, 72168.27831721668, 9805.166560842408, 9985.20118390527, 10147.34042287249, 10163.390196588229, 10208.234382421348, 13450.798238026437, 13479.663008424868, 13481.393337299845, 13539.661508462368, 13553.186808791505, 5798.10129429939, 5870.73581688825, 5909.527237820964, 6501.512386571026, 7532.359749421361, 6583.012548117821, 6647.534672572873, 6753.109129443764, 6787.355201255873, 6796.286389929085, 3845.250176215611, 4075.1849630074103, 4106.3635136553885, 4254.468191476066, 4351.303791393362, 1696.414736915762, 1726.620143568413, 1740.7736994190675, 1766.5406994181606, 1770.3957948299253, 801.1867954026668, 843.2832092721261, 859.8452278589914, 907.2877790934085, 932.7481579973369, 15925.522234332988, 16580.917095414447, 16695.74956375655, 17109.315627375014, 17338.653226935392, 813.2599334605599, 823.0617096509983, 825.331481499975, 832.8709050097244, 877.9078196789372, 9006.414583052081, 9765.267604929659, 9833.4099954003, 9840.557174927146, 10023.047810457994, 364864.0, 366669.0, 384288.0, 395500.0, 395998.0, 48923.266151007054, 51957.0, 79353.0, 81388.59305703433, 86516.61243320722, 885.1148851148852, 898.7797989492616, 911.7128104647015, 919.3518569408551, 936.3305236755616, 15423.61440963985, 15619.76570351423, 15762.369505219664, 15787.447439339569, 16429.753553696944, 36115.458268126524, 36980.0, 37117.62882371142, 37187.25625487529, 37204.255914882095, 51553.0, 51613.0, 52374.47625523696, 52518.73740631272, 52590.73704631453, 7191.568505889663, 7228.63856807147, 7281.963590182015, 7330.230325815713, 7435.665395057344, 10598.682039538826, 11244.156688248251, 11827.0, 11853.0, 12084.75830483403, 9067.773305667411, 9517.799915534135, 9747.268954828274, 10155.847662284923, 10435.165186784887, 9118.589663465027, 10058.396496210251, 10165.0, 10188.388696678223, 10245.180385569285, 10050.296479246676, 10203.795924081329, 10380.273380863267, 10614.363138211424, 10688.946555267174, 7289.343959043712, 7471.775846724607, 7530.209328020479, 7692.230776922487, 7694.961525192338, 9395.765105872408, 9510.572024258787, 9706.272029597667, 9787.119159275699, 10495.947520262349], "value": 7867.045047369357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.8310211223593, 1388.4168649167348, 1421.5948454690415, 1628.1452237575272, 1630.2826756227253, 6717.865642687156, 7363.963180184098, 7480.13978392485, 7971.202879712033, 7983.441159118864, 7712.383009359251, 7808.102068262137, 7816.882746758789, 7817.491863028899, 7820.92179078209, 2121.299971009567, 2162.7837216278404, 2165.1664109317867, 2166.360923527563, 2168.4253672776726, 1809.8371146596803, 2060.5054786851124, 2069.9068541915576, 2113.6301147299237, 2147.1733382647717, 2118.05746442833, 2136.594047131048, 2139.70044193813, 2142.6678864775986, 2144.7640759516516, 2100.768915419295, 2120.035383900329, 2144.8176904963098, 2145.4850835799452, 2146.399008277685, 2033.1359172351692, 2079.656856618671, 2129.318618042227, 2140.304401069643, 2147.3987283560627, 7881.290683838425, 7934.404919631051, 7937.72217972374, 7938.24586664266, 7950.56271905045, 4411.228035093878, 4525.977370113128, 4528.117017181651, 4528.954710452919, 4542.500324964251, 2765.3224959884756, 2863.4273145371008, 2911.3595009097967, 2916.0377075565225, 2920.7517361024125, 878.3368556739684, 902.8510295801185, 928.373347990104, 930.4882314726941, 939.3377668743519, 10441.582336706599, 10548.94725526375, 10676.199285053573, 10677.786444271149, 10682.572697092108, 3902.6292502212245, 3940.7832569208967, 3987.1626958339075, 4131.5248746394545, 4132.173565286955, 8390.580470976427, 8391.454555453876, 8398.412111152284, 8398.916010839814, 8413.200745929127, 4315.568443155722, 4327.891802704958, 4338.566143385636, 4342.044750154961, 4363.127374525107, 3975.900602484903, 4021.1153546219784, 4032.052467670095, 4034.899127521777, 4046.615571520701, 3251.430999575065, 3285.227971426713, 3339.532465454838, 3354.0943945134677, 3395.5076513905346, 928.800307933784, 972.776261459854, 977.7946631207526, 1029.2023681646633, 1075.4407707991957, 580.901246788047, 702.6697452197459, 719.5574721546211, 725.2855936902147, 730.1092666946317, 4875.07373599015, 5045.565459887441, 5087.287779710843, 5099.56653684441, 5254.028004819121, 816.4896939412866, 855.9871601925976, 864.4726716702806, 891.919727224553, 892.9553522323857, 3198.3603279344225, 3300.6864347886913, 3314.668533146666, 3337.199072222698, 3385.559877215946, 9199.908000920039, 9546.713598592054, 9558.044195580525, 9562.56968436422, 9572.76068098303, 9509.5720692569, 9522.714318570454, 9522.85715714265, 9529.857052144223, 9541.856872146924, 7233.276672332725, 7323.853522929511, 7340.0, 7342.486025978237, 7436.702531898772, 4824.734639594856, 4846.079244943449, 4877.3903262092235, 4933.975330123327, 4959.851204463727, 8664.046954835088, 8800.16398442147, 8828.646854125764, 8844.95577522134, 8884.200421962054, 8834.779130521789, 8887.911120888966, 9222.769430764285, 9244.306676999118, 9245.953770231106, 6112.847178820565, 6187.16473276102, 6198.783042593487, 6204.968975155095, 6218.782342617987, 7239.565626062453, 7240.348368646847, 7279.417646588367, 7287.635618219174, 7293.744718934812, 6160.630362178284, 6266.248050234001, 6371.713272902638, 6398.87202255943, 6437.130987316652, 6055.333913269449, 6086.087086936995, 6140.785072522441, 6290.433860952537, 6371.39471750183, 6078.635281882925, 6166.414190651881, 6190.473809726223, 6197.380261973766, 6200.968995154995, 4292.463442069741, 4339.978300108479, 4403.873741059046, 4485.0, 4645.047765208192, 4275.209086319041, 4318.654507639444, 4334.133173365402, 4341.8046187922255, 4386.0789234261165], "value": 3978.2370153497754, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.7617905675459, 302.995455068174, 305.04672897196264, 306.12295772611475, 309.645455952934, 4953.529414705602, 4953.87615309617, 4958.975205123978, 4965.453800081988, 4968.627352948525, 4890.948446084091, 4900.6569540132205, 4923.5076492350745, 4929.852104436873, 4933.7533123343865, 3639.181184233546, 3753.530808648919, 3765.755225910321, 3773.0, 3774.0, 3692.2615476904593, 3762.7366084374103, 3805.3340665383585, 3861.362875125601, 3871.1096447817017, 3796.297684928283, 3810.390337545993, 3815.751976121557, 3816.0650640592953, 3826.0, 3607.4047782115917, 3781.810909454516, 3816.103215744298, 3820.2168555446065, 3831.540215174169, 3308.4375656138272, 3324.1357247115925, 3325.6009278886445, 3330.60196658408, 3336.1326055225572, 4790.80836766529, 4790.9816815406075, 4795.4964728703335, 4802.327674125625, 4808.2547205183255, 4347.0, 4350.58669426404, 4353.020570371673, 4353.129374125156, 4353.129374125156, 4987.7755501002175, 5095.847124586268, 5124.231365295198, 5124.333836601218, 5131.512506311894, 3595.82020898954, 3601.3697602919647, 3613.2114603271284, 3614.0, 3615.168511242429, 5375.408705042442, 5406.783728650849, 5410.675359478444, 5413.133898576249, 5415.431379705114, 3574.7140228782155, 3724.7206459515646, 3737.383331750285, 3752.1557649528636, 3759.9436008459893, 3798.772073675588, 3799.259144466858, 3801.9809900950872, 3803.3344164771056, 3807.809609519513, 4345.130973805189, 4364.0, 4367.781610919441, 4371.672124590668, 4374.671899607542, 4971.726555039508, 5111.667741596784, 5123.718195499283, 5165.1219292720325, 5166.793328266903, 1268.4545645372577, 1292.134270039076, 1292.7414517096431, 1295.1710905020793, 1299.6490947444138, 797.3063434811751, 809.9794259233408, 824.282873899711, 829.639106988462, 831.5468069901918, 4293.291606884829, 4429.756363400044, 4439.42287502629, 4440.400545926259, 4441.578050085237, 5177.974110129425, 5283.101872681654, 5288.418273989858, 5297.125974214211, 5325.813596524103, 4482.8792801799555, 4496.7301961882395, 4505.702091933073, 4510.842120525832, 4515.5484451554585, 2659.2819938616854, 2795.762360199365, 2808.6208361871295, 2810.564362523812, 2813.971860281412, 4978.087818626072, 4984.759906061016, 4985.750712464363, 4988.401391832931, 4995.725235112031, 5179.48205179479, 5404.270423492857, 5414.781674123369, 5426.728663566806, 5432.940576587606, 5046.949530504721, 5050.242463630411, 5053.343065401547, 5054.346468104275, 5085.389753229636, 5332.520073193431, 5373.382061062872, 5392.379876314118, 5397.379301380392, 5419.34967803866, 5146.536811686966, 5232.895342093061, 5247.16045432729, 5309.6460402597095, 5328.706921119376, 5035.4712755161645, 5038.790690234244, 5045.495450454925, 5056.57019153376, 5060.873478163076, 3755.361588530011, 3764.6988240941205, 3772.4529943158636, 3790.696744260508, 3792.582815890305, 5057.367829021372, 5266.0, 5397.487238712316, 5400.651596010342, 5405.162199859028, 5128.564072053917, 5153.2270159476375, 5154.046501397253, 5159.716215608178, 5175.482451754794, 5173.81891633791, 5176.0, 5200.297959775533, 5201.843944681515, 5202.531772140525, 4815.470298267258, 5046.410380730058, 5057.241413787961, 5059.949400506095, 5073.44192138857, 4978.60171186297, 5079.974600126976, 5221.9216711748595, 5223.817166399158, 5238.869028274171, 5082.475257422832, 5115.335006449138, 5118.820841270538, 5121.359830021247, 5128.948710512847], "value": 3865.9089930581194, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.8821265215327, 560.627182923356, 569.3424095170079, 570.6005795942841, 613.5306490534739, 13208.471661133555, 14072.718545629106, 14074.085184463003, 14332.4983625573, 14347.282635868218, 13353.198808071522, 13543.322833858292, 13616.523421680244, 13619.319034048283, 13669.65825854354, 757.3486801350834, 775.6083177995105, 776.953382797034, 777.5490215674895, 777.9688812447523, 634.058423241486, 742.476554029408, 765.039874956931, 767.3899250096159, 777.5218240781907, 822.7696245051366, 824.2746383182791, 825.3314814999869, 825.471698113205, 825.896762904637, 822.0998007182126, 822.4078663362429, 822.5887056471735, 822.62159406673, 822.6462621072936, 485.958693511052, 495.5193462341523, 497.5546885537424, 500.469502327534, 579.7912751409489, 12335.568255111028, 12811.423485943154, 12831.615051548468, 12849.0, 12852.036097292741, 11610.477528511237, 11979.640610781691, 12004.639860804102, 12144.453499592539, 12418.81371779424, 10492.317999330095, 10587.84118238227, 10675.039246467777, 10830.945845270802, 10843.240973131884, 3858.5562660294145, 3871.380579107329, 3955.0903292242656, 4039.4344791728886, 4085.9387109193385, 63164.684176579285, 63685.36314636841, 63901.680491597246, 64032.3596764031, 64219.0, 9447.763805904908, 9579.712608621752, 9625.278104142217, 9639.325247232626, 9653.0, 18263.0, 18443.354482593044, 18726.25094996185, 19209.615807683767, 19356.516087097934, 6822.215445223764, 6910.792676219721, 6960.825979350456, 6963.4777391694815, 6981.0924579804305, 3656.4515322701277, 3681.153334732973, 3691.2617476504806, 3730.925381492355, 3763.5295588051495, 2577.4845030993874, 2668.4396276781704, 2670.8664566771586, 2671.131882138274, 2674.665666791651, 458.76832199739584, 470.2569939495589, 472.3127848979726, 509.4828748819951, 538.4400223767238, 387.43047719851774, 421.1030505024279, 454.1190091223017, 467.87601285659326, 475.1447394689545, 7512.272177399229, 7651.885221721679, 7931.167227441036, 7976.800579985431, 8052.235037671529, 499.35598929951306, 519.9272101905736, 524.2346174585073, 531.2933798048587, 534.4682041368862, 3644.7448678592773, 3707.8516859325864, 3714.925701485955, 3803.847846086181, 3822.0, 100131.0, 103245.0, 103367.48316258371, 105212.0, 106035.4698226504, 68481.65759171173, 75843.62078189573, 78166.0, 79974.0, 80875.52995760326, 63626.36373636297, 65246.0, 67506.66246668833, 70969.0, 72427.0, 7460.253974602496, 7569.697212111454, 7666.373715857611, 7850.175731548105, 8397.95801020991, 37285.62714372821, 37359.25281494301, 37733.622663773014, 43353.0, 44522.0, 38984.220315594095, 47308.763456182496, 51061.744691276304, 53191.734041329546, 53329.466705334, 8510.82978340442, 8808.251298639687, 10511.789764204826, 10635.89364106349, 10727.517261723086, 9961.808402151515, 9991.25065620096, 9991.701078859702, 11526.366049867338, 12557.183783054072, 11350.432478376213, 11455.828162577734, 11474.196806223485, 11870.58452954177, 11878.881211187778, 11179.105671546095, 11227.157963152633, 11473.942630286796, 11617.850697620966, 12009.339486327986, 10501.737456563647, 10640.946795265974, 10759.731006724895, 10823.945880270549, 10989.395583242998, 8561.2330574547, 8744.78138046554, 8791.648334066822, 8797.38418310712, 9040.276777857887, 8349.206825351583, 8488.10874858131, 8944.150305720947, 8958.148975847284, 9237.07629237071], "value": 6207.2340310525615, "unit": "score"}], "name": "dromaeo_css", "value": 6240.750156796768, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 114.0, 116.0, 111.0, 115.0, 115.0, 114.0, 114.0, 116.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 123.0, 179.0, 130.0, 129.0, 151.0, 126.0, 160.0, 124.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 162.0, 161.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 109.0, 77.0, 77.0, 74.0, 74.0, 100.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 143.0, 85.0, 86.0, 87.0, 121.0, 86.0, 86.0, 137.0], "value": 100.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 119.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 67.0, 65.0, 66.0, 68.0, 65.0, 66.0, 67.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 82.0, 82.0, 82.0, 82.0, 85.0, 81.0, 82.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 145.0, 132.0, 130.0, 136.0, 129.0, 137.0, 155.0, 137.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 171.0, 172.0, 173.0, 175.0, 168.0, 171.0, 174.0, 174.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 70.0, 68.0, 73.0, 73.0, 68.0, 69.0, 69.0, 70.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1547.1, "alertThreshold": 2.0}]} 10:21:28 INFO - Return code: 0 10:21:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:21:28 INFO - # TBPL SUCCESS # 10:21:28 INFO - Running post-action listener: _resource_record_post_action 10:21:28 INFO - [mozharness: 2016-08-18 17:21:28.268925Z] Finished run-tests step (success) 10:21:28 INFO - Running post-run listener: _resource_record_post_run 10:21:28 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 655360; Write bytes: 397176832; Read time: 120; Write time: 259160 10:21:28 INFO - TinderboxPrint: CPU usage
13.0% 10:21:28 INFO - TinderboxPrint: I/O read bytes / time
655,360 / 120 10:21:28 INFO - TinderboxPrint: I/O write bytes / time
397,176,832 / 259,160 10:21:28 INFO - TinderboxPrint: CPU idle
8,336.2 (87.0%) 10:21:28 INFO - TinderboxPrint: CPU user
1,198.3 (12.5%) 10:21:28 INFO - TinderboxPrint: Swap in / out
0 / 0 10:21:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113528832; Read time: 0; Write time: 66316 10:21:28 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 651264; Write bytes: 283648000; Read time: 120; Write time: 192844 10:21:28 INFO - Running post-run listener: _upload_blobber_files 10:21:28 INFO - Blob upload gear active. 10:21:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:21:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:21:29 INFO - (blobuploader) - INFO - Open directory for files ... 10:21:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:21:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:21:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:30 INFO - (blobuploader) - INFO - Done attempting. 10:21:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:21:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:21:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:30 INFO - (blobuploader) - INFO - Done attempting. 10:21:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:21:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:21:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:36 INFO - (blobuploader) - INFO - Done attempting. 10:21:36 INFO - (blobuploader) - INFO - Iteration through files over. 10:21:36 INFO - Return code: 0 10:21:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:21:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:21:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c92cbca3ddd6625563aabc9c48e5be740173232dd2fd4e6c9da25588cb4ef1149a9ce3fb255a6e42932be8ce8cce97a6ddb5a3b797821dfba9a2a3f56d3eb1e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e46efe44d193de3cffe36ae108b91457e051e4cb0ba50e2d0f94cde8f809da4436293d817d4c34006c2c5c5c92054f4b1a470e95ce58082072d70dc408070f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af9e0259d31710a54fae9f2309dd974998cf0ab3e1d6d65c1a851fb9b951044e95e1c1466f4519f138b4f2c45c5b6f3e3c2ea8fb78289646b98266fb86fe235d"} 10:21:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:21:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:21:36 INFO - Contents: 10:21:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c92cbca3ddd6625563aabc9c48e5be740173232dd2fd4e6c9da25588cb4ef1149a9ce3fb255a6e42932be8ce8cce97a6ddb5a3b797821dfba9a2a3f56d3eb1e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e46efe44d193de3cffe36ae108b91457e051e4cb0ba50e2d0f94cde8f809da4436293d817d4c34006c2c5c5c92054f4b1a470e95ce58082072d70dc408070f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af9e0259d31710a54fae9f2309dd974998cf0ab3e1d6d65c1a851fb9b951044e95e1c1466f4519f138b4f2c45c5b6f3e3c2ea8fb78289646b98266fb86fe235d"} 10:21:36 INFO - Running post-run listener: copy_logs_to_upload_dir 10:21:36 INFO - Copying logs to upload dir... 10:21:36 INFO - mkdir: /builds/slave/test/build/upload/logs 10:21:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.933501 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-18 10:21:36.288952) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 10:21:36.292498) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c92cbca3ddd6625563aabc9c48e5be740173232dd2fd4e6c9da25588cb4ef1149a9ce3fb255a6e42932be8ce8cce97a6ddb5a3b797821dfba9a2a3f56d3eb1e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e46efe44d193de3cffe36ae108b91457e051e4cb0ba50e2d0f94cde8f809da4436293d817d4c34006c2c5c5c92054f4b1a470e95ce58082072d70dc408070f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af9e0259d31710a54fae9f2309dd974998cf0ab3e1d6d65c1a851fb9b951044e95e1c1466f4519f138b4f2c45c5b6f3e3c2ea8fb78289646b98266fb86fe235d"} build_url:https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/bgxhpooCSO2qt5zYFuEzKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c92cbca3ddd6625563aabc9c48e5be740173232dd2fd4e6c9da25588cb4ef1149a9ce3fb255a6e42932be8ce8cce97a6ddb5a3b797821dfba9a2a3f56d3eb1e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e46efe44d193de3cffe36ae108b91457e051e4cb0ba50e2d0f94cde8f809da4436293d817d4c34006c2c5c5c92054f4b1a470e95ce58082072d70dc408070f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af9e0259d31710a54fae9f2309dd974998cf0ab3e1d6d65c1a851fb9b951044e95e1c1466f4519f138b4f2c45c5b6f3e3c2ea8fb78289646b98266fb86fe235d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 10:21:36.318531) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 10:21:36.318861) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1471539649.750354-1992825456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 10:21:36.401843) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 10:21:36.402201) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 10:21:36.402477) ========= ========= Total master_lag: 0.18 =========