builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1467018124.54 results: success (0) buildid: 20160627004823 builduid: 7e9e73d6c54e44ca916b3f351104e610 revision: f5a2832bb5f9a9f5d31df70ca6557f3be6f9468e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 02:02:04.543606) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 02:02:04.544184) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 02:02:04.544558) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 02:02:04.566216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 02:02:04.566576) ========= 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=32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 02:02:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.7M=0s 2016-06-27 02:02:05 (88.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122372 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 02:02:04.705094) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 02:02:04.705450) ========= 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=32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020546 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 02:02:04.846733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 02:02:04.847097) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f5a2832bb5f9a9f5d31df70ca6557f3be6f9468e --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 f5a2832bb5f9a9f5d31df70ca6557f3be6f9468e --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=32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 02:02:06,118 truncating revision to first 12 chars 2016-06-27 02:02:06,118 Setting DEBUG logging. 2016-06-27 02:02:06,118 attempt 1/10 2016-06-27 02:02:06,118 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f5a2832bb5f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 02:02:06,476 unpacking tar archive at: fx-team-f5a2832bb5f9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.706708 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 02:02:05.575005) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 02:02:05.575329) ========= script_repo_revision: f5a2832bb5f9a9f5d31df70ca6557f3be6f9468e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 02:02:05.575804) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 02:02:05.576106) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 02:02:05.585757) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-27 02:02:05.586068) ========= /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=32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:02:06 INFO - MultiFileLogger online at 20160627 02:02:06 in /builds/slave/test 02:02:06 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 02:02:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:02:06 INFO - {'append_to_log': False, 02:02:06 INFO - 'base_work_dir': '/builds/slave/test', 02:02:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:02:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:02:06 INFO - 'branch': 'Fx-Team-Non-PGO', 02:02:06 INFO - 'buildbot_json_path': 'buildprops.json', 02:02:06 INFO - 'config_files': ('talos/linux_config.py',), 02:02:06 INFO - 'default_actions': ('clobber', 02:02:06 INFO - 'read-buildbot-config', 02:02:06 INFO - 'download-and-extract', 02:02:06 INFO - 'populate-webroot', 02:02:06 INFO - 'create-virtualenv', 02:02:06 INFO - 'install', 02:02:06 INFO - 'run-tests'), 02:02:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:02:06 INFO - 'download_minidump_stackwalk': True, 02:02:06 INFO - 'download_symbols': 'ondemand', 02:02:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:02:06 INFO - 'tooltool.py': '/tools/tooltool.py', 02:02:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:02:06 INFO - '/tools/misc-python/virtualenv.py')}, 02:02:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:02:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:02:06 INFO - 'installer_path': 'installer.exe', 02:02:06 INFO - 'log_level': 'info', 02:02:06 INFO - 'log_name': 'talos', 02:02:06 INFO - 'log_to_console': True, 02:02:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:02:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:02:06 INFO - 'opt_config_files': (), 02:02:06 INFO - 'pip_index': False, 02:02:06 INFO - 'sps_profile': False, 02:02:06 INFO - 'sps_profile_interval': 0, 02:02:06 INFO - 'suite': 'dromaeojs', 02:02:06 INFO - 'system_bits': '32', 02:02:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:02:06 INFO - 'title': 'talos-linux64-ix-008', 02:02:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:02:06 INFO - 'use_talos_json': True, 02:02:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:02:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:02:06 INFO - 'work_dir': 'build'} 02:02:06 INFO - ##### 02:02:06 INFO - ##### Running clobber step. 02:02:06 INFO - ##### 02:02:06 INFO - Running pre-action listener: _resource_record_pre_action 02:02:06 INFO - Running main action method: clobber 02:02:06 INFO - rmtree: /builds/slave/test/build 02:02:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:02:07 INFO - Running post-action listener: _resource_record_post_action 02:02:07 INFO - ##### 02:02:07 INFO - ##### Finished clobber step (success) 02:02:07 INFO - ##### 02:02:07 INFO - ##### 02:02:07 INFO - ##### Running read-buildbot-config step. 02:02:07 INFO - ##### 02:02:07 INFO - Running pre-action listener: _resource_record_pre_action 02:02:07 INFO - Running main action method: read_buildbot_config 02:02:07 INFO - Using buildbot properties: 02:02:07 INFO - { 02:02:07 INFO - "project": "", 02:02:07 INFO - "product": "firefox", 02:02:07 INFO - "script_repo_revision": "production", 02:02:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:02:07 INFO - "repository": "", 02:02:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:02:07 INFO - "buildid": "20160627004823", 02:02:07 INFO - "pgo_build": "False", 02:02:07 INFO - "basedir": "/builds/slave/test", 02:02:07 INFO - "buildnumber": 1776, 02:02:07 INFO - "slavename": "talos-linux64-ix-008", 02:02:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:02:07 INFO - "platform": "ubuntu64_hw", 02:02:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:02:07 INFO - "branch": "fx-team", 02:02:07 INFO - "repo_path": "integration/fx-team", 02:02:07 INFO - "revision": "f5a2832bb5f9a9f5d31df70ca6557f3be6f9468e", 02:02:07 INFO - "stage_platform": "linux64", 02:02:07 INFO - "builduid": "7e9e73d6c54e44ca916b3f351104e610", 02:02:07 INFO - "slavebuilddir": "test" 02:02:07 INFO - } 02:02:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:02:07 INFO - Running post-action listener: _resource_record_post_action 02:02:07 INFO - ##### 02:02:07 INFO - ##### Finished read-buildbot-config step (success) 02:02:07 INFO - ##### 02:02:07 INFO - ##### 02:02:07 INFO - ##### Running download-and-extract step. 02:02:07 INFO - ##### 02:02:07 INFO - Running pre-action listener: _resource_record_pre_action 02:02:07 INFO - Running main action method: download_and_extract 02:02:07 INFO - mkdir: /builds/slave/test/build/tests 02:02:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:07 INFO - https://queue.taskcluster.net/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:02:08 INFO - Downloaded 1361 bytes. 02:02:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:02:08 INFO - Using the following test package requirements: 02:02:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:02:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:02:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:02:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:08 INFO - u'jsshell-linux-x86_64.zip'], 02:02:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:02:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:02:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:02:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:02:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:02:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:02:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:02: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:08 INFO - https://queue.taskcluster.net/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:02:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:02:09 INFO - Downloaded 22712973 bytes. 02:02:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:02:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:02:10 INFO - Return code: 0 02:02:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:02:10 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:10 INFO - https://queue.taskcluster.net/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:02:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:02:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:02:11 INFO - Downloaded 22712973 bytes. 02:02:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:02:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:02:13 INFO - Return code: 0 02:02:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:13 INFO - https://queue.taskcluster.net/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:02:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:02:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:02:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:02:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:02:14 INFO - Downloaded 14405240 bytes. 02:02:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:02:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:02:14 INFO - Return code: 0 02:02: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:14 INFO - https://queue.taskcluster.net/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:02:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:02:15 INFO - Downloaded 56279693 bytes. 02:02:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:15 INFO - mkdir: /builds/slave/test/properties 02:02:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:02:15 INFO - Writing to file /builds/slave/test/properties/build_url 02:02:15 INFO - Contents: 02:02:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:02:16 INFO - Running post-action listener: _resource_record_post_action 02:02:16 INFO - Running post-action listener: set_extra_try_arguments 02:02:16 INFO - ##### 02:02:16 INFO - ##### Finished download-and-extract step (success) 02:02:16 INFO - ##### 02:02:16 INFO - ##### 02:02:16 INFO - ##### Running populate-webroot step. 02:02:16 INFO - ##### 02:02:16 INFO - Running pre-action listener: _resource_record_pre_action 02:02:16 INFO - Running main action method: populate_webroot 02:02:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:02:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:02:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:02:16 INFO - '--tppagecycles', 02:02:16 INFO - '7'], 02:02:16 INFO - 'tests': ['tsvgm']}}, 02:02:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:02:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:02:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:02:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:02:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:02:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:02:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:16 INFO - 'talos_options': ['--disable-e10s'], 02:02:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:16 INFO - 'talos_options': ['--disable-e10s'], 02:02:16 INFO - 'tests': ['damp', 'tps']}, 02:02:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:16 INFO - 'tests': ['damp', 'tps']}, 02:02:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:02:16 INFO - 'tests': ['dromaeo_dom']}, 02:02:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:02:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:02:16 INFO - 'tests': ['basic_compositor_video']}, 02:02:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:02:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:02:16 INFO - 'tests': ['a11yr', 02:02:16 INFO - 'ts_paint', 02:02:16 INFO - 'tpaint', 02:02:16 INFO - 'sessionrestore', 02:02:16 INFO - 'sessionrestore_no_auto_restore', 02:02:16 INFO - 'tabpaint']}, 02:02:16 INFO - 'other-e10s': {'tests': ['a11yr', 02:02:16 INFO - 'ts_paint', 02:02:16 INFO - 'tpaint', 02:02:16 INFO - 'sessionrestore', 02:02:16 INFO - 'sessionrestore_no_auto_restore', 02:02:16 INFO - 'tabpaint']}, 02:02:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:02:16 INFO - 'ts_paint', 02:02:16 INFO - 'tpaint', 02:02:16 INFO - 'sessionrestore', 02:02:16 INFO - 'sessionrestore_no_auto_restore', 02:02:16 INFO - 'tabpaint']}, 02:02:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:02:16 INFO - 'ts_paint', 02:02:16 INFO - 'tpaint', 02:02:16 INFO - 'sessionrestore', 02:02:16 INFO - 'sessionrestore_no_auto_restore', 02:02:16 INFO - 'tabpaint']}, 02:02:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:02:16 INFO - 'tests': ['a11yr', 02:02:16 INFO - 'ts_paint', 02:02:16 INFO - 'tpaint', 02:02:16 INFO - 'sessionrestore', 02:02:16 INFO - 'sessionrestore_no_auto_restore', 02:02:16 INFO - 'tabpaint']}, 02:02:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:02:16 INFO - 'tests': ['a11yr', 02:02:16 INFO - 'ts_paint', 02:02:16 INFO - 'tpaint', 02:02:16 INFO - 'sessionrestore', 02:02:16 INFO - 'sessionrestore_no_auto_restore', 02:02:16 INFO - 'tabpaint']}, 02:02:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:02:16 INFO - 'tests': ['tsvgx', 02:02:16 INFO - 'tsvgr_opacity', 02:02:16 INFO - 'tart', 02:02:16 INFO - 'tscrollx', 02:02:16 INFO - 'cart']}, 02:02:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:02:16 INFO - 'tsvgr_opacity', 02:02:16 INFO - 'tart', 02:02:16 INFO - 'tscrollx', 02:02:16 INFO - 'cart']}, 02:02:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:16 INFO - 'talos_options': ['--disable-e10s'], 02:02:16 INFO - 'tests': ['tp5o']}, 02:02:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:16 INFO - 'tests': ['tp5o']}, 02:02:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:16 INFO - 'talos_options': ['--disable-e10s', 02:02:16 INFO - '--xperf_path', 02:02:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:02:16 INFO - 'tests': ['tp5n']}, 02:02:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:16 INFO - 'talos_options': ['--xperf_path', 02:02:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:02:16 INFO - 'tests': ['tp5n']}}, 02:02:16 INFO - 'talos.zip': {'path': '', 02:02:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:02:16 INFO - Running post-action listener: _resource_record_post_action 02:02:16 INFO - ##### 02:02:16 INFO - ##### Finished populate-webroot step (success) 02:02:16 INFO - ##### 02:02:16 INFO - ##### 02:02:16 INFO - ##### Running create-virtualenv step. 02:02:16 INFO - ##### 02:02:16 INFO - Running pre-action listener: _resource_record_pre_action 02:02:16 INFO - Running main action method: create_virtualenv 02:02:16 INFO - Creating virtualenv /builds/slave/test/build/venv 02:02:16 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 02:02:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:02:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:02:16 INFO - Using real prefix '/usr' 02:02:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:02:17 INFO - Installing distribute.............................................................................................................................................................................................done. 02:02:19 INFO - Installing pip.................done. 02:02:19 INFO - Return code: 0 02:02:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:02:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:19 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 0x7f45f18d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2350480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df6f0>, '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 0x23e05f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0aa0>, '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': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', '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 02:02:19 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 02:02:19 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 02:02:19 INFO - Using env: {'DISPLAY': ':0', 02:02:19 INFO - 'HOME': '/home/cltbld', 02:02:19 INFO - 'LANG': 'en_US.UTF-8', 02:02:19 INFO - 'LANGUAGE': 'en_US:en', 02:02:19 INFO - 'LOGNAME': 'cltbld', 02:02:19 INFO - 'MAIL': '/var/mail/cltbld', 02:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:19 INFO - 'MOZ_NO_REMOTE': '1', 02:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:19 INFO - 'NO_EM_RESTART': '1', 02:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:19 INFO - 'PWD': '/builds/slave/test', 02:02:19 INFO - 'SHELL': '/bin/bash', 02:02:19 INFO - 'SHLVL': '1', 02:02:19 INFO - 'TERM': 'linux', 02:02:19 INFO - 'TMOUT': '86400', 02:02:19 INFO - 'USER': 'cltbld', 02:02:19 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', 02:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:19 INFO - '_': '/tools/buildbot/bin/python'} 02:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:19 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 02:02:19 INFO - Cleaning up... 02:02:19 INFO - Return code: 0 02:02:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:02:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:19 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 0x7f45f18d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2350480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df6f0>, '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 0x23e05f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0aa0>, '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': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', '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 02:02:19 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 02:02:19 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 02:02:19 INFO - Using env: {'DISPLAY': ':0', 02:02:19 INFO - 'HOME': '/home/cltbld', 02:02:19 INFO - 'LANG': 'en_US.UTF-8', 02:02:19 INFO - 'LANGUAGE': 'en_US:en', 02:02:19 INFO - 'LOGNAME': 'cltbld', 02:02:19 INFO - 'MAIL': '/var/mail/cltbld', 02:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:19 INFO - 'MOZ_NO_REMOTE': '1', 02:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:19 INFO - 'NO_EM_RESTART': '1', 02:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:19 INFO - 'PWD': '/builds/slave/test', 02:02:19 INFO - 'SHELL': '/bin/bash', 02:02:19 INFO - 'SHLVL': '1', 02:02:19 INFO - 'TERM': 'linux', 02:02:19 INFO - 'TMOUT': '86400', 02:02:19 INFO - 'USER': 'cltbld', 02:02:19 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', 02:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:19 INFO - '_': '/tools/buildbot/bin/python'} 02:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:19 INFO - Downloading/unpacking psutil>=3.1.1 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:02:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:21 INFO - Installing collected packages: psutil 02:02:21 INFO - Running setup.py install for psutil 02:02:21 INFO - building 'psutil._psutil_linux' extension 02:02:21 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 02:02:21 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 02:02:21 INFO - building 'psutil._psutil_posix' extension 02:02:21 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 02:02:22 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 02:02:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:22 INFO - Successfully installed psutil 02:02:22 INFO - Cleaning up... 02:02:22 INFO - Return code: 0 02:02:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:02:22 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:22 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:22 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 0x7f45f18d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2350480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df6f0>, '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 0x23e05f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0aa0>, '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': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', '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 02:02:22 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 02:02:22 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 02:02:22 INFO - Using env: {'DISPLAY': ':0', 02:02:22 INFO - 'HOME': '/home/cltbld', 02:02:22 INFO - 'LANG': 'en_US.UTF-8', 02:02:22 INFO - 'LANGUAGE': 'en_US:en', 02:02:22 INFO - 'LOGNAME': 'cltbld', 02:02:22 INFO - 'MAIL': '/var/mail/cltbld', 02:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:22 INFO - 'MOZ_NO_REMOTE': '1', 02:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:22 INFO - 'NO_EM_RESTART': '1', 02:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:22 INFO - 'PWD': '/builds/slave/test', 02:02:22 INFO - 'SHELL': '/bin/bash', 02:02:22 INFO - 'SHLVL': '1', 02:02:22 INFO - 'TERM': 'linux', 02:02:22 INFO - 'TMOUT': '86400', 02:02:22 INFO - 'USER': 'cltbld', 02:02:22 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', 02:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:22 INFO - '_': '/tools/buildbot/bin/python'} 02:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:02:22 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 02:02:22 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 02:02:22 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 02:02:22 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 02:02:22 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 02:02:22 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 02:02:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:02:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:02:24 INFO - Installing collected packages: mozsystemmonitor 02:02:24 INFO - Running setup.py install for mozsystemmonitor 02:02:24 INFO - Successfully installed mozsystemmonitor 02:02:24 INFO - Cleaning up... 02:02:24 INFO - Return code: 0 02:02:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:02:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:24 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 0x7f45f18d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2350480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df6f0>, '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 0x23e05f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0aa0>, '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': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', '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 02:02:24 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 02:02:24 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 02:02:24 INFO - Using env: {'DISPLAY': ':0', 02:02:24 INFO - 'HOME': '/home/cltbld', 02:02:24 INFO - 'LANG': 'en_US.UTF-8', 02:02:24 INFO - 'LANGUAGE': 'en_US:en', 02:02:24 INFO - 'LOGNAME': 'cltbld', 02:02:24 INFO - 'MAIL': '/var/mail/cltbld', 02:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:24 INFO - 'MOZ_NO_REMOTE': '1', 02:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:24 INFO - 'NO_EM_RESTART': '1', 02:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:24 INFO - 'PWD': '/builds/slave/test', 02:02:24 INFO - 'SHELL': '/bin/bash', 02:02:24 INFO - 'SHLVL': '1', 02:02:24 INFO - 'TERM': 'linux', 02:02:24 INFO - 'TMOUT': '86400', 02:02:24 INFO - 'USER': 'cltbld', 02:02:24 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', 02:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:24 INFO - '_': '/tools/buildbot/bin/python'} 02:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:24 INFO - Downloading/unpacking jsonschema==2.5.1 02:02:24 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 02:02:24 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 02:02:24 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 02:02:24 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 02:02:24 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 02:02:24 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 02:02:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:02:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:02:27 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 02:02:27 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 02:02:27 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 02:02:27 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 02:02:27 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 02:02:27 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 02:02:27 INFO - Downloading functools32-3.2.3-2.tar.gz 02:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:02:27 INFO - warning: no files found matching '*.txt' 02:02:27 INFO - no previously-included directories found matching 'build' 02:02:27 INFO - no previously-included directories found matching 'dist' 02:02:27 INFO - no previously-included directories found matching '.git*' 02:02:27 INFO - Installing collected packages: jsonschema, functools32 02:02:27 INFO - Running setup.py install for functools32 02:02:27 INFO - warning: no files found matching '*.txt' 02:02:27 INFO - no previously-included directories found matching 'build' 02:02:27 INFO - no previously-included directories found matching 'dist' 02:02:27 INFO - no previously-included directories found matching '.git*' 02:02:27 INFO - Successfully installed jsonschema functools32 02:02:27 INFO - Cleaning up... 02:02:28 INFO - Return code: 0 02:02:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:02:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:28 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 0x7f45f18d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2350480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df6f0>, '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 0x23e05f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0aa0>, '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': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', '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 02:02:28 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 02:02:28 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 02:02:28 INFO - Using env: {'DISPLAY': ':0', 02:02:28 INFO - 'HOME': '/home/cltbld', 02:02:28 INFO - 'LANG': 'en_US.UTF-8', 02:02:28 INFO - 'LANGUAGE': 'en_US:en', 02:02:28 INFO - 'LOGNAME': 'cltbld', 02:02:28 INFO - 'MAIL': '/var/mail/cltbld', 02:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:28 INFO - 'MOZ_NO_REMOTE': '1', 02:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:28 INFO - 'NO_EM_RESTART': '1', 02:02:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:28 INFO - 'PWD': '/builds/slave/test', 02:02:28 INFO - 'SHELL': '/bin/bash', 02:02:28 INFO - 'SHLVL': '1', 02:02:28 INFO - 'TERM': 'linux', 02:02:28 INFO - 'TMOUT': '86400', 02:02:28 INFO - 'USER': 'cltbld', 02:02:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', 02:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:28 INFO - '_': '/tools/buildbot/bin/python'} 02:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:28 INFO - Downloading/unpacking blobuploader==1.2.4 02:02:28 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 02:02:28 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 02:02:28 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 02:02:28 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 02:02:28 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 02:02:28 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 02:02:30 INFO - Downloading blobuploader-1.2.4.tar.gz 02:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:02:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:02:30 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 02:02:30 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 02:02:30 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 02:02:30 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 02:02:30 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 02:02:30 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 02:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:02:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:02:30 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 02:02:30 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 02:02:30 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 02:02:30 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 02:02:30 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 02:02:30 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 02:02:30 INFO - Downloading docopt-0.6.1.tar.gz 02:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:02:30 INFO - Installing collected packages: blobuploader, requests, docopt 02:02:30 INFO - Running setup.py install for blobuploader 02:02:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:02:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:02:31 INFO - Running setup.py install for requests 02:02:31 INFO - Running setup.py install for docopt 02:02:31 INFO - Successfully installed blobuploader requests docopt 02:02:31 INFO - Cleaning up... 02:02:31 INFO - Return code: 0 02:02:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:31 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:31 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:31 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 0x7f45f18d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2350480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df6f0>, '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 0x23e05f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0aa0>, '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': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', '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 02:02:31 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 02:02:31 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 02:02:31 INFO - Using env: {'DISPLAY': ':0', 02:02:31 INFO - 'HOME': '/home/cltbld', 02:02:31 INFO - 'LANG': 'en_US.UTF-8', 02:02:31 INFO - 'LANGUAGE': 'en_US:en', 02:02:31 INFO - 'LOGNAME': 'cltbld', 02:02:31 INFO - 'MAIL': '/var/mail/cltbld', 02:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:31 INFO - 'MOZ_NO_REMOTE': '1', 02:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:31 INFO - 'NO_EM_RESTART': '1', 02:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:31 INFO - 'PWD': '/builds/slave/test', 02:02:31 INFO - 'SHELL': '/bin/bash', 02:02:31 INFO - 'SHLVL': '1', 02:02:31 INFO - 'TERM': 'linux', 02:02:31 INFO - 'TMOUT': '86400', 02:02:31 INFO - 'USER': 'cltbld', 02:02:31 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', 02:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:31 INFO - '_': '/tools/buildbot/bin/python'} 02:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:31 INFO - Running setup.py (path:/tmp/pip-j3yqYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:31 INFO - Running setup.py (path:/tmp/pip-erb_p3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:31 INFO - Running setup.py (path:/tmp/pip-ChAq7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:31 INFO - Running setup.py (path:/tmp/pip-zSMSfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:32 INFO - Running setup.py (path:/tmp/pip-GSKWax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:32 INFO - Running setup.py (path:/tmp/pip-jijGMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:32 INFO - Running setup.py (path:/tmp/pip-RJgJKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:32 INFO - Running setup.py (path:/tmp/pip-Ns4YyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:32 INFO - Running setup.py (path:/tmp/pip-afh4w4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:32 INFO - Running setup.py (path:/tmp/pip-qGhQQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:32 INFO - Running setup.py (path:/tmp/pip-hLd1Bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:32 INFO - Running setup.py (path:/tmp/pip-3yfGIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:32 INFO - Running setup.py (path:/tmp/pip-OHCbuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:32 INFO - Running setup.py (path:/tmp/pip-7hdvbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:32 INFO - Running setup.py (path:/tmp/pip-6YftvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:32 INFO - Running setup.py (path:/tmp/pip-Iga5AJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:32 INFO - Running setup.py (path:/tmp/pip-6F34sU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:02:32 INFO - Running setup.py install for manifestparser 02:02:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:02:33 INFO - Running setup.py install for mozcrash 02:02:33 INFO - Running setup.py install for mozdebug 02:02:33 INFO - Running setup.py install for mozdevice 02:02:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:02:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:02:33 INFO - Running setup.py install for mozfile 02:02:33 INFO - Running setup.py install for mozhttpd 02:02:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:02:33 INFO - Running setup.py install for mozinfo 02:02:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:02:33 INFO - Running setup.py install for mozInstall 02:02:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:02:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:02:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:02:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:02:33 INFO - Running setup.py install for mozleak 02:02:33 INFO - Running setup.py install for mozlog 02:02:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:02:33 INFO - Running setup.py install for moznetwork 02:02:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:02:34 INFO - Running setup.py install for mozprocess 02:02:34 INFO - Running setup.py install for mozprofile 02:02:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:02:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:02:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:02:34 INFO - Running setup.py install for mozrunner 02:02:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:02:34 INFO - Running setup.py install for mozscreenshot 02:02:34 INFO - Running setup.py install for moztest 02:02:34 INFO - Running setup.py install for mozversion 02:02:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:02:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:02:34 INFO - Cleaning up... 02:02:34 INFO - Return code: 0 02:02:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:34 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 0x7f45f18d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2350480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df6f0>, '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 0x23e05f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0aa0>, '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': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', '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 02:02:34 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 02:02:34 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 02:02:34 INFO - Using env: {'DISPLAY': ':0', 02:02:34 INFO - 'HOME': '/home/cltbld', 02:02:34 INFO - 'LANG': 'en_US.UTF-8', 02:02:34 INFO - 'LANGUAGE': 'en_US:en', 02:02:34 INFO - 'LOGNAME': 'cltbld', 02:02:34 INFO - 'MAIL': '/var/mail/cltbld', 02:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:34 INFO - 'MOZ_NO_REMOTE': '1', 02:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:34 INFO - 'NO_EM_RESTART': '1', 02:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:34 INFO - 'PWD': '/builds/slave/test', 02:02:34 INFO - 'SHELL': '/bin/bash', 02:02:34 INFO - 'SHLVL': '1', 02:02:34 INFO - 'TERM': 'linux', 02:02:34 INFO - 'TMOUT': '86400', 02:02:34 INFO - 'USER': 'cltbld', 02:02:34 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', 02:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:34 INFO - '_': '/tools/buildbot/bin/python'} 02:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:34 INFO - Running setup.py (path:/tmp/pip-pBK18Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:35 INFO - Running setup.py (path:/tmp/pip-9pvoDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:35 INFO - Running setup.py (path:/tmp/pip-_7C3cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:35 INFO - Running setup.py (path:/tmp/pip-GVoSav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:35 INFO - Running setup.py (path:/tmp/pip-rMflUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:35 INFO - Running setup.py (path:/tmp/pip-SlLEXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:35 INFO - Running setup.py (path:/tmp/pip-0qUi8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:35 INFO - Running setup.py (path:/tmp/pip-KSJvUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:35 INFO - Running setup.py (path:/tmp/pip-Rmm2yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:35 INFO - Running setup.py (path:/tmp/pip-J5w0Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:35 INFO - Running setup.py (path:/tmp/pip-_COkoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:35 INFO - Running setup.py (path:/tmp/pip-ln2sFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:35 INFO - Running setup.py (path:/tmp/pip-D7F5dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:35 INFO - Running setup.py (path:/tmp/pip-MLvKAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:35 INFO - Running setup.py (path:/tmp/pip-5tl65m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:36 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)) 02:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:36 INFO - Running setup.py (path:/tmp/pip-AWa39e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:36 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)) 02:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:36 INFO - Running setup.py (path:/tmp/pip-d0GVGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:36 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)) 02:02:36 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)) 02:02:36 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)) 02:02:36 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)) 02:02:36 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)) 02:02:36 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)) 02:02:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:02:36 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 02:02:36 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 02:02:36 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 02:02:36 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 02:02:36 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 02:02:36 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 02:02:38 INFO - Downloading blessings-1.6.tar.gz 02:02:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:02:38 INFO - Installing collected packages: blessings 02:02:38 INFO - Running setup.py install for blessings 02:02:38 INFO - Successfully installed blessings 02:02:38 INFO - Cleaning up... 02:02:38 INFO - Return code: 0 02:02:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:02:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:38 INFO - Reading from file tmpfile_stdout 02:02:38 INFO - Current package versions: 02:02:38 INFO - argparse == 1.2.1 02:02:38 INFO - blessings == 1.6 02:02:38 INFO - blobuploader == 1.2.4 02:02:38 INFO - docopt == 0.6.1 02:02:38 INFO - functools32 == 3.2.3-2 02:02:38 INFO - jsonschema == 2.5.1 02:02:38 INFO - manifestparser == 1.1 02:02:38 INFO - mozInstall == 1.12 02:02:38 INFO - mozcrash == 0.17 02:02:38 INFO - mozdebug == 0.1 02:02:38 INFO - mozdevice == 0.48 02:02:38 INFO - mozfile == 1.2 02:02:38 INFO - mozhttpd == 0.7 02:02:38 INFO - mozinfo == 0.9 02:02:38 INFO - mozleak == 0.1 02:02:38 INFO - mozlog == 3.2 02:02:38 INFO - moznetwork == 0.27 02:02:38 INFO - mozprocess == 0.22 02:02:38 INFO - mozprofile == 0.28 02:02:38 INFO - mozrunner == 6.11 02:02:38 INFO - mozscreenshot == 0.1 02:02:38 INFO - mozsystemmonitor == 0.3 02:02:38 INFO - moztest == 0.7 02:02:38 INFO - mozversion == 1.4 02:02:38 INFO - psutil == 3.1.1 02:02:38 INFO - requests == 1.2.3 02:02:38 INFO - wsgiref == 0.1.2 02:02:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:38 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 0x7f45f18d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2350480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df6f0>, '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 0x23e05f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0aa0>, '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': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', '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 02:02:38 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 02:02:38 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 02:02:38 INFO - Using env: {'DISPLAY': ':0', 02:02:38 INFO - 'HOME': '/home/cltbld', 02:02:38 INFO - 'LANG': 'en_US.UTF-8', 02:02:38 INFO - 'LANGUAGE': 'en_US:en', 02:02:38 INFO - 'LOGNAME': 'cltbld', 02:02:38 INFO - 'MAIL': '/var/mail/cltbld', 02:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:38 INFO - 'MOZ_NO_REMOTE': '1', 02:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:38 INFO - 'NO_EM_RESTART': '1', 02:02:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:38 INFO - 'PWD': '/builds/slave/test', 02:02:38 INFO - 'SHELL': '/bin/bash', 02:02:38 INFO - 'SHLVL': '1', 02:02:38 INFO - 'TERM': 'linux', 02:02:38 INFO - 'TMOUT': '86400', 02:02:38 INFO - 'USER': 'cltbld', 02:02:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', 02:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:38 INFO - '_': '/tools/buildbot/bin/python'} 02:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:38 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)) 02:02:38 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)) 02:02:38 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)) 02:02:38 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)) 02:02:38 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)) 02:02:38 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)) 02:02:38 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)) 02:02:38 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)) 02:02:38 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)) 02:02:38 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)) 02:02:38 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)) 02:02:38 INFO - Cleaning up... 02:02:38 INFO - Return code: 0 02:02:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:02:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:38 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 0x7f45f18d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2350480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df6f0>, '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 0x23e05f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0aa0>, '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': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', '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 02:02:38 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 02:02:38 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 02:02:38 INFO - Using env: {'DISPLAY': ':0', 02:02:38 INFO - 'HOME': '/home/cltbld', 02:02:38 INFO - 'LANG': 'en_US.UTF-8', 02:02:38 INFO - 'LANGUAGE': 'en_US:en', 02:02:38 INFO - 'LOGNAME': 'cltbld', 02:02:38 INFO - 'MAIL': '/var/mail/cltbld', 02:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:38 INFO - 'MOZ_NO_REMOTE': '1', 02:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:38 INFO - 'NO_EM_RESTART': '1', 02:02:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:38 INFO - 'PWD': '/builds/slave/test', 02:02:38 INFO - 'SHELL': '/bin/bash', 02:02:38 INFO - 'SHLVL': '1', 02:02:38 INFO - 'TERM': 'linux', 02:02:38 INFO - 'TMOUT': '86400', 02:02:38 INFO - 'USER': 'cltbld', 02:02:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', 02:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:38 INFO - '_': '/tools/buildbot/bin/python'} 02:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:02:38 INFO - Cleaning up... 02:02:39 INFO - Return code: 0 02:02:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:02:39 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:39 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:39 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f45f18d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2350480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23df6f0>, '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 0x23e05f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0aa0>, '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': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', '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 02:02:39 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', 'flake8'] in /builds/slave/test/build 02:02:39 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 flake8 02:02:39 INFO - Using env: {'DISPLAY': ':0', 02:02:39 INFO - 'HOME': '/home/cltbld', 02:02:39 INFO - 'LANG': 'en_US.UTF-8', 02:02:39 INFO - 'LANGUAGE': 'en_US:en', 02:02:39 INFO - 'LOGNAME': 'cltbld', 02:02:39 INFO - 'MAIL': '/var/mail/cltbld', 02:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:39 INFO - 'MOZ_NO_REMOTE': '1', 02:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:39 INFO - 'NO_EM_RESTART': '1', 02:02:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:39 INFO - 'PWD': '/builds/slave/test', 02:02:39 INFO - 'SHELL': '/bin/bash', 02:02:39 INFO - 'SHLVL': '1', 02:02:39 INFO - 'TERM': 'linux', 02:02:39 INFO - 'TMOUT': '86400', 02:02:39 INFO - 'USER': 'cltbld', 02:02:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', 02:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:39 INFO - '_': '/tools/buildbot/bin/python'} 02:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:39 INFO - Downloading/unpacking flake8 02:02:39 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 02:02:39 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 02:02:39 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 02:02:39 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 02:02:39 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 02:02:39 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 02:02:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:02:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:02:41 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 02:02:41 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 02:02:41 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 02:02:41 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 02:02:41 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 02:02:41 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 02:02:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:02:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:02:41 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 02:02:41 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 02:02:41 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 02:02:41 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 02:02:41 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 02:02:41 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 02:02:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:02:41 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 02:02:41 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 02:02:41 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 02:02:41 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 02:02:41 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 02:02:41 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 02:02:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:02:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:02:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:02:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:02:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:02:41 INFO - no previously-included directories found matching 'docs/_build' 02:02:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:02:41 INFO - Running setup.py install for pep8 02:02:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:02:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:02:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:02:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:02:41 INFO - no previously-included directories found matching 'docs/_build' 02:02:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:02:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:02:42 INFO - Cleaning up... 02:02:42 INFO - Return code: 0 02:02:42 INFO - Running post-action listener: _resource_record_post_action 02:02:42 INFO - Running post-action listener: _start_resource_monitoring 02:02:42 INFO - Starting resource monitoring. 02:02:42 INFO - ##### 02:02:42 INFO - ##### Finished create-virtualenv step (success) 02:02:42 INFO - ##### 02:02:42 INFO - ##### 02:02:42 INFO - ##### Running install step. 02:02:42 INFO - ##### 02:02:42 INFO - Running pre-action listener: _resource_record_pre_action 02:02:42 INFO - Running main action method: install 02:02:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:42 INFO - Reading from file tmpfile_stdout 02:02:42 INFO - Detecting whether we're running mozinstall >=1.0... 02:02:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:02:42 INFO - Reading from file tmpfile_stdout 02:02:42 INFO - Output received: 02:02:42 INFO - Usage: mozinstall [options] installer 02:02:42 INFO - Options: 02:02:42 INFO - -h, --help show this help message and exit 02:02:42 INFO - -d DEST, --destination=DEST 02:02:42 INFO - Directory to install application into. [default: 02:02:42 INFO - "/builds/slave/test"] 02:02:42 INFO - --app=APP Application being installed. [default: firefox] 02:02:42 INFO - mkdir: /builds/slave/test/build/application 02:02:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:02:58 INFO - Reading from file tmpfile_stdout 02:02:58 INFO - Output received: 02:02:58 INFO - /builds/slave/test/build/application/firefox/firefox 02:02:58 INFO - Running post-action listener: _resource_record_post_action 02:02:58 INFO - ##### 02:02:58 INFO - ##### Finished install step (success) 02:02:58 INFO - ##### 02:02:58 INFO - ##### 02:02:58 INFO - ##### Running run-tests step. 02:02:58 INFO - ##### 02:02:58 INFO - Running pre-action listener: _resource_record_pre_action 02:02:58 INFO - Running main action method: run_tests 02:02:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:02:58 INFO - Python 2.7.3 02:02:58 INFO - Return code: 0 02:02:58 INFO - grabbing minidump binary from tooltool 02:02:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:58 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 0x23df6f0>, '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 0x23e05f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e0aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:02:58 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 02:02:58 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 02:02:58 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 02:02:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:02:58 INFO - Return code: 0 02:02:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:02:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:02:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:02:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:02:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:02:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:02:59 INFO - Return code: 0 02:02:59 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/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 02:02:59 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/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 02:02:59 INFO - Using env: {'DISPLAY': ':0', 02:02:59 INFO - 'HOME': '/home/cltbld', 02:02:59 INFO - 'LANG': 'en_US.UTF-8', 02:02:59 INFO - 'LANGUAGE': 'en_US:en', 02:02:59 INFO - 'LOGNAME': 'cltbld', 02:02:59 INFO - 'MAIL': '/var/mail/cltbld', 02:02:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:02:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:59 INFO - 'MOZ_NO_REMOTE': '1', 02:02:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:59 INFO - 'NO_EM_RESTART': '1', 02:02:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:59 INFO - 'PWD': '/builds/slave/test', 02:02:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:02:59 INFO - 'SHELL': '/bin/bash', 02:02:59 INFO - 'SHLVL': '1', 02:02:59 INFO - 'TERM': 'linux', 02:02:59 INFO - 'TMOUT': '86400', 02:02:59 INFO - 'USER': 'cltbld', 02:02:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372', 02:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:59 INFO - '_': '/tools/buildbot/bin/python'} 02:02:59 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/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 02:02:59 INFO - mozversion application_buildid: 20160627004823 02:02:59 INFO - mozversion application_changeset: f5a2832bb5f9a9f5d31df70ca6557f3be6f9468e 02:02:59 INFO - mozversion application_display_name: Nightly 02:02:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:02:59 INFO - mozversion application_name: Firefox 02:02:59 INFO - mozversion application_remotingname: firefox 02:02:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:02:59 INFO - mozversion application_vendor: Mozilla 02:02:59 INFO - mozversion application_version: 50.0a1 02:02:59 INFO - mozversion platform_buildid: 20160627004823 02:02:59 INFO - mozversion platform_changeset: f5a2832bb5f9a9f5d31df70ca6557f3be6f9468e 02:02:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:02:59 INFO - mozversion platform_version: 50.0a1 02:02:59 INFO - using testdate: 1467018179 02:02:59 INFO - actual date: 1467018179 02:02:59 INFO - starting webserver on 'localhost:53236' 02:02:59 INFO - SUITE-START | Running 2 tests 02:02:59 INFO - TEST-START | dromaeo_css 02:02:59 INFO - operating with platform_type : linux_ 02:02:59 INFO - Initialising browser for dromaeo_css test... 02:02:59 INFO - TEST-INFO | started process 1247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOuhYUi/profile http://localhost:53236/getInfo.html) 02:03:04 INFO - PROCESS | 1247 | __metrics Screen width/height:1600/1200 02:03:04 INFO - PROCESS | 1247 | colorDepth:24 02:03:04 INFO - PROCESS | 1247 | Browser inner width/height: 1024/697 02:03:04 INFO - PROCESS | 1247 | __metrics 02:03:05 INFO - PROCESS | 1247 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:03:06 INFO - TEST-INFO | 1247: exit 0 02:03:06 INFO - Browser initialized. 02:03:06 INFO - Running cycle 1/1 for dromaeo_css test... 02:03:06 INFO - TEST-INFO | started process 1339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOuhYUi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:03:18 INFO - PROCESS | 1339 | RSS: Main: 176136192 02:03:18 INFO - PROCESS | 1339 | 02:04:09 INFO - PROCESS | 1339 | 1467018249100 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] 02:06:22 INFO - PROCESS | 1339 | Cycle 1(1): loaded http://localhost:53236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53236/tests/dromaeo/cssquery-ext.html) 02:06:23 INFO - PROCESS | 1339 | RSS: Main: 284266496 02:06:23 INFO - PROCESS | 1339 | 02:09:26 INFO - PROCESS | 1339 | Cycle 1(1): loaded http://localhost:53236/tests/dromaeo/cssquery-ext.html (next: http://localhost:53236/tests/dromaeo/cssquery-jquery.html) 02:09:27 INFO - PROCESS | 1339 | RSS: Main: 257224704 02:09:27 INFO - PROCESS | 1339 | 02:12:29 INFO - PROCESS | 1339 | Cycle 1(1): loaded http://localhost:53236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53236/tests/dromaeo/cssquery-mootools.html) 02:12:30 INFO - PROCESS | 1339 | RSS: Main: 258981888 02:12:30 INFO - PROCESS | 1339 | 02:15:32 INFO - PROCESS | 1339 | Cycle 1(1): loaded http://localhost:53236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53236/tests/dromaeo/cssquery-prototype.html) 02:15:32 INFO - PROCESS | 1339 | RSS: Main: 256675840 02:15:32 INFO - PROCESS | 1339 | 02:18:35 INFO - PROCESS | 1339 | Cycle 1(1): loaded http://localhost:53236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53236/tests/dromaeo/cssquery-yui.html) 02:18:36 INFO - PROCESS | 1339 | RSS: Main: 237416448 02:18:36 INFO - PROCESS | 1339 | 02:21:39 INFO - PROCESS | 1339 | Cycle 1(1): loaded http://localhost:53236/tests/dromaeo/cssquery-yui.html (next: http://localhost:53236/tests/dromaeo/cssquery-dojo.html) 02:21:39 INFO - PROCESS | 1339 | RSS: Main: 290631680 02:21:39 INFO - PROCESS | 1339 | 02:21:39 INFO - PROCESS | 1339 | __start_tp_report 02:21:39 INFO - PROCESS | 1339 | _x_x_mozilla_page_load 02:21:39 INFO - PROCESS | 1339 | _x_x_mozilla_page_load_details 02:21:39 INFO - PROCESS | 1339 | |i|pagename|runs| 02:21:39 INFO - PROCESS | 1339 | |0;dojo.html;2628.973710262897;2644.6165306030625;2650.085720426453;2656.428867793425;2675.2643023168625;4683.859484215471;4743.928841067383;4767.928481072778;4805.399325084364;4835.419749630045;4672;4681.625469962403;4704.623630109583;4806.7115973041555;4845.103655823675;4354.238008348534;4441.578050085237;4453.799579018952;4477.417935668374;4614.746188959606;4461.799219035135;4545.636349092081;4564.520725323843;4604.033153037849;4622.3528705981025;4357.085012147453;4512.34570987205;4539.523350048247;4569.063342014879;4569.314602809589;4388;4412.183746006999;4458.041521072985;4459.152760975404;4462.0183559616835;4390.078083602447;4404.779761011937;4414.867553973386;4459.643228541741;4499.437570303712;4866.294387313819;4886.14492463821;4897.779599917976;4898.583620392271;4908.950910490885;5036.420811606676;5090.083784918713;5172.689638621657;5202.583793296565;5229.895402091937;5093.134167191549;5195.714235717034;5196.038732834438;5223.059849227137;5249.737513124329;4829.203181475087;4855.198892182821;4874.171390863562;4875.926861097087;4878.414590249193;5123.795048198105;5196.92204616931;5256.658317209446;5311.867203319871;5343.225232341289;5029.4719054498755;5039.496050395004;5044.066847633199;5083.542481176712;5101.69389836611;5146.897062058738;5147.897042059138;5148.253503242009;5185.248139019821;5198.584113270929;4986.975065124724;5073.391193056783;5089.694618322913;5095.847124586268;5127.07712611726;5092.363454568179;5102.821401250939;5108.821191258288;5109.8722531936255;5152.948470515322;4354.629856462173;4360;4364.585364390377;4366.017646029618;4409.030013397048;3734.477173195755;3764.416515440111;3770.4155855842387;3790.1472168761807;3835.002899246216;4398.538153493901;4413.293872980308;4413.646908247332;4448.266036104006;4460.799264033127;5139.820106296336;5144.485551444825;5146.382434107856;5147.176451767699;5148.0476111919415;4341.327094300388;4356.695031347838;4394.428724265825;4409.691321607456;4414.183376075436;4597.7241365518175;4599.770011499411;4605.746683932349;4606.124836281163;4631.409139340608;4697.224957881911;4802.759862006886;4805.543473370024;4810.326554282473;4836.806527738851;5094.872628184325;5107.029664363759;5109.6678715883345;5155.072087024371;5163.922541161961;4795.904081918412;4821.132196204717;4822.42130944289;4838.443578988461;4879.438864530624;4915.827946021872;5055.014272216882;5094.5160209780015;5098.46466121052;5154.201098829687;5155.793768249378;5172.793088276578;5195.870103247449;5195.948040519697;5248.58011359098;5046.318746969259;5058.898822023465;5063.468335824686;5063.797448102035;5110.97444512775;4884.535969083074;4958.7024778513405;5006.324146240357;5041.294218809297;5044.924326135184;4990.451050384382;4999.900002000012;5010;5010.899782004267;5012.924806127984;5051.797928082836;5053.393592768891;5056.595472362275;5058.468860769566;5118.641695081308;4789.353437285922;4830.758462076952;4858.1012512685265;4967.329410529533;4972.975135124301 02:21:39 INFO - PROCESS | 1339 | |1;ext.html;537.3612630920744;588.4850755588857;588.988220235595;598.4703537369428;599.4125756758376;26318;29073.127806165823;29142.562861557068;43727.56272437282;44528.33207501882;41144;41432;41612.791936040354;41652.375214371736;41722.79138604303;7825.882611760814;7991.160928102553;8006.9199308006755;8009.479383840061;8009.599520023976;7838.216178382173;7870.016247969004;7871.48835325702;7876.921230787705;7942.960285198595;7912.723054693087;7950.6483897737235;7954.204579542057;7983.800404989893;8017.799555011113;7861.017372828396;7913.050433947963;7916.406269529751;7921.722739704141;7938.801529961739;7875.684972601089;7948.284654381076;7990.840183196362;7991.041075070971;7999.200079992012;38685.226295473934;39097.80451097755;39153.60846391528;39174.41238381426;39182;2976.79162458628;3016.592759977397;3044.4215599036334;3210.6949839765184;3416.231347946717;28882;29260.561091583644;29956.655480984376;30286.84856575725;31006.844965775254;3338.7829791063505;3366.5791776027995;3370.275390790992;3403.268297316064;3405.267867408519;215624;269689;270618.999999998;270878;275134;31357.216069597987;32247.67752322494;54398.18402723962;55151;55236;33402.49896251558;33439.16402089919;33520.32959340848;33526.66473335236;33542.49686254708;13014.284214368112;13200.075994680281;13200.471981120647;13208.33958302081;13212.867871321356;10353.4305613192;10403.687889363331;10427.843582346271;10435.530401131968;10435.634752783617;7724.6137693115115;7806.180351063056;7823.178566250575;7881;7896.131425543185;3088.3977624363033;3142.324400253911;3159.036493869346;3162.5888634477833;3169.4770362889867;804.1355542791406;842.3219308456629;842.4103127810557;872.7338161860566;895.0333639669271;27599.17202483929;27654;27765.44469110647;27972.720272797418;28340.574891376647;811.7118422959883;932.6362718539775;934.9906500934903;954.6897258390911;958.8849338079475;14447.711045779026;14540.49108281205;14663.48677796272;14901.627459313604;15090.698186036218;380427;381268;382311;384018;385574;49364.75317623389;49905;49919.50080499148;49944.750276248385;50010.49989500131;1066.2269854355686;1160.6634076118;1165.6211731187398;1166.6383421139474;1195.043964828134;27614.723852761213;28579;29421.26446838846;29517.704822951495;29699.406011879208;39261;39674;39703.2059358817;39726.404103937886;39733;291939;296316;298894;298944;300532;22263.332100037023;22887.885560572755;22926.082956681545;24097.397565061015;24190.153344632854;38646.61353386543;41815.1636967265;42697;42704;42755.14489710251;36226.27547449089;36294.81852590826;36776.44835327526;37089.443658345685;37100.443493347084;35587.46618800772;36497.27005459929;36566.817165914;36642.45036324511;36790.8160459196;35257.29485410329;35676.28647427089;36023.27953440969;36080.819595901856;36304.455433168;32436.351272973938;32910.50634240536;32950.67049329572;33254.16864578405;33332.1666958328;25399.746002540476;25499.362515936507;25563.488730225665;25657.871710641328;25967.74032259653 02:21:39 INFO - PROCESS | 1339 | |2;jquery.html;371.12044454642495;373.12502182382315;377.4828484975584;384.08204391504324;385.11807959772125;15890.284937177827;17251.137443127842;17676.204570794314;17692.646147077085;17725.645487090267;15676.529704108867;16287.755683664755;17119.743203851922;17126.229319680613;17126.914365428187;4665.626749860012;4868.78090485929;4909.140900342443;4910.2143657014885;4910.75446227689;3521.8239088045625;3688.243909998457;4873.780679869415;5162.586993040548;5501.779928802843;5476.835694929158;5487.670739755607;5491.341039075317;5513.917291240635;5515.283013208297;5157.48425157485;5458.863528411802;5481.232627432163;5481.643693159932;5497.340319161686;3334.5998480182293;5081.491850814926;5302.337207849019;5434.864128396782;5448.591355648342;12519;13010;15411.306491207923;17003.574910627332;17009.319627214896;1835.164999925031;1844.4651051195272;1864.9720254196197;1910.551020510179;1956.7358406615067;8833;9378.718638440858;9711.36876103051;9725.708228753148;9820.459874706889;1623.375000624768;1744.1366523570787;1756.1219390304848;1757.6748301564123;1775.7070083436217;61098.389016109715;65136.3486365135;65893.3410665892;68302;70044;9697.175740062174;9979.750506237257;10087.285161522559;10110.595576177018;10251;14074.437022518985;14144.717105658036;14195.716085678228;14198;14199.92900035514;7037.331453511908;7154.105736782903;7173.605451700102;7175.497715159889;7192.964035179791;6610.669466526654;6668.33316668339;6676.499262555328;6776.220734615484;6795.490338224653;4448.354988526646;4465.486469056035;4500.684952053391;4532.456105267389;4573.748443835621;1706.48805358392;1708.1544635405553;1732.3330517750758;1748.9300427982992;1856.4801855480487;784.8391079828622;822.9547374894438;864.5893200729729;885.8848349714495;900.522722956834;16297.185140742915;16624.584385390463;16867.831321686626;17220.397286094925;17417.39039133624;818.9467684600481;834.4534330013851;894.9955250223837;896.802768304308;939.7462685075128;7037.894431583531;9373.20327772147;9683.467409292556;9701.563429645683;9815.460149691693;400662;401865;419824;420740;421824;72928;74678;74817;75501.24498754942;76242.61878690572;878.021006577674;897.6364572348209;920.9033051529627;924.4037595750704;927.3045216087934;14905.776413353591;15034.17312047804;15155.924220378827;15183.633472987483;15315;34537.65462345345;34649.48025779565;36503.634963651086;36720.63279367172;36780.632193677724;48047;48198;48305.27542086801;48382.5161748378;48905;6996.440284777307;7068.187158476841;7106.4314854810455;7199.388052015637;7204.675789589376;9141.177294043568;10674.02530531854;10803.729906752395;10816.459177040959;10865.348079115278;9295.907040929504;9303.395279306824;9347.158755712018;9366.718998430058;9457.810843783223;9851.45816980073;10315.432651204255;10418.062374386342;10540.736481588021;10699.090577301016;9709.36889102206;9963.601455941682;10053.984792876343;10112.79774404493;10453.26827122094;7828.921710782819;7891.171427000312;7933.801654958672;7940.054686601819;8037.839243214986;9595.184409325006;9949.850752238577;9959.601615935282;10139.39163650154;10270.281080324306 02:21:39 INFO - PROCESS | 1339 | |3;mootools.html;1238.566501724396;1373.9175649461033;1413.2721648351098;1495.8578935001171;1704.6505466379394;6853.143357080365;7544.962275188624;7746.147923728386;7752.57360845154;7968.72109476167;7755.185705500926;7765.572893490856;7765.805854853632;7782.610869456518;7827.608619569027;2181.727284089489;2206.8013878750908;2209.3482422685265;2209.4586826227596;2209.823214142865;2127.4681329667583;2170.479085019592;2189.1462329691435;2189.343197040889;2192.8574642648255;2184.563087382522;2188.6388745856916;2194.0236594715357;2199.5490924360547;2231.4979129695853;2130.8828014459277;2131.9467013324634;2135.7970992755663;2136;2143.5391390850964;2097.590969760897;2152.806247437738;2157.13714514194;2160.8487405881597;2161.8162456191244;7786.961065194694;7830.725924592669;7863.292303692638;7867.6459559319965;7871.291583757432;4486.439195100613;4694.225452800284;4699;4700.4594471635855;4705.835295764666;2871.239121632769;2901.419716056797;2953.4979053560946;2993.386355797078;2998.865051072707;1011.5397494140149;1016.2022812092546;1027.1628622672497;1033.1579762493618;1034.9534270957824;10875.510602022929;10997.12023038155;11008.229423940327;11017.394043327613;11036.337819730841;4132.483439570054;4245.172191422643;4267.466566679165;4268.637165840938;4311.439512863308;8059.677612895536;8084.717034903751;8085.959570202229;8103.392245581487;8106.959465202636;4672.509386514435;4679.181143299909;4680.906381872412;4681.9297710534365;4683.016566521001;3571.357155711945;4179.477565304337;4245.405643209953;4306.181825453154;4345;3358.7984720916334;3364.360771453416;3389.7796793154444;3420.8973730788116;3423.2126610879636;1025.553884060436;1035.539185062655;1040.7190058684114;1057.9047885690325;1064.4571268652887;580.3616022375438;670.8993650952299;796.1361922314238;802.3941923847575;805.1304591041661;5286.97356513215;5324.41431442541;5446.618736688473;5499.835004949778;5580.91628625571;455.3147512992924;456.39299731357215;462.10351917280366;466.9836555720601;612.1063247658468;3406.880759173417;3514.857671256852;3547.858085676544;3568.964310356915;3576.2311103112957;9424.434533927986;9778.364406313567;9837.655682051094;9908;9924.156446701967;9738.853917191247;9842.950785246028;9858.753531161778;9859.211263098934;9887.604495820231;7284.599347035964;7526.134494533089;7589.279018493235;7591.4685971981435;7593.810154746176;5044.672096313728;5113.079645663667;5249.055170069424;5272.762725677277;5440.836774896759;9082.45505269686;9107.134822191882;9179.495127768037;9235.12266334697;9261.67584134579;8438.873416898628;8779.429337093068;8783.956080219557;9105.089491050841;9133.588988495667;6217.533684973736;6434.227892652724;6437.130987316652;6913.239543650094;7051.929480705127;7094.467914906506;7192.532485388642;7301;7490.288422599844;7502.3622992046285;6764.797056088325;6848.589084654936;6892;7002.4398048157045;7002.75490357835;6725.663716814238;6803.115594972622;6822.897656535057;6867.3476019778045;6930.341617546325;5955.434233747787;6112.297085835008;6164.260288765377;6189.876202475835;6257.7184026719815;4464.955350446454;4491.663125265683;4496.505384407778;4581.496035436033;4648.372469716545;4518.774061296987;4541.977290113528;4578.313253011942;4630.3517507548295;4641.16459037363 02:21:39 INFO - PROCESS | 1339 | |4;prototype.html;277.97498225159734;290.90981795643364;294.9100524340075;297.1708932079498;304.5523081070826;4622.39908811854;4756.453007904092;4789.736564488951;4871.878203044921;4881.975590122049;4640.466346370168;4759.643026772988;4776.880577985552;4787.281907713845;4804.183288840897;3779.6960048783126;3784.829682664273;3797.2405518896194;3803.695704343646;3809.466674665549;3569.4824250483666;3637.5998640149564;3775.7356985010924;3776.3957766757326;3778.2254637799183;3737.738358314919;3753.4557489164054;3754.5119134512474;3763.322601931665;3773.1511559336004;3717.646823551758;3743.5320584926885;3751.624837516254;3763.266163098197;3776.6412190841825;3333.4833100869405;3351.8938750212374;3355.902560899438;3365.5456513370627;3375.594928608583;4592.609628181575;4644.326572646981;4647.419072615923;4654.5338218461075;4664.416947881515;4252.489701235841;4269.316909294529;4270.167317373113;4271.530131685512;4295.2912769393015;4943.629227807929;4982.202847544376;4997.750112494397;5014.473480284591;5085.7622646036;3412.812295323756;3571.392863213234;3591.0842735102383;3678.7608805427562;3688.870889518854;5203.245529398216;5246.7638956247065;5247.763850626731;5291.126964050927;5305.840824775224;3618.149734812317;3620.6198349173483;3626.32912911107;3636.818159092035;3656.2504686539196;3660.890173294805;3694.4667962795675;3701.333759923186;3707.35121353762;3714.9071273218387;4057.4928133983253;4225.91548169041;4244.129953359554;4261.424707664488;4266.2960611499375;4988.551030407209;4994.725290109079;5008.5993120550265;5033.395992480852;5039.143345631178;1210.8183772434206;1227.4292454008928;1250.3123282194938;1259.2633309514038;1264.4310060472824;787.2560430393223;817.5217497763756;819.4141189049858;836.2473773603805;837.2213841127809;3960.0199900049975;4030.1738143680477;4038.0106873816103;4039.5960403959957;4047.291723948297;4581.106684196549;4614.74618895964;4638.884027899262;4688.476245220317;4704.811807527729;4076.3681629347498;4087.2642924273914;4096.057906681421;4101.610347017028;4104.671626269891;2380.535795519857;2430.6718592990073;2443.841150325223;2453.77915987562;2494.6881639795024;4306.354046892991;4315.619001919418;4319.092990472036;4348.260795664682;4406.27296496081;4651.116287905287;4651.81378748417;4685.9531404686195;4703.929441058387;4725.362076119749;4125.793710314532;4387.824487020547;4394.274944634163;4418.4035155254915;4421.44731908505;4523.638108951342;4579.290210017452;4589.4722106958125;4638.350630911607;4655.3249778782565;4446.466424029137;4523.751193684379;4530.501644819134;4537.750423726727;4541.704789188692;4098.090282051404;4369.541198174146;4377.562243775597;4387.868363949086;4407.636439924388;3284.802911825298;3290.276139249361;3314.2045908982154;3391.4404123319378;3412.2322477442376;4533.325338050566;4533.501314855429;4540.728595993127;4579.633629309714;4965.602751779921;4863.076015557032;5049.621278404061;5066.670666406671;5068.150125204347;5081.974590127025;5019.071471777733;5034.572061374824;5086.059079070384;5111.693298402108;5114.5652619527755;4832.710037397767;4937.728424936663;4968.205087186033;5034.14419548685;5048.772805223847;5077.8730531737;5094.847154585368;5099.209622508517;5133.204353325241;5140.691558506502;4977.502249774993;4980.850574482772;4985.130576033987;5005.524475174852;5016.849494515171 02:21:39 INFO - PROCESS | 1339 | |5;yui.html;655.0098798982647;656.6953619027274;725.6335550546976;731.4441024821136;760.4334770595905;11463.140264480166;12139.271643701362;12211.877881221186;12223.511059557619;13186.274754888478;12632;12772.68068298293;12792.616221513346;12793.040521960867;12803.295818729966;625.4527288622455;765.663108232376;785.8664027115404;790.608648718885;802.891609632698;794.8688466403037;795.5306369242146;798.4889670610813;799.0970203669874;799.6201804143014;807.0879905706544;807.6002378822491;808.6239898447221;809.0049239435498;810.7486679129489;658.4567731621431;808.0747544062045;815.7919730468752;835.4110352201683;836.8242669039448;616.0451300484276;616.2358675242712;616.4513582911212;616.4944745308849;616.9969150154266;12166.904978551973;12211.877881221162;12219.938900305531;12229.205101668453;12250.75498490034;12629.305388203646;12947.87052129476;13074.607761767162;13308.800367994489;13387.397567109503;10708.25042247043;10864.185186110994;10890.891091089146;11491.65525034242;11616.070714342917;4223.68322375823;4304.504981927087;4324.589164029412;4340.045190058182;4474.127545128701;58948.41051589472;59111.11333330003;59737;59880.70059649674;59975;10239.48802559869;10364;10367.118794902366;10665.680029599125;10679.199060070527;15671.764923526156;15738.763918541232;15759.054456732632;15766.211689415484;15774.447894323643;6681.164854393201;6689.5986240825705;6759.695813688396;6805.591664500146;6810.727570897207;3716.0524066362905;3725.3480640887738;3823.847046118124;3901.317269477887;3913.354296541039;2607.074488556573;2688;2695.191442567222;2703.094463354759;2703.432279221346;510.97700603472936;539.9757010934518;569.3395661033264;576.4264556766045;583.9416058394212;564.7994961788506;573.3609946179373;577;627.1877918095986;628.632250133677;8161.878591056708;8412.8317433651;8430.241278284984;8447.704330348408;8739.217349464521;541.2882060090968;594.9974293315777;596.5704692621306;598.2641351138125;600.5075837813039;4026.3356546169553;4080;4234.915301693949;4276.3157894737315;4364.1271745650365;99769;100957.49521252347;103656;103773.48113259385;105569.47215263874;88312.55843720741;90654.54672726594;90878.54560727286;91265.54367228254;91767.54116229377;48767;72477.6376118116;74822;78638.6068069656;81496.59251703823;8178.427510074238;8342.29090527312;8377.45546539473;8728.738137855875;8893.110688931056;36689.63310366969;42201;42703.35944960766;45128.77435612801;47530;63354;66378.69834318318;66599.66700166468;67841.66079169573;68489.65755171391;10702.250842440955;10712.571497140027;10938.289011214245;10990.560377584807;11028.393438360967;12306.323152226356;12604.684882878002;13242.271675057964;13761.862381376459;14025.579232623038;11485.885141148481;11613.419329033684;11732.12009099338;12131.636050918487;12188.390580470763;12464.439100240692;12761;12893.355332233163;13003.284819335027;13478.86521134776;11307.830382544433;11357.829632555684;11500.25248358854;11539.769204616028;11920.821187682019;9367.156955874005;10021.248406369406;10427.739306517095;10650.573977041142;10751.784964300827;9473.952630236805;9796.040195005415;9910.851337229804;9956.20350371983;10021 02:21:39 INFO - PROCESS | 1339 | __end_tp_report 02:21:39 INFO - PROCESS | 1339 | __start_cc_report 02:21:39 INFO - PROCESS | 1339 | _x_x_mozilla_cycle_collect,1005 02:21:39 INFO - PROCESS | 1339 | __end_cc_report 02:21:39 INFO - PROCESS | 1339 | __startTimestamp1467019299860__endTimestamp 02:21:39 INFO - PROCESS | 1339 | 02:21:39 INFO - PROCESS | 1339 | ------- Summary: start ------- 02:21:39 INFO - PROCESS | 1339 | Number of tests: 6 02:21:39 INFO - PROCESS | 1339 | 02:21:39 INFO - PROCESS | 1339 | [#0] dojo.html Cycles:165 Average:4759.09 Median:4878.41 stddev:502.17 (10.3%) stddev-sans-first:475.09 02:21:39 INFO - PROCESS | 1339 | Values: 2629.0 2644.6 2650.1 2656.4 2675.3 4683.9 4743.9 4767.9 4805.4 4835.4 4672.0 4681.6 4704.6 4806.7 4845.1 4354.2 4441.6 4453.8 4477.4 4614.7 4461.8 4545.6 4564.5 4604.0 4622.4 4357.1 4512.3 4539.5 4569.1 4569.3 4388.0 4412.2 4458.0 4459.2 4462.0 4390.1 4404.8 4414.9 4459.6 4499.4 4866.3 4886.1 4897.8 4898.6 4909.0 5036.4 5090.1 5172.7 5202.6 5229.9 5093.1 5195.7 5196.0 5223.1 5249.7 4829.2 4855.2 4874.2 4875.9 4878.4 5123.8 5196.9 5256.7 5311.9 5343.2 5029.5 5039.5 5044.1 5083.5 5101.7 5146.9 5147.9 5148.3 5185.2 5198.6 4987.0 5073.4 5089.7 5095.8 5127.1 5092.4 5102.8 5108.8 5109.9 5152.9 4354.6 4360.0 4364.6 4366.0 4409.0 3734.5 3764.4 3770.4 3790.1 3835.0 4398.5 4413.3 4413.6 4448.3 4460.8 5139.8 5144.5 5146.4 5147.2 5148.0 4341.3 4356.7 4394.4 4409.7 4414.2 4597.7 4599.8 4605.7 4606.1 4631.4 4697.2 4802.8 4805.5 4810.3 4836.8 5094.9 5107.0 5109.7 5155.1 5163.9 4795.9 4821.1 4822.4 4838.4 4879.4 4915.8 5055.0 5094.5 5098.5 5154.2 5155.8 5172.8 5195.9 5195.9 5248.6 5046.3 5058.9 5063.5 5063.8 5111.0 4884.5 4958.7 5006.3 5041.3 5044.9 4990.5 4999.9 5010.0 5010.9 5012.9 5051.8 5053.4 5056.6 5058.5 5118.6 4789.4 4830.8 4858.1 4967.3 4973.0 02:21:39 INFO - PROCESS | 1339 | 02:21:39 INFO - PROCESS | 1339 | [#1] ext.html Cycles:180 Average:45623.20 Median:36260.55 stddev:83826.99 (231.2%) stddev-sans-first:83993.80 02:21:39 INFO - PROCESS | 1339 | Values: 537.4 588.5 589.0 598.5 599.4 26318.0 29073.1 29142.6 43727.6 44528.3 41144.0 41432.0 41612.8 41652.4 41722.8 7825.9 7991.2 8006.9 8009.5 8009.6 7838.2 7870.0 7871.5 7876.9 7943.0 7912.7 7950.6 7954.2 7983.8 8017.8 7861.0 7913.1 7916.4 7921.7 7938.8 7875.7 7948.3 7990.8 7991.0 7999.2 38685.2 39097.8 39153.6 39174.4 39182.0 2976.8 3016.6 3044.4 3210.7 3416.2 28882.0 29260.6 29956.7 30286.8 31006.8 3338.8 3366.6 3370.3 3403.3 3405.3 215624.0 269689.0 270619.0 270878.0 275134.0 31357.2 32247.7 54398.2 55151.0 55236.0 33402.5 33439.2 33520.3 33526.7 33542.5 13014.3 13200.1 13200.5 13208.3 13212.9 10353.4 10403.7 10427.8 10435.5 10435.6 7724.6 7806.2 7823.2 7881.0 7896.1 3088.4 3142.3 3159.0 3162.6 3169.5 804.1 842.3 842.4 872.7 895.0 27599.2 27654.0 27765.4 27972.7 28340.6 811.7 932.6 935.0 954.7 958.9 14447.7 14540.5 14663.5 14901.6 15090.7 380427.0 381268.0 382311.0 384018.0 385574.0 49364.8 49905.0 49919.5 49944.8 50010.5 1066.2 1160.7 1165.6 1166.6 1195.0 27614.7 28579.0 29421.3 29517.7 29699.4 39261.0 39674.0 39703.2 39726.4 39733.0 291939.0 296316.0 298894.0 298944.0 300532.0 22263.3 22887.9 22926.1 24097.4 24190.2 38646.6 41815.2 42697.0 42704.0 42755.1 36226.3 36294.8 36776.4 37089.4 37100.4 35587.5 36497.3 36566.8 36642.5 36790.8 35257.3 35676.3 36023.3 36080.8 36304.5 32436.4 32910.5 32950.7 33254.2 33332.2 25399.7 25499.4 25563.5 25657.9 25967.7 02:21:39 INFO - PROCESS | 1339 | 02:21:39 INFO - PROCESS | 1339 | [#2] jquery.html Cycles:180 Average:24418.48 Median:26889.39 stddev:67983.06 (252.8%) stddev-sans-first:68149.79 02:21:39 INFO - PROCESS | 1339 | Values: 371.1 373.1 377.5 384.1 385.1 15890.3 17251.1 17676.2 17692.6 17725.6 15676.5 16287.8 17119.7 17126.2 17126.9 4665.6 4868.8 4909.1 4910.2 4910.8 3521.8 3688.2 4873.8 5162.6 5501.8 5476.8 5487.7 5491.3 5513.9 5515.3 5157.5 5458.9 5481.2 5481.6 5497.3 3334.6 5081.5 5302.3 5434.9 5448.6 12519.0 13010.0 15411.3 17003.6 17009.3 1835.2 1844.5 1865.0 1910.6 1956.7 8833.0 9378.7 9711.4 9725.7 9820.5 1623.4 1744.1 1756.1 1757.7 1775.7 61098.4 65136.3 65893.3 68302.0 70044.0 9697.2 9979.8 10087.3 10110.6 10251.0 14074.4 14144.7 14195.7 14198.0 14199.9 7037.3 7154.1 7173.6 7175.5 7193.0 6610.7 6668.3 6676.5 6776.2 6795.5 4448.4 4465.5 4500.7 4532.5 4573.7 1706.5 1708.2 1732.3 1748.9 1856.5 784.8 823.0 864.6 885.9 900.5 16297.2 16624.6 16867.8 17220.4 17417.4 818.9 834.5 895.0 896.8 939.7 7037.9 9373.2 9683.5 9701.6 9815.5 400662.0 401865.0 419824.0 420740.0 421824.0 72928.0 74678.0 74817.0 75501.2 76242.6 878.0 897.6 920.9 924.4 927.3 14905.8 15034.2 15155.9 15183.6 15315.0 34537.7 34649.5 36503.6 36720.6 36780.6 48047.0 48198.0 48305.3 48382.5 48905.0 6996.4 7068.2 7106.4 7199.4 7204.7 9141.2 10674.0 10803.7 10816.5 10865.3 9295.9 9303.4 9347.2 9366.7 9457.8 9851.5 10315.4 10418.1 10540.7 10699.1 9709.4 9963.6 10054.0 10112.8 10453.3 7828.9 7891.2 7933.8 7940.1 8037.8 9595.2 9949.9 9959.6 10139.4 10270.3 02:21:39 INFO - PROCESS | 1339 | 02:21:39 INFO - PROCESS | 1339 | [#3] mootools.html Cycles:180 Average:5115.32 Median:4696.61 stddev:2907.87 (61.9%) stddev-sans-first:2901.43 02:21:39 INFO - PROCESS | 1339 | Values: 1238.6 1373.9 1413.3 1495.9 1704.7 6853.1 7545.0 7746.1 7752.6 7968.7 7755.2 7765.6 7765.8 7782.6 7827.6 2181.7 2206.8 2209.3 2209.5 2209.8 2127.5 2170.5 2189.1 2189.3 2192.9 2184.6 2188.6 2194.0 2199.5 2231.5 2130.9 2131.9 2135.8 2136.0 2143.5 2097.6 2152.8 2157.1 2160.8 2161.8 7787.0 7830.7 7863.3 7867.6 7871.3 4486.4 4694.2 4699.0 4700.5 4705.8 2871.2 2901.4 2953.5 2993.4 2998.9 1011.5 1016.2 1027.2 1033.2 1035.0 10875.5 10997.1 11008.2 11017.4 11036.3 4132.5 4245.2 4267.5 4268.6 4311.4 8059.7 8084.7 8086.0 8103.4 8107.0 4672.5 4679.2 4680.9 4681.9 4683.0 3571.4 4179.5 4245.4 4306.2 4345.0 3358.8 3364.4 3389.8 3420.9 3423.2 1025.6 1035.5 1040.7 1057.9 1064.5 580.4 670.9 796.1 802.4 805.1 5287.0 5324.4 5446.6 5499.8 5580.9 455.3 456.4 462.1 467.0 612.1 3406.9 3514.9 3547.9 3569.0 3576.2 9424.4 9778.4 9837.7 9908.0 9924.2 9738.9 9843.0 9858.8 9859.2 9887.6 7284.6 7526.1 7589.3 7591.5 7593.8 5044.7 5113.1 5249.1 5272.8 5440.8 9082.5 9107.1 9179.5 9235.1 9261.7 8438.9 8779.4 8784.0 9105.1 9133.6 6217.5 6434.2 6437.1 6913.2 7051.9 7094.5 7192.5 7301.0 7490.3 7502.4 6764.8 6848.6 6892.0 7002.4 7002.8 6725.7 6803.1 6822.9 6867.3 6930.3 5955.4 6112.3 6164.3 6189.9 6257.7 4465.0 4491.7 4496.5 4581.5 4648.4 4518.8 4542.0 4578.3 4630.4 4641.2 02:21:39 INFO - PROCESS | 1339 | 02:21:39 INFO - PROCESS | 1339 | [#4] prototype.html Cycles:180 Average:4020.18 Median:4400.27 stddev:1163.25 (26.4%) stddev-sans-first:1132.10 02:21:39 INFO - PROCESS | 1339 | Values: 278.0 290.9 294.9 297.2 304.6 4622.4 4756.5 4789.7 4871.9 4882.0 4640.5 4759.6 4776.9 4787.3 4804.2 3779.7 3784.8 3797.2 3803.7 3809.5 3569.5 3637.6 3775.7 3776.4 3778.2 3737.7 3753.5 3754.5 3763.3 3773.2 3717.6 3743.5 3751.6 3763.3 3776.6 3333.5 3351.9 3355.9 3365.5 3375.6 4592.6 4644.3 4647.4 4654.5 4664.4 4252.5 4269.3 4270.2 4271.5 4295.3 4943.6 4982.2 4997.8 5014.5 5085.8 3412.8 3571.4 3591.1 3678.8 3688.9 5203.2 5246.8 5247.8 5291.1 5305.8 3618.1 3620.6 3626.3 3636.8 3656.3 3660.9 3694.5 3701.3 3707.4 3714.9 4057.5 4225.9 4244.1 4261.4 4266.3 4988.6 4994.7 5008.6 5033.4 5039.1 1210.8 1227.4 1250.3 1259.3 1264.4 787.3 817.5 819.4 836.2 837.2 3960.0 4030.2 4038.0 4039.6 4047.3 4581.1 4614.7 4638.9 4688.5 4704.8 4076.4 4087.3 4096.1 4101.6 4104.7 2380.5 2430.7 2443.8 2453.8 2494.7 4306.4 4315.6 4319.1 4348.3 4406.3 4651.1 4651.8 4686.0 4703.9 4725.4 4125.8 4387.8 4394.3 4418.4 4421.4 4523.6 4579.3 4589.5 4638.4 4655.3 4446.5 4523.8 4530.5 4537.8 4541.7 4098.1 4369.5 4377.6 4387.9 4407.6 3284.8 3290.3 3314.2 3391.4 3412.2 4533.3 4533.5 4540.7 4579.6 4965.6 4863.1 5049.6 5066.7 5068.2 5082.0 5019.1 5034.6 5086.1 5111.7 5114.6 4832.7 4937.7 4968.2 5034.1 5048.8 5077.9 5094.8 5099.2 5133.2 5140.7 4977.5 4980.9 4985.1 5005.5 5016.8 02:21:39 INFO - PROCESS | 1339 | 02:21:39 INFO - PROCESS | 1339 | [#5] yui.html Cycles:180 Average:17956.21 Median:4419.13 stddev:26156.72 (591.9%) stddev-sans-first:26197.84 02:21:39 INFO - PROCESS | 1339 | Values: 655.0 656.7 725.6 731.4 760.4 11463.1 12139.3 12211.9 12223.5 13186.3 12632.0 12772.7 12792.6 12793.0 12803.3 625.5 765.7 785.9 790.6 802.9 794.9 795.5 798.5 799.1 799.6 807.1 807.6 808.6 809.0 810.7 658.5 808.1 815.8 835.4 836.8 616.0 616.2 616.5 616.5 617.0 12166.9 12211.9 12219.9 12229.2 12250.8 12629.3 12947.9 13074.6 13308.8 13387.4 10708.3 10864.2 10890.9 11491.7 11616.1 4223.7 4304.5 4324.6 4340.0 4474.1 58948.4 59111.1 59737.0 59880.7 59975.0 10239.5 10364.0 10367.1 10665.7 10679.2 15671.8 15738.8 15759.1 15766.2 15774.4 6681.2 6689.6 6759.7 6805.6 6810.7 3716.1 3725.3 3823.8 3901.3 3913.4 2607.1 2688.0 2695.2 2703.1 2703.4 511.0 540.0 569.3 576.4 583.9 564.8 573.4 577.0 627.2 628.6 8161.9 8412.8 8430.2 8447.7 8739.2 541.3 595.0 596.6 598.3 600.5 4026.3 4080.0 4234.9 4276.3 4364.1 99769.0 100957.5 103656.0 103773.5 105569.5 88312.6 90654.5 90878.5 91265.5 91767.5 48767.0 72477.6 74822.0 78638.6 81496.6 8178.4 8342.3 8377.5 8728.7 8893.1 36689.6 42201.0 42703.4 45128.8 47530.0 63354.0 66378.7 66599.7 67841.7 68489.7 10702.3 10712.6 10938.3 10990.6 11028.4 12306.3 12604.7 13242.3 13761.9 14025.6 11485.9 11613.4 11732.1 12131.6 12188.4 12464.4 12761.0 12893.4 13003.3 13478.9 11307.8 11357.8 11500.3 11539.8 11920.8 9367.2 10021.2 10427.7 10650.6 10751.8 9474.0 9796.0 9910.9 9956.2 10021.0 02:21:39 INFO - PROCESS | 1339 | -------- Summary: end -------- 02:21:39 INFO - PROCESS | 1339 | 02:21:40 INFO - TEST-INFO | 1339: exit 0 02:21:40 INFO - TEST-OK | dromaeo_css | took 1120917ms 02:21:40 INFO - TEST-START | kraken 02:21:40 INFO - operating with platform_type : linux_ 02:21:40 INFO - Initialising browser for kraken test... 02:21:40 INFO - TEST-INFO | started process 1521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv99odb/profile http://localhost:53236/getInfo.html) 02:21:44 INFO - PROCESS | 1521 | __metrics Screen width/height:1600/1200 02:21:44 INFO - PROCESS | 1521 | colorDepth:24 02:21:44 INFO - PROCESS | 1521 | Browser inner width/height: 1024/697 02:21:44 INFO - PROCESS | 1521 | __metrics 02:21:45 INFO - PROCESS | 1521 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:21:46 INFO - TEST-INFO | 1521: exit 0 02:21:46 INFO - Browser initialized. 02:21:46 INFO - Running cycle 1/1 for kraken test... 02:21:46 INFO - TEST-INFO | started process 1601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv99odb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:58 INFO - PROCESS | 1601 | RSS: Main: 175255552 02:21:58 INFO - PROCESS | 1601 | 02:22:01 INFO - PROCESS | 1601 | Cycle 1(1): loaded http://localhost:53236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53236/tests/kraken/driver.html?testName=audio-beat-detection) 02:22:02 INFO - PROCESS | 1601 | RSS: Main: 233070592 02:22:02 INFO - PROCESS | 1601 | 02:22:05 INFO - PROCESS | 1601 | Cycle 1(1): loaded http://localhost:53236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53236/tests/kraken/driver.html?testName=audio-dft) 02:22:06 INFO - PROCESS | 1601 | RSS: Main: 222261248 02:22:06 INFO - PROCESS | 1601 | 02:22:09 INFO - PROCESS | 1601 | Cycle 1(1): loaded http://localhost:53236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53236/tests/kraken/driver.html?testName=audio-fft) 02:22:09 INFO - PROCESS | 1601 | RSS: Main: 287879168 02:22:09 INFO - PROCESS | 1601 | 02:22:12 INFO - PROCESS | 1601 | Cycle 1(1): loaded http://localhost:53236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53236/tests/kraken/driver.html?testName=audio-oscillator) 02:22:12 INFO - PROCESS | 1601 | RSS: Main: 198242304 02:22:12 INFO - PROCESS | 1601 | 02:22:14 INFO - PROCESS | 1601 | Cycle 1(1): loaded http://localhost:53236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:22:15 INFO - PROCESS | 1601 | RSS: Main: 201904128 02:22:15 INFO - PROCESS | 1601 | 02:22:18 INFO - PROCESS | 1601 | Cycle 1(1): loaded http://localhost:53236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53236/tests/kraken/driver.html?testName=imaging-darkroom) 02:22:19 INFO - PROCESS | 1601 | RSS: Main: 238247936 02:22:19 INFO - PROCESS | 1601 | 02:22:22 INFO - PROCESS | 1601 | Cycle 1(1): loaded http://localhost:53236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53236/tests/kraken/driver.html?testName=imaging-desaturate) 02:22:23 INFO - PROCESS | 1601 | RSS: Main: 233893888 02:22:23 INFO - PROCESS | 1601 | 02:22:26 INFO - PROCESS | 1601 | Cycle 1(1): loaded http://localhost:53236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53236/tests/kraken/driver.html?testName=json-parse-financial) 02:22:26 INFO - PROCESS | 1601 | RSS: Main: 236634112 02:22:26 INFO - PROCESS | 1601 | 02:22:28 INFO - PROCESS | 1601 | Cycle 1(1): loaded http://localhost:53236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:22:29 INFO - PROCESS | 1601 | RSS: Main: 222568448 02:22:29 INFO - PROCESS | 1601 | 02:22:31 INFO - PROCESS | 1601 | Cycle 1(1): loaded http://localhost:53236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53236/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:22:31 INFO - PROCESS | 1601 | RSS: Main: 227876864 02:22:31 INFO - PROCESS | 1601 | 02:22:33 INFO - PROCESS | 1601 | Cycle 1(1): loaded http://localhost:53236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:22:34 INFO - PROCESS | 1601 | RSS: Main: 236118016 02:22:34 INFO - PROCESS | 1601 | 02:22:37 INFO - PROCESS | 1601 | Cycle 1(1): loaded http://localhost:53236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:22:37 INFO - PROCESS | 1601 | RSS: Main: 239042560 02:22:37 INFO - PROCESS | 1601 | 02:22:40 INFO - PROCESS | 1601 | Cycle 1(1): loaded http://localhost:53236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:22:41 INFO - PROCESS | 1601 | RSS: Main: 239697920 02:22:41 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | Cycle 1(1): loaded http://localhost:53236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53236/tests/kraken/driver.html?testName=ai-astar) 02:22:43 INFO - PROCESS | 1601 | RSS: Main: 281800704 02:22:43 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | __start_tp_report 02:22:43 INFO - PROCESS | 1601 | _x_x_mozilla_page_load 02:22:43 INFO - PROCESS | 1601 | _x_x_mozilla_page_load_details 02:22:43 INFO - PROCESS | 1601 | |i|pagename|runs| 02:22:43 INFO - PROCESS | 1601 | |0;ai-astar;103;112;112;114;113;114;112;112;112;112 02:22:43 INFO - PROCESS | 1601 | |1;audio-beat-detection;151;130;136;191;132;157;154;133;190;131 02:22:43 INFO - PROCESS | 1601 | |2;audio-dft;161;161;162;161;162;162;163;162;162;160 02:22:43 INFO - PROCESS | 1601 | |3;audio-fft;77;76;76;101;76;76;75;75;99;76 02:22:43 INFO - PROCESS | 1601 | |4;audio-oscillator;89;88;111;86;87;85;114;86;86;125 02:22:43 INFO - PROCESS | 1601 | |5;imaging-gaussian-blur;117;116;117;116;117;116;116;117;117;116 02:22:43 INFO - PROCESS | 1601 | |6;imaging-darkroom;146;146;146;145;146;147;147;147;147;147 02:22:43 INFO - PROCESS | 1601 | |7;imaging-desaturate;94;95;95;95;94;94;95;96;95;95 02:22:43 INFO - PROCESS | 1601 | |8;json-parse-financial;64;63;63;63;64;64;63;63;63;69 02:22:43 INFO - PROCESS | 1601 | |9;json-stringify-tinderbox;65;65;65;65;66;65;65;65;65;68 02:22:43 INFO - PROCESS | 1601 | |10;stanford-crypto-aes;81;82;84;83;84;85;83;84;92;89 02:22:43 INFO - PROCESS | 1601 | |11;stanford-crypto-ccm;136;140;135;130;129;131;127;128;144;132 02:22:43 INFO - PROCESS | 1601 | |12;stanford-crypto-pbkdf2;169;169;167;171;174;170;176;174;172;170 02:22:43 INFO - PROCESS | 1601 | |13;stanford-crypto-sha256-iterative;67;66;66;66;67;67;65;71;70;67 02:22:43 INFO - PROCESS | 1601 | __end_tp_report 02:22:43 INFO - PROCESS | 1601 | __start_cc_report 02:22:43 INFO - PROCESS | 1601 | _x_x_mozilla_cycle_collect,1893 02:22:43 INFO - PROCESS | 1601 | __end_cc_report 02:22:43 INFO - PROCESS | 1601 | __startTimestamp1467019363516__endTimestamp 02:22:43 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | ------- Summary: start ------- 02:22:43 INFO - PROCESS | 1601 | Number of tests: 14 02:22:43 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:3.13 (2.8%) stddev-sans-first:0.88 02:22:43 INFO - PROCESS | 1601 | Values: 103.0 112.0 112.0 114.0 113.0 114.0 112.0 112.0 112.0 112.0 02:22:43 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:152.50 stddev:23.37 (15.3%) stddev-sans-first:24.78 02:22:43 INFO - PROCESS | 1601 | Values: 151.0 130.0 136.0 191.0 132.0 157.0 154.0 133.0 190.0 131.0 02:22:43 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 02:22:43 INFO - PROCESS | 1601 | Values: 161.0 161.0 162.0 161.0 162.0 162.0 163.0 162.0 162.0 160.0 02:22:43 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | [#3] audio-fft Cycles:10 Average:80.70 Median:76.00 stddev:10.20 (13.4%) stddev-sans-first:10.73 02:22:43 INFO - PROCESS | 1601 | Values: 77.0 76.0 76.0 101.0 76.0 76.0 75.0 75.0 99.0 76.0 02:22:43 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:86.00 stddev:14.92 (17.4%) stddev-sans-first:15.63 02:22:43 INFO - PROCESS | 1601 | Values: 89.0 88.0 111.0 86.0 87.0 85.0 114.0 86.0 86.0 125.0 02:22:43 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:22:43 INFO - PROCESS | 1601 | Values: 117.0 116.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 116.0 02:22:43 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 02:22:43 INFO - PROCESS | 1601 | Values: 146.0 146.0 146.0 145.0 146.0 147.0 147.0 147.0 147.0 147.0 02:22:43 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 02:22:43 INFO - PROCESS | 1601 | Values: 94.0 95.0 95.0 95.0 94.0 94.0 95.0 96.0 95.0 95.0 02:22:43 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:63.50 stddev:1.85 (2.9%) stddev-sans-first:1.96 02:22:43 INFO - PROCESS | 1601 | Values: 64.0 63.0 63.0 63.0 64.0 64.0 63.0 63.0 63.0 69.0 02:22:43 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 02:22:43 INFO - PROCESS | 1601 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 68.0 02:22:43 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:3.33 (4.0%) stddev-sans-first:3.26 02:22:43 INFO - PROCESS | 1601 | Values: 81.0 82.0 84.0 83.0 84.0 85.0 83.0 84.0 92.0 89.0 02:22:43 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | [#11] stanford-crypto-ccm Cycles:10 Average:133.20 Median:133.50 stddev:5.51 (4.1%) stddev-sans-first:5.75 02:22:43 INFO - PROCESS | 1601 | Values: 136.0 140.0 135.0 130.0 129.0 131.0 127.0 128.0 144.0 132.0 02:22:43 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:171.50 stddev:2.78 (1.6%) stddev-sans-first:2.83 02:22:43 INFO - PROCESS | 1601 | Values: 169.0 169.0 167.0 171.0 174.0 170.0 176.0 174.0 172.0 170.0 02:22:43 INFO - PROCESS | 1601 | 02:22:43 INFO - PROCESS | 1601 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.87 (2.8%) stddev-sans-first:1.99 02:22:43 INFO - PROCESS | 1601 | Values: 67.0 66.0 66.0 66.0 67.0 67.0 65.0 71.0 70.0 67.0 02:22:43 INFO - PROCESS | 1601 | -------- Summary: end -------- 02:22:43 INFO - PROCESS | 1601 | 02:22:44 INFO - TEST-INFO | 1601: exit 0 02:22:44 INFO - TEST-OK | kraken | took 63825ms 02:22:44 INFO - SUITE-END | took 1184s 02:22:44 INFO - Completed test suite (00:19:44) 02:22:44 INFO - javascript benchmark 02:22:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2628.973710262897, 2644.6165306030625, 2650.085720426453, 2656.428867793425, 2675.2643023168625, 4683.859484215471, 4743.928841067383, 4767.928481072778, 4805.399325084364, 4835.419749630045, 4672.0, 4681.625469962403, 4704.623630109583, 4806.7115973041555, 4845.103655823675, 4354.238008348534, 4441.578050085237, 4453.799579018952, 4477.417935668374, 4614.746188959606, 4461.799219035135, 4545.636349092081, 4564.520725323843, 4604.033153037849, 4622.3528705981025, 4357.085012147453, 4512.34570987205, 4539.523350048247, 4569.063342014879, 4569.314602809589, 4388.0, 4412.183746006999, 4458.041521072985, 4459.152760975404, 4462.0183559616835, 4390.078083602447, 4404.779761011937, 4414.867553973386, 4459.643228541741, 4499.437570303712, 4866.294387313819, 4886.14492463821, 4897.779599917976, 4898.583620392271, 4908.950910490885, 5036.420811606676, 5090.083784918713, 5172.689638621657, 5202.583793296565, 5229.895402091937, 5093.134167191549, 5195.714235717034, 5196.038732834438, 5223.059849227137, 5249.737513124329, 4829.203181475087, 4855.198892182821, 4874.171390863562, 4875.926861097087, 4878.414590249193, 5123.795048198105, 5196.92204616931, 5256.658317209446, 5311.867203319871, 5343.225232341289, 5029.4719054498755, 5039.496050395004, 5044.066847633199, 5083.542481176712, 5101.69389836611, 5146.897062058738, 5147.897042059138, 5148.253503242009, 5185.248139019821, 5198.584113270929, 4986.975065124724, 5073.391193056783, 5089.694618322913, 5095.847124586268, 5127.07712611726, 5092.363454568179, 5102.821401250939, 5108.821191258288, 5109.8722531936255, 5152.948470515322, 4354.629856462173, 4360.0, 4364.585364390377, 4366.017646029618, 4409.030013397048, 3734.477173195755, 3764.416515440111, 3770.4155855842387, 3790.1472168761807, 3835.002899246216, 4398.538153493901, 4413.293872980308, 4413.646908247332, 4448.266036104006, 4460.799264033127, 5139.820106296336, 5144.485551444825, 5146.382434107856, 5147.176451767699, 5148.0476111919415, 4341.327094300388, 4356.695031347838, 4394.428724265825, 4409.691321607456, 4414.183376075436, 4597.7241365518175, 4599.770011499411, 4605.746683932349, 4606.124836281163, 4631.409139340608, 4697.224957881911, 4802.759862006886, 4805.543473370024, 4810.326554282473, 4836.806527738851, 5094.872628184325, 5107.029664363759, 5109.6678715883345, 5155.072087024371, 5163.922541161961, 4795.904081918412, 4821.132196204717, 4822.42130944289, 4838.443578988461, 4879.438864530624, 4915.827946021872, 5055.014272216882, 5094.5160209780015, 5098.46466121052, 5154.201098829687, 5155.793768249378, 5172.793088276578, 5195.870103247449, 5195.948040519697, 5248.58011359098, 5046.318746969259, 5058.898822023465, 5063.468335824686, 5063.797448102035, 5110.97444512775, 4884.535969083074, 4958.7024778513405, 5006.324146240357, 5041.294218809297, 5044.924326135184, 4990.451050384382, 4999.900002000012, 5010.0, 5010.899782004267, 5012.924806127984, 5051.797928082836, 5053.393592768891, 5056.595472362275, 5058.468860769566, 5118.641695081308, 4789.353437285922, 4830.758462076952, 4858.1012512685265, 4967.329410529533, 4972.975135124301], "value": 4726.434131778521, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.3612630920744, 588.4850755588857, 588.988220235595, 598.4703537369428, 599.4125756758376, 26318.0, 29073.127806165823, 29142.562861557068, 43727.56272437282, 44528.33207501882, 41144.0, 41432.0, 41612.791936040354, 41652.375214371736, 41722.79138604303, 7825.882611760814, 7991.160928102553, 8006.9199308006755, 8009.479383840061, 8009.599520023976, 7838.216178382173, 7870.016247969004, 7871.48835325702, 7876.921230787705, 7942.960285198595, 7912.723054693087, 7950.6483897737235, 7954.204579542057, 7983.800404989893, 8017.799555011113, 7861.017372828396, 7913.050433947963, 7916.406269529751, 7921.722739704141, 7938.801529961739, 7875.684972601089, 7948.284654381076, 7990.840183196362, 7991.041075070971, 7999.200079992012, 38685.226295473934, 39097.80451097755, 39153.60846391528, 39174.41238381426, 39182.0, 2976.79162458628, 3016.592759977397, 3044.4215599036334, 3210.6949839765184, 3416.231347946717, 28882.0, 29260.561091583644, 29956.655480984376, 30286.84856575725, 31006.844965775254, 3338.7829791063505, 3366.5791776027995, 3370.275390790992, 3403.268297316064, 3405.267867408519, 215624.0, 269689.0, 270618.999999998, 270878.0, 275134.0, 31357.216069597987, 32247.67752322494, 54398.18402723962, 55151.0, 55236.0, 33402.49896251558, 33439.16402089919, 33520.32959340848, 33526.66473335236, 33542.49686254708, 13014.284214368112, 13200.075994680281, 13200.471981120647, 13208.33958302081, 13212.867871321356, 10353.4305613192, 10403.687889363331, 10427.843582346271, 10435.530401131968, 10435.634752783617, 7724.6137693115115, 7806.180351063056, 7823.178566250575, 7881.0, 7896.131425543185, 3088.3977624363033, 3142.324400253911, 3159.036493869346, 3162.5888634477833, 3169.4770362889867, 804.1355542791406, 842.3219308456629, 842.4103127810557, 872.7338161860566, 895.0333639669271, 27599.17202483929, 27654.0, 27765.44469110647, 27972.720272797418, 28340.574891376647, 811.7118422959883, 932.6362718539775, 934.9906500934903, 954.6897258390911, 958.8849338079475, 14447.711045779026, 14540.49108281205, 14663.48677796272, 14901.627459313604, 15090.698186036218, 380427.0, 381268.0, 382311.0, 384018.0, 385574.0, 49364.75317623389, 49905.0, 49919.50080499148, 49944.750276248385, 50010.49989500131, 1066.2269854355686, 1160.6634076118, 1165.6211731187398, 1166.6383421139474, 1195.043964828134, 27614.723852761213, 28579.0, 29421.26446838846, 29517.704822951495, 29699.406011879208, 39261.0, 39674.0, 39703.2059358817, 39726.404103937886, 39733.0, 291939.0, 296316.0, 298894.0, 298944.0, 300532.0, 22263.332100037023, 22887.885560572755, 22926.082956681545, 24097.397565061015, 24190.153344632854, 38646.61353386543, 41815.1636967265, 42697.0, 42704.0, 42755.14489710251, 36226.27547449089, 36294.81852590826, 36776.44835327526, 37089.443658345685, 37100.443493347084, 35587.46618800772, 36497.27005459929, 36566.817165914, 36642.45036324511, 36790.8160459196, 35257.29485410329, 35676.28647427089, 36023.27953440969, 36080.819595901856, 36304.455433168, 32436.351272973938, 32910.50634240536, 32950.67049329572, 33254.16864578405, 33332.1666958328, 25399.746002540476, 25499.362515936507, 25563.488730225665, 25657.871710641328, 25967.74032259653], "value": 16278.134820849642, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.12044454642495, 373.12502182382315, 377.4828484975584, 384.08204391504324, 385.11807959772125, 15890.284937177827, 17251.137443127842, 17676.204570794314, 17692.646147077085, 17725.645487090267, 15676.529704108867, 16287.755683664755, 17119.743203851922, 17126.229319680613, 17126.914365428187, 4665.626749860012, 4868.78090485929, 4909.140900342443, 4910.2143657014885, 4910.75446227689, 3521.8239088045625, 3688.243909998457, 4873.780679869415, 5162.586993040548, 5501.779928802843, 5476.835694929158, 5487.670739755607, 5491.341039075317, 5513.917291240635, 5515.283013208297, 5157.48425157485, 5458.863528411802, 5481.232627432163, 5481.643693159932, 5497.340319161686, 3334.5998480182293, 5081.491850814926, 5302.337207849019, 5434.864128396782, 5448.591355648342, 12519.0, 13010.0, 15411.306491207923, 17003.574910627332, 17009.319627214896, 1835.164999925031, 1844.4651051195272, 1864.9720254196197, 1910.551020510179, 1956.7358406615067, 8833.0, 9378.718638440858, 9711.36876103051, 9725.708228753148, 9820.459874706889, 1623.375000624768, 1744.1366523570787, 1756.1219390304848, 1757.6748301564123, 1775.7070083436217, 61098.389016109715, 65136.3486365135, 65893.3410665892, 68302.0, 70044.0, 9697.175740062174, 9979.750506237257, 10087.285161522559, 10110.595576177018, 10251.0, 14074.437022518985, 14144.717105658036, 14195.716085678228, 14198.0, 14199.92900035514, 7037.331453511908, 7154.105736782903, 7173.605451700102, 7175.497715159889, 7192.964035179791, 6610.669466526654, 6668.33316668339, 6676.499262555328, 6776.220734615484, 6795.490338224653, 4448.354988526646, 4465.486469056035, 4500.684952053391, 4532.456105267389, 4573.748443835621, 1706.48805358392, 1708.1544635405553, 1732.3330517750758, 1748.9300427982992, 1856.4801855480487, 784.8391079828622, 822.9547374894438, 864.5893200729729, 885.8848349714495, 900.522722956834, 16297.185140742915, 16624.584385390463, 16867.831321686626, 17220.397286094925, 17417.39039133624, 818.9467684600481, 834.4534330013851, 894.9955250223837, 896.802768304308, 939.7462685075128, 7037.894431583531, 9373.20327772147, 9683.467409292556, 9701.563429645683, 9815.460149691693, 400662.0, 401865.0, 419824.0, 420740.0, 421824.0, 72928.0, 74678.0, 74817.0, 75501.24498754942, 76242.61878690572, 878.021006577674, 897.6364572348209, 920.9033051529627, 924.4037595750704, 927.3045216087934, 14905.776413353591, 15034.17312047804, 15155.924220378827, 15183.633472987483, 15315.0, 34537.65462345345, 34649.48025779565, 36503.634963651086, 36720.63279367172, 36780.632193677724, 48047.0, 48198.0, 48305.27542086801, 48382.5161748378, 48905.0, 6996.440284777307, 7068.187158476841, 7106.4314854810455, 7199.388052015637, 7204.675789589376, 9141.177294043568, 10674.02530531854, 10803.729906752395, 10816.459177040959, 10865.348079115278, 9295.907040929504, 9303.395279306824, 9347.158755712018, 9366.718998430058, 9457.810843783223, 9851.45816980073, 10315.432651204255, 10418.062374386342, 10540.736481588021, 10699.090577301016, 9709.36889102206, 9963.601455941682, 10053.984792876343, 10112.79774404493, 10453.26827122094, 7828.921710782819, 7891.171427000312, 7933.801654958672, 7940.054686601819, 8037.839243214986, 9595.184409325006, 9949.850752238577, 9959.601615935282, 10139.39163650154, 10270.281080324306], "value": 7969.857208096845, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1238.566501724396, 1373.9175649461033, 1413.2721648351098, 1495.8578935001171, 1704.6505466379394, 6853.143357080365, 7544.962275188624, 7746.147923728386, 7752.57360845154, 7968.72109476167, 7755.185705500926, 7765.572893490856, 7765.805854853632, 7782.610869456518, 7827.608619569027, 2181.727284089489, 2206.8013878750908, 2209.3482422685265, 2209.4586826227596, 2209.823214142865, 2127.4681329667583, 2170.479085019592, 2189.1462329691435, 2189.343197040889, 2192.8574642648255, 2184.563087382522, 2188.6388745856916, 2194.0236594715357, 2199.5490924360547, 2231.4979129695853, 2130.8828014459277, 2131.9467013324634, 2135.7970992755663, 2136.0, 2143.5391390850964, 2097.590969760897, 2152.806247437738, 2157.13714514194, 2160.8487405881597, 2161.8162456191244, 7786.961065194694, 7830.725924592669, 7863.292303692638, 7867.6459559319965, 7871.291583757432, 4486.439195100613, 4694.225452800284, 4699.0, 4700.4594471635855, 4705.835295764666, 2871.239121632769, 2901.419716056797, 2953.4979053560946, 2993.386355797078, 2998.865051072707, 1011.5397494140149, 1016.2022812092546, 1027.1628622672497, 1033.1579762493618, 1034.9534270957824, 10875.510602022929, 10997.12023038155, 11008.229423940327, 11017.394043327613, 11036.337819730841, 4132.483439570054, 4245.172191422643, 4267.466566679165, 4268.637165840938, 4311.439512863308, 8059.677612895536, 8084.717034903751, 8085.959570202229, 8103.392245581487, 8106.959465202636, 4672.509386514435, 4679.181143299909, 4680.906381872412, 4681.9297710534365, 4683.016566521001, 3571.357155711945, 4179.477565304337, 4245.405643209953, 4306.181825453154, 4345.0, 3358.7984720916334, 3364.360771453416, 3389.7796793154444, 3420.8973730788116, 3423.2126610879636, 1025.553884060436, 1035.539185062655, 1040.7190058684114, 1057.9047885690325, 1064.4571268652887, 580.3616022375438, 670.8993650952299, 796.1361922314238, 802.3941923847575, 805.1304591041661, 5286.97356513215, 5324.41431442541, 5446.618736688473, 5499.835004949778, 5580.91628625571, 455.3147512992924, 456.39299731357215, 462.10351917280366, 466.9836555720601, 612.1063247658468, 3406.880759173417, 3514.857671256852, 3547.858085676544, 3568.964310356915, 3576.2311103112957, 9424.434533927986, 9778.364406313567, 9837.655682051094, 9908.0, 9924.156446701967, 9738.853917191247, 9842.950785246028, 9858.753531161778, 9859.211263098934, 9887.604495820231, 7284.599347035964, 7526.134494533089, 7589.279018493235, 7591.4685971981435, 7593.810154746176, 5044.672096313728, 5113.079645663667, 5249.055170069424, 5272.762725677277, 5440.836774896759, 9082.45505269686, 9107.134822191882, 9179.495127768037, 9235.12266334697, 9261.67584134579, 8438.873416898628, 8779.429337093068, 8783.956080219557, 9105.089491050841, 9133.588988495667, 6217.533684973736, 6434.227892652724, 6437.130987316652, 6913.239543650094, 7051.929480705127, 7094.467914906506, 7192.532485388642, 7301.0, 7490.288422599844, 7502.3622992046285, 6764.797056088325, 6848.589084654936, 6892.0, 7002.4398048157045, 7002.75490357835, 6725.663716814238, 6803.115594972622, 6822.897656535057, 6867.3476019778045, 6930.341617546325, 5955.434233747787, 6112.297085835008, 6164.260288765377, 6189.876202475835, 6257.7184026719815, 4464.955350446454, 4491.663125265683, 4496.505384407778, 4581.496035436033, 4648.372469716545, 4518.774061296987, 4541.977290113528, 4578.313253011942, 4630.3517507548295, 4641.16459037363], "value": 4046.8304736468303, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.97498225159734, 290.90981795643364, 294.9100524340075, 297.1708932079498, 304.5523081070826, 4622.39908811854, 4756.453007904092, 4789.736564488951, 4871.878203044921, 4881.975590122049, 4640.466346370168, 4759.643026772988, 4776.880577985552, 4787.281907713845, 4804.183288840897, 3779.6960048783126, 3784.829682664273, 3797.2405518896194, 3803.695704343646, 3809.466674665549, 3569.4824250483666, 3637.5998640149564, 3775.7356985010924, 3776.3957766757326, 3778.2254637799183, 3737.738358314919, 3753.4557489164054, 3754.5119134512474, 3763.322601931665, 3773.1511559336004, 3717.646823551758, 3743.5320584926885, 3751.624837516254, 3763.266163098197, 3776.6412190841825, 3333.4833100869405, 3351.8938750212374, 3355.902560899438, 3365.5456513370627, 3375.594928608583, 4592.609628181575, 4644.326572646981, 4647.419072615923, 4654.5338218461075, 4664.416947881515, 4252.489701235841, 4269.316909294529, 4270.167317373113, 4271.530131685512, 4295.2912769393015, 4943.629227807929, 4982.202847544376, 4997.750112494397, 5014.473480284591, 5085.7622646036, 3412.812295323756, 3571.392863213234, 3591.0842735102383, 3678.7608805427562, 3688.870889518854, 5203.245529398216, 5246.7638956247065, 5247.763850626731, 5291.126964050927, 5305.840824775224, 3618.149734812317, 3620.6198349173483, 3626.32912911107, 3636.818159092035, 3656.2504686539196, 3660.890173294805, 3694.4667962795675, 3701.333759923186, 3707.35121353762, 3714.9071273218387, 4057.4928133983253, 4225.91548169041, 4244.129953359554, 4261.424707664488, 4266.2960611499375, 4988.551030407209, 4994.725290109079, 5008.5993120550265, 5033.395992480852, 5039.143345631178, 1210.8183772434206, 1227.4292454008928, 1250.3123282194938, 1259.2633309514038, 1264.4310060472824, 787.2560430393223, 817.5217497763756, 819.4141189049858, 836.2473773603805, 837.2213841127809, 3960.0199900049975, 4030.1738143680477, 4038.0106873816103, 4039.5960403959957, 4047.291723948297, 4581.106684196549, 4614.74618895964, 4638.884027899262, 4688.476245220317, 4704.811807527729, 4076.3681629347498, 4087.2642924273914, 4096.057906681421, 4101.610347017028, 4104.671626269891, 2380.535795519857, 2430.6718592990073, 2443.841150325223, 2453.77915987562, 2494.6881639795024, 4306.354046892991, 4315.619001919418, 4319.092990472036, 4348.260795664682, 4406.27296496081, 4651.116287905287, 4651.81378748417, 4685.9531404686195, 4703.929441058387, 4725.362076119749, 4125.793710314532, 4387.824487020547, 4394.274944634163, 4418.4035155254915, 4421.44731908505, 4523.638108951342, 4579.290210017452, 4589.4722106958125, 4638.350630911607, 4655.3249778782565, 4446.466424029137, 4523.751193684379, 4530.501644819134, 4537.750423726727, 4541.704789188692, 4098.090282051404, 4369.541198174146, 4377.562243775597, 4387.868363949086, 4407.636439924388, 3284.802911825298, 3290.276139249361, 3314.2045908982154, 3391.4404123319378, 3412.2322477442376, 4533.325338050566, 4533.501314855429, 4540.728595993127, 4579.633629309714, 4965.602751779921, 4863.076015557032, 5049.621278404061, 5066.670666406671, 5068.150125204347, 5081.974590127025, 5019.071471777733, 5034.572061374824, 5086.059079070384, 5111.693298402108, 5114.5652619527755, 4832.710037397767, 4937.728424936663, 4968.205087186033, 5034.14419548685, 5048.772805223847, 5077.8730531737, 5094.847154585368, 5099.209622508517, 5133.204353325241, 5140.691558506502, 4977.502249774993, 4980.850574482772, 4985.130576033987, 5005.524475174852, 5016.849494515171], "value": 3651.829245631777, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.0098798982647, 656.6953619027274, 725.6335550546976, 731.4441024821136, 760.4334770595905, 11463.140264480166, 12139.271643701362, 12211.877881221186, 12223.511059557619, 13186.274754888478, 12632.0, 12772.68068298293, 12792.616221513346, 12793.040521960867, 12803.295818729966, 625.4527288622455, 765.663108232376, 785.8664027115404, 790.608648718885, 802.891609632698, 794.8688466403037, 795.5306369242146, 798.4889670610813, 799.0970203669874, 799.6201804143014, 807.0879905706544, 807.6002378822491, 808.6239898447221, 809.0049239435498, 810.7486679129489, 658.4567731621431, 808.0747544062045, 815.7919730468752, 835.4110352201683, 836.8242669039448, 616.0451300484276, 616.2358675242712, 616.4513582911212, 616.4944745308849, 616.9969150154266, 12166.904978551973, 12211.877881221162, 12219.938900305531, 12229.205101668453, 12250.75498490034, 12629.305388203646, 12947.87052129476, 13074.607761767162, 13308.800367994489, 13387.397567109503, 10708.25042247043, 10864.185186110994, 10890.891091089146, 11491.65525034242, 11616.070714342917, 4223.68322375823, 4304.504981927087, 4324.589164029412, 4340.045190058182, 4474.127545128701, 58948.41051589472, 59111.11333330003, 59737.0, 59880.70059649674, 59975.0, 10239.48802559869, 10364.0, 10367.118794902366, 10665.680029599125, 10679.199060070527, 15671.764923526156, 15738.763918541232, 15759.054456732632, 15766.211689415484, 15774.447894323643, 6681.164854393201, 6689.5986240825705, 6759.695813688396, 6805.591664500146, 6810.727570897207, 3716.0524066362905, 3725.3480640887738, 3823.847046118124, 3901.317269477887, 3913.354296541039, 2607.074488556573, 2688.0, 2695.191442567222, 2703.094463354759, 2703.432279221346, 510.97700603472936, 539.9757010934518, 569.3395661033264, 576.4264556766045, 583.9416058394212, 564.7994961788506, 573.3609946179373, 577.0, 627.1877918095986, 628.632250133677, 8161.878591056708, 8412.8317433651, 8430.241278284984, 8447.704330348408, 8739.217349464521, 541.2882060090968, 594.9974293315777, 596.5704692621306, 598.2641351138125, 600.5075837813039, 4026.3356546169553, 4080.0, 4234.915301693949, 4276.3157894737315, 4364.1271745650365, 99769.0, 100957.49521252347, 103656.0, 103773.48113259385, 105569.47215263874, 88312.55843720741, 90654.54672726594, 90878.54560727286, 91265.54367228254, 91767.54116229377, 48767.0, 72477.6376118116, 74822.0, 78638.6068069656, 81496.59251703823, 8178.427510074238, 8342.29090527312, 8377.45546539473, 8728.738137855875, 8893.110688931056, 36689.63310366969, 42201.0, 42703.35944960766, 45128.77435612801, 47530.0, 63354.0, 66378.69834318318, 66599.66700166468, 67841.66079169573, 68489.65755171391, 10702.250842440955, 10712.571497140027, 10938.289011214245, 10990.560377584807, 11028.393438360967, 12306.323152226356, 12604.684882878002, 13242.271675057964, 13761.862381376459, 14025.579232623038, 11485.885141148481, 11613.419329033684, 11732.12009099338, 12131.636050918487, 12188.390580470763, 12464.439100240692, 12761.0, 12893.355332233163, 13003.284819335027, 13478.86521134776, 11307.830382544433, 11357.829632555684, 11500.25248358854, 11539.769204616028, 11920.821187682019, 9367.156955874005, 10021.248406369406, 10427.739306517095, 10650.573977041142, 10751.784964300827, 9473.952630236805, 9796.040195005415, 9910.851337229804, 9956.20350371983, 10021.0], "value": 6635.030061366948, "unit": "score"}], "name": "dromaeo_css", "value": 6259.182264826892, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 112.0, 114.0, 113.0, 114.0, 112.0, 112.0, 112.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 130.0, 136.0, 191.0, 132.0, 157.0, 154.0, 133.0, 190.0, 131.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 163.0, 162.0, 162.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 101.0, 76.0, 76.0, 75.0, 75.0, 99.0, 76.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 111.0, 86.0, 87.0, 85.0, 114.0, 86.0, 86.0, 125.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 64.0, 64.0, 63.0, 63.0, 63.0, 69.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 68.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 84.0, 83.0, 84.0, 85.0, 83.0, 84.0, 92.0, 89.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 140.0, 135.0, 130.0, 129.0, 131.0, 127.0, 128.0, 144.0, 132.0], "value": 133.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 167.0, 171.0, 174.0, 170.0, 176.0, 174.0, 172.0, 170.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 67.0, 67.0, 65.0, 71.0, 70.0, 67.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1543.4, "alertThreshold": 2.0}]} 02:22:44 INFO - Return code: 0 02:22:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:22:44 INFO - # TBPL SUCCESS # 02:22:44 INFO - Running post-action listener: _resource_record_post_action 02:22:44 INFO - ##### 02:22:44 INFO - ##### Finished run-tests step (success) 02:22:44 INFO - ##### 02:22:44 INFO - Running post-run listener: _resource_record_post_run 02:22:44 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 543600640; Read time: 184; Write time: 534248 02:22:44 INFO - TinderboxPrint: CPU usage
13.3% 02:22:44 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 184 02:22:44 INFO - TinderboxPrint: I/O write bytes / time
543,600,640 / 534,248 02:22:44 INFO - TinderboxPrint: CPU idle
8,319.3 (86.7%) 02:22:44 INFO - TinderboxPrint: CPU user
1,223.9 (12.8%) 02:22:44 INFO - TinderboxPrint: Swap in / out
0 / 0 02:22:44 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 255623168; Read time: 0; Write time: 290132 02:22:44 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 287977472; Read time: 184; Write time: 244116 02:22:45 INFO - Running post-run listener: _upload_blobber_files 02:22:45 INFO - Blob upload gear active. 02:22:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:22:45 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 02:22:45 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'] 02:22:45 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 02:22:45 INFO - (blobuploader) - INFO - Open directory for files ... 02:22:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:22:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:22:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:49 INFO - (blobuploader) - INFO - Done attempting. 02:22:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:22:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:22:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:50 INFO - (blobuploader) - INFO - Done attempting. 02:22:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:22:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:22:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:50 INFO - (blobuploader) - INFO - Done attempting. 02:22:50 INFO - (blobuploader) - INFO - Iteration through files over. 02:22:50 INFO - Return code: 0 02:22:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:22:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:22:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fef575679ac88273391d366205085d3efbd0c9528765cf3d636cf3499990d5ff03fa6083b8c8bb954b7c8729b33aa5c72428baabc65ce625a13db16009c077e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/195e22fbb6011ba7bd7dc14a3db93920cc66c7faec2836c3a6d07ec942b1e4a11943c49db9ad26f92f7a66d5f0ab4f1b43819bf7984b17035e9572987b616a01", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26ddb9f7ddcef68b363f1b029fcce8fe3108202b23c8ef7ed4ea177c104724d853a672faa08de50650ea6f3f6995f86506817402f8954d527fc38bbc331c834d"} 02:22:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:22:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:22:50 INFO - Contents: 02:22:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fef575679ac88273391d366205085d3efbd0c9528765cf3d636cf3499990d5ff03fa6083b8c8bb954b7c8729b33aa5c72428baabc65ce625a13db16009c077e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/195e22fbb6011ba7bd7dc14a3db93920cc66c7faec2836c3a6d07ec942b1e4a11943c49db9ad26f92f7a66d5f0ab4f1b43819bf7984b17035e9572987b616a01", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26ddb9f7ddcef68b363f1b029fcce8fe3108202b23c8ef7ed4ea177c104724d853a672faa08de50650ea6f3f6995f86506817402f8954d527fc38bbc331c834d"} 02:22:50 INFO - Running post-run listener: copy_logs_to_upload_dir 02:22:50 INFO - Copying logs to upload dir... 02:22:50 INFO - mkdir: /builds/slave/test/build/upload/logs 02:22:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.971378 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-27 02:22:49.586019) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 02:22:49.590676) ========= 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=32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372 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/fef575679ac88273391d366205085d3efbd0c9528765cf3d636cf3499990d5ff03fa6083b8c8bb954b7c8729b33aa5c72428baabc65ce625a13db16009c077e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/195e22fbb6011ba7bd7dc14a3db93920cc66c7faec2836c3a6d07ec942b1e4a11943c49db9ad26f92f7a66d5f0ab4f1b43819bf7984b17035e9572987b616a01", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26ddb9f7ddcef68b363f1b029fcce8fe3108202b23c8ef7ed4ea177c104724d853a672faa08de50650ea6f3f6995f86506817402f8954d527fc38bbc331c834d"} build_url:https://queue.taskcluster.net/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/Yxu00Jq2SeuRp7wpGY_DDQ/artifacts/public/build/firefox-50.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/fef575679ac88273391d366205085d3efbd0c9528765cf3d636cf3499990d5ff03fa6083b8c8bb954b7c8729b33aa5c72428baabc65ce625a13db16009c077e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/195e22fbb6011ba7bd7dc14a3db93920cc66c7faec2836c3a6d07ec942b1e4a11943c49db9ad26f92f7a66d5f0ab4f1b43819bf7984b17035e9572987b616a01", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/26ddb9f7ddcef68b363f1b029fcce8fe3108202b23c8ef7ed4ea177c104724d853a672faa08de50650ea6f3f6995f86506817402f8954d527fc38bbc331c834d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 02:22:49.619000) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 02:22:49.619404) ========= 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=32c5991c409366f7fec8a718000001d2-1467016094.618893-718464372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 02:22:49.701188) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 02:22:49.701522) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 02:22:49.701858) ========= ========= Total master_lag: 0.28 =========