builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1467032280.96 results: success (0) buildid: 20160627025709 builduid: 149c76c2819e40dabdae4b1b3c7151ea revision: 9f311d92805addcd093ba46dabfcf385a0f7fed3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 05:58:00.960196) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 05:58:00.960687) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 05:58:00.961004) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 05:58:00.976546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:58:00.976851) ========= 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=923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 05:58:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 27.5M=0s 2016-06-27 05:58:01 (27.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105478 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:58:01.097896) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:58:01.098292) ========= 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=923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016402 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:58:01.148750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:58:01.149170) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9f311d92805addcd093ba46dabfcf385a0f7fed3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9f311d92805addcd093ba46dabfcf385a0f7fed3 --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=923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 05:58:01,414 truncating revision to first 12 chars 2016-06-27 05:58:01,414 Setting DEBUG logging. 2016-06-27 05:58:01,414 attempt 1/10 2016-06-27 05:58:01,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9f311d92805a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 05:58:01,706 unpacking tar archive at: mozilla-aurora-9f311d92805a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.601098 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 05:58:01.764930) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 05:58:01.765340) ========= script_repo_revision: 9f311d92805addcd093ba46dabfcf385a0f7fed3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 05:58:01.765949) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 05:58:01.766394) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 05:58:01.776933) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-27 05:58:01.777398) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:58:02 INFO - MultiFileLogger online at 20160627 05:58:02 in /builds/slave/test 05:58:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:58:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:58:02 INFO - {'append_to_log': False, 05:58:02 INFO - 'base_work_dir': '/builds/slave/test', 05:58:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:58:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:58:02 INFO - 'branch': 'Mozilla-Aurora', 05:58:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:58:02 INFO - 'config_files': ('talos/linux_config.py',), 05:58:02 INFO - 'default_actions': ('clobber', 05:58:02 INFO - 'read-buildbot-config', 05:58:02 INFO - 'download-and-extract', 05:58:02 INFO - 'populate-webroot', 05:58:02 INFO - 'create-virtualenv', 05:58:02 INFO - 'install', 05:58:02 INFO - 'run-tests'), 05:58:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:58:02 INFO - 'download_minidump_stackwalk': True, 05:58:02 INFO - 'download_symbols': 'ondemand', 05:58:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:58:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:58:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:58:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:58:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:58:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:58:02 INFO - 'installer_path': 'installer.exe', 05:58:02 INFO - 'log_level': 'info', 05:58:02 INFO - 'log_name': 'talos', 05:58:02 INFO - 'log_to_console': True, 05:58:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:58:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:58:02 INFO - 'opt_config_files': (), 05:58:02 INFO - 'pip_index': False, 05:58:02 INFO - 'sps_profile': False, 05:58:02 INFO - 'sps_profile_interval': 0, 05:58:02 INFO - 'suite': 'dromaeojs', 05:58:02 INFO - 'system_bits': '32', 05:58:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:58:02 INFO - 'title': 'talos-linux64-ix-007', 05:58:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:58:02 INFO - 'use_talos_json': True, 05:58:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:58:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:58:02 INFO - 'work_dir': 'build'} 05:58:02 INFO - ##### 05:58:02 INFO - ##### Running clobber step. 05:58:02 INFO - ##### 05:58:02 INFO - Running pre-action listener: _resource_record_pre_action 05:58:02 INFO - Running main action method: clobber 05:58:02 INFO - rmtree: /builds/slave/test/build 05:58:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:58:02 INFO - Running post-action listener: _resource_record_post_action 05:58:02 INFO - ##### 05:58:02 INFO - ##### Finished clobber step (success) 05:58:02 INFO - ##### 05:58:02 INFO - ##### 05:58:02 INFO - ##### Running read-buildbot-config step. 05:58:02 INFO - ##### 05:58:02 INFO - Running pre-action listener: _resource_record_pre_action 05:58:02 INFO - Running main action method: read_buildbot_config 05:58:02 INFO - Using buildbot properties: 05:58:02 INFO - { 05:58:02 INFO - "project": "", 05:58:02 INFO - "product": "firefox", 05:58:02 INFO - "script_repo_revision": "production", 05:58:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 05:58:02 INFO - "repository": "", 05:58:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 05:58:02 INFO - "buildid": "20160627025709", 05:58:02 INFO - "pgo_build": "True", 05:58:02 INFO - "basedir": "/builds/slave/test", 05:58:02 INFO - "buildnumber": 578, 05:58:02 INFO - "slavename": "talos-linux64-ix-007", 05:58:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:58:02 INFO - "platform": "ubuntu64_hw", 05:58:02 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:58:02 INFO - "branch": "mozilla-aurora", 05:58:02 INFO - "repo_path": "releases/mozilla-aurora", 05:58:02 INFO - "revision": "9f311d92805addcd093ba46dabfcf385a0f7fed3", 05:58:02 INFO - "stage_platform": "linux64-pgo", 05:58:02 INFO - "builduid": "149c76c2819e40dabdae4b1b3c7151ea", 05:58:02 INFO - "slavebuilddir": "test" 05:58:02 INFO - } 05:58:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 05:58:02 INFO - Running post-action listener: _resource_record_post_action 05:58:02 INFO - ##### 05:58:02 INFO - ##### Finished read-buildbot-config step (success) 05:58:02 INFO - ##### 05:58:02 INFO - ##### 05:58:02 INFO - ##### Running download-and-extract step. 05:58:02 INFO - ##### 05:58:02 INFO - Running pre-action listener: _resource_record_pre_action 05:58:02 INFO - Running main action method: download_and_extract 05:58:02 INFO - mkdir: /builds/slave/test/build/tests 05:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:02 INFO - https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:58:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 05:58:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 05:58:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 05:58:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:58:03 INFO - Downloaded 1361 bytes. 05:58:03 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 05:58:03 INFO - Using the following test package requirements: 05:58:03 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 05:58:03 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:58:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:58:03 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:58:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:58:03 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:58:03 INFO - u'jsshell-linux-x86_64.zip'], 05:58:03 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:58:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:58:03 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 05:58:03 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:58:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:58:03 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:58:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:58:03 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:58:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:58:03 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:58:03 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:58:03 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:58:03 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')]} 05:58:03 INFO - https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:58:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:58:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:58:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:58:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:58:04 INFO - Downloaded 24517304 bytes. 05:58:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:58:06 INFO - Return code: 0 05:58:06 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:58:06 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')]} 05:58:06 INFO - https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:58:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:58:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:58:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:58:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:58:07 INFO - Downloaded 24517304 bytes. 05:58:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:58:08 INFO - Return code: 0 05:58: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')]} 05:58:08 INFO - https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:58:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 05:58:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 05:58:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 05:58:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:58:09 INFO - Downloaded 10833369 bytes. 05:58:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:58:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:58:09 INFO - Return code: 0 05:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:09 INFO - https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:58:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:58:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:58:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:58:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:58:11 INFO - Downloaded 63617093 bytes. 05:58:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:58:11 INFO - mkdir: /builds/slave/test/properties 05:58:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:11 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:11 INFO - Contents: 05:58:11 INFO - build_url:https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:58:11 INFO - Running post-action listener: _resource_record_post_action 05:58:11 INFO - Running post-action listener: set_extra_try_arguments 05:58:11 INFO - ##### 05:58:11 INFO - ##### Finished download-and-extract step (success) 05:58:11 INFO - ##### 05:58:11 INFO - ##### 05:58:11 INFO - ##### Running populate-webroot step. 05:58:11 INFO - ##### 05:58:11 INFO - Running pre-action listener: _resource_record_pre_action 05:58:11 INFO - Running main action method: populate_webroot 05:58:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:11 INFO - '--tppagecycles', 05:58:11 INFO - '7'], 05:58:11 INFO - 'tests': ['tsvgm']}}, 05:58:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:11 INFO - 'talos_options': ['--disable-e10s'], 05:58:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:11 INFO - 'talos_options': ['--disable-e10s'], 05:58:11 INFO - 'tests': ['damp', 'tps']}, 05:58:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:11 INFO - 'tests': ['damp', 'tps']}, 05:58:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:11 INFO - 'tests': ['dromaeo_dom']}, 05:58:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:11 INFO - 'tests': ['a11yr', 05:58:11 INFO - 'ts_paint', 05:58:11 INFO - 'tpaint', 05:58:11 INFO - 'sessionrestore', 05:58:11 INFO - 'sessionrestore_no_auto_restore', 05:58:11 INFO - 'tabpaint']}, 05:58:11 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:11 INFO - 'ts_paint', 05:58:11 INFO - 'tpaint', 05:58:11 INFO - 'sessionrestore', 05:58:11 INFO - 'sessionrestore_no_auto_restore', 05:58:11 INFO - 'tabpaint']}, 05:58:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:11 INFO - 'ts_paint', 05:58:11 INFO - 'tpaint', 05:58:11 INFO - 'sessionrestore', 05:58:11 INFO - 'sessionrestore_no_auto_restore', 05:58:11 INFO - 'tabpaint']}, 05:58:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:11 INFO - 'ts_paint', 05:58:11 INFO - 'tpaint', 05:58:11 INFO - 'sessionrestore', 05:58:11 INFO - 'sessionrestore_no_auto_restore', 05:58:11 INFO - 'tabpaint']}, 05:58:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:11 INFO - 'tests': ['a11yr', 05:58:11 INFO - 'ts_paint', 05:58:11 INFO - 'tpaint', 05:58:11 INFO - 'sessionrestore', 05:58:11 INFO - 'sessionrestore_no_auto_restore', 05:58:11 INFO - 'tabpaint']}, 05:58:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:11 INFO - 'tests': ['a11yr', 05:58:11 INFO - 'ts_paint', 05:58:11 INFO - 'tpaint', 05:58:11 INFO - 'sessionrestore', 05:58:11 INFO - 'sessionrestore_no_auto_restore', 05:58:11 INFO - 'tabpaint']}, 05:58:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:11 INFO - 'tests': ['tsvgx', 05:58:11 INFO - 'tsvgr_opacity', 05:58:11 INFO - 'tart', 05:58:11 INFO - 'tscrollx', 05:58:11 INFO - 'cart']}, 05:58:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:11 INFO - 'tsvgr_opacity', 05:58:11 INFO - 'tart', 05:58:11 INFO - 'tscrollx', 05:58:11 INFO - 'cart']}, 05:58:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:11 INFO - 'talos_options': ['--disable-e10s'], 05:58:11 INFO - 'tests': ['tp5o']}, 05:58:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:11 INFO - 'tests': ['tp5o']}, 05:58:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:11 INFO - 'talos_options': ['--disable-e10s', 05:58:11 INFO - '--xperf_path', 05:58:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:11 INFO - 'tests': ['tp5n']}, 05:58:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:11 INFO - 'talos_options': ['--xperf_path', 05:58:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:11 INFO - 'tests': ['tp5n']}}, 05:58:11 INFO - 'talos.zip': {'path': '', 05:58:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:11 INFO - Running post-action listener: _resource_record_post_action 05:58:11 INFO - ##### 05:58:11 INFO - ##### Finished populate-webroot step (success) 05:58:11 INFO - ##### 05:58:11 INFO - ##### 05:58:11 INFO - ##### Running create-virtualenv step. 05:58:11 INFO - ##### 05:58:11 INFO - Running pre-action listener: _resource_record_pre_action 05:58:11 INFO - Running main action method: create_virtualenv 05:58:11 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:11 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 05:58:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:12 INFO - Using real prefix '/usr' 05:58:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:12 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:14 INFO - Installing pip.................done. 05:58:14 INFO - Return code: 0 05:58:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8848f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a1c0>, '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 0x1f7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b550>, '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': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', '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 05:58:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:58:14 INFO - Using env: {'DISPLAY': ':0', 05:58:14 INFO - 'HOME': '/home/cltbld', 05:58:14 INFO - 'LANG': 'en_US.UTF-8', 05:58:14 INFO - 'LANGUAGE': 'en_US:en', 05:58:14 INFO - 'LOGNAME': 'cltbld', 05:58:14 INFO - 'MAIL': '/var/mail/cltbld', 05:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:14 INFO - 'MOZ_NO_REMOTE': '1', 05:58:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:14 INFO - 'NO_EM_RESTART': '1', 05:58:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:14 INFO - 'PWD': '/builds/slave/test', 05:58:14 INFO - 'SHELL': '/bin/bash', 05:58:14 INFO - 'SHLVL': '1', 05:58:14 INFO - 'TERM': 'linux', 05:58:14 INFO - 'TMOUT': '86400', 05:58:14 INFO - 'USER': 'cltbld', 05:58:14 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', 05:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:14 INFO - '_': '/tools/buildbot/bin/python'} 05:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:14 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 05:58:14 INFO - Cleaning up... 05:58:14 INFO - Return code: 0 05:58:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa8848f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a1c0>, '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 0x1f7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b550>, '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': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', '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 05:58:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:58:14 INFO - Using env: {'DISPLAY': ':0', 05:58:14 INFO - 'HOME': '/home/cltbld', 05:58:14 INFO - 'LANG': 'en_US.UTF-8', 05:58:14 INFO - 'LANGUAGE': 'en_US:en', 05:58:14 INFO - 'LOGNAME': 'cltbld', 05:58:14 INFO - 'MAIL': '/var/mail/cltbld', 05:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:14 INFO - 'MOZ_NO_REMOTE': '1', 05:58:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:14 INFO - 'NO_EM_RESTART': '1', 05:58:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:14 INFO - 'PWD': '/builds/slave/test', 05:58:14 INFO - 'SHELL': '/bin/bash', 05:58:14 INFO - 'SHLVL': '1', 05:58:14 INFO - 'TERM': 'linux', 05:58:14 INFO - 'TMOUT': '86400', 05:58:14 INFO - 'USER': 'cltbld', 05:58:14 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', 05:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:14 INFO - '_': '/tools/buildbot/bin/python'} 05:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:14 INFO - Downloading/unpacking psutil>=3.1.1 05:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:16 INFO - Installing collected packages: psutil 05:58:16 INFO - Running setup.py install for psutil 05:58:16 INFO - building 'psutil._psutil_linux' extension 05:58:16 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 05:58:17 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 05:58:17 INFO - building 'psutil._psutil_posix' extension 05:58:17 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 05:58:17 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 05:58:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:17 INFO - Successfully installed psutil 05:58:17 INFO - Cleaning up... 05:58:17 INFO - Return code: 0 05:58:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8848f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a1c0>, '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 0x1f7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b550>, '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': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', '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 05:58:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:58:17 INFO - Using env: {'DISPLAY': ':0', 05:58:17 INFO - 'HOME': '/home/cltbld', 05:58:17 INFO - 'LANG': 'en_US.UTF-8', 05:58:17 INFO - 'LANGUAGE': 'en_US:en', 05:58:17 INFO - 'LOGNAME': 'cltbld', 05:58:17 INFO - 'MAIL': '/var/mail/cltbld', 05:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:17 INFO - 'MOZ_NO_REMOTE': '1', 05:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:17 INFO - 'NO_EM_RESTART': '1', 05:58:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:17 INFO - 'PWD': '/builds/slave/test', 05:58:17 INFO - 'SHELL': '/bin/bash', 05:58:17 INFO - 'SHLVL': '1', 05:58:17 INFO - 'TERM': 'linux', 05:58:17 INFO - 'TMOUT': '86400', 05:58:17 INFO - 'USER': 'cltbld', 05:58:17 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', 05:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:17 INFO - '_': '/tools/buildbot/bin/python'} 05:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:58:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:58:19 INFO - Installing collected packages: mozsystemmonitor 05:58:19 INFO - Running setup.py install for mozsystemmonitor 05:58:19 INFO - Successfully installed mozsystemmonitor 05:58:19 INFO - Cleaning up... 05:58:19 INFO - Return code: 0 05:58:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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', '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 0x7fa8848f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a1c0>, '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 0x1f7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b550>, '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': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', '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 05:58: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:58: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 jsonschema==2.5.1 05:58:19 INFO - Using env: {'DISPLAY': ':0', 05:58:19 INFO - 'HOME': '/home/cltbld', 05:58:19 INFO - 'LANG': 'en_US.UTF-8', 05:58:19 INFO - 'LANGUAGE': 'en_US:en', 05:58:19 INFO - 'LOGNAME': 'cltbld', 05:58:19 INFO - 'MAIL': '/var/mail/cltbld', 05:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:19 INFO - 'MOZ_NO_REMOTE': '1', 05:58:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:19 INFO - 'NO_EM_RESTART': '1', 05:58:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:19 INFO - 'PWD': '/builds/slave/test', 05:58:19 INFO - 'SHELL': '/bin/bash', 05:58:19 INFO - 'SHLVL': '1', 05:58:19 INFO - 'TERM': 'linux', 05:58:19 INFO - 'TMOUT': '86400', 05:58:19 INFO - 'USER': 'cltbld', 05:58:19 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', 05:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:19 INFO - '_': '/tools/buildbot/bin/python'} 05:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:19 INFO - Downloading/unpacking jsonschema==2.5.1 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:58:21 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 05:58:21 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 05:58:21 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 05:58:21 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 05:58:21 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 05:58:21 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 05:58:22 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:22 INFO - warning: no files found matching '*.txt' 05:58:22 INFO - no previously-included directories found matching 'build' 05:58:22 INFO - no previously-included directories found matching 'dist' 05:58:22 INFO - no previously-included directories found matching '.git*' 05:58:22 INFO - Installing collected packages: jsonschema, functools32 05:58:22 INFO - Running setup.py install for functools32 05:58:22 INFO - warning: no files found matching '*.txt' 05:58:22 INFO - no previously-included directories found matching 'build' 05:58:22 INFO - no previously-included directories found matching 'dist' 05:58:22 INFO - no previously-included directories found matching '.git*' 05:58:22 INFO - Successfully installed jsonschema functools32 05:58:22 INFO - Cleaning up... 05:58:22 INFO - Return code: 0 05:58:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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', '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 0x7fa8848f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a1c0>, '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 0x1f7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b550>, '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': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', '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 05:58: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:58: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 blobuploader==1.2.4 05:58:22 INFO - Using env: {'DISPLAY': ':0', 05:58:22 INFO - 'HOME': '/home/cltbld', 05:58:22 INFO - 'LANG': 'en_US.UTF-8', 05:58:22 INFO - 'LANGUAGE': 'en_US:en', 05:58:22 INFO - 'LOGNAME': 'cltbld', 05:58:22 INFO - 'MAIL': '/var/mail/cltbld', 05:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:22 INFO - 'MOZ_NO_REMOTE': '1', 05:58:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:22 INFO - 'NO_EM_RESTART': '1', 05:58:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:22 INFO - 'PWD': '/builds/slave/test', 05:58:22 INFO - 'SHELL': '/bin/bash', 05:58:22 INFO - 'SHLVL': '1', 05:58:22 INFO - 'TERM': 'linux', 05:58:22 INFO - 'TMOUT': '86400', 05:58:22 INFO - 'USER': 'cltbld', 05:58:22 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', 05:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:22 INFO - '_': '/tools/buildbot/bin/python'} 05:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:22 INFO - Downloading/unpacking blobuploader==1.2.4 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:24 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:25 INFO - Downloading docopt-0.6.1.tar.gz 05:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:25 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:25 INFO - Running setup.py install for blobuploader 05:58:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:25 INFO - Running setup.py install for requests 05:58:25 INFO - Running setup.py install for docopt 05:58:25 INFO - Successfully installed blobuploader requests docopt 05:58:25 INFO - Cleaning up... 05:58:25 INFO - Return code: 0 05:58:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:25 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')]} 05:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:25 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')]} 05:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:25 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 0x7fa8848f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a1c0>, '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 0x1f7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b550>, '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': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', '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 05:58:25 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 05:58:25 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 05:58:25 INFO - Using env: {'DISPLAY': ':0', 05:58:25 INFO - 'HOME': '/home/cltbld', 05:58:25 INFO - 'LANG': 'en_US.UTF-8', 05:58:25 INFO - 'LANGUAGE': 'en_US:en', 05:58:25 INFO - 'LOGNAME': 'cltbld', 05:58:25 INFO - 'MAIL': '/var/mail/cltbld', 05:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:25 INFO - 'MOZ_NO_REMOTE': '1', 05:58:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:25 INFO - 'NO_EM_RESTART': '1', 05:58:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:25 INFO - 'PWD': '/builds/slave/test', 05:58:25 INFO - 'SHELL': '/bin/bash', 05:58:25 INFO - 'SHLVL': '1', 05:58:25 INFO - 'TERM': 'linux', 05:58:25 INFO - 'TMOUT': '86400', 05:58:25 INFO - 'USER': 'cltbld', 05:58:25 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', 05:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:25 INFO - '_': '/tools/buildbot/bin/python'} 05:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:26 INFO - Running setup.py (path:/tmp/pip-sr38wB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:26 INFO - Running setup.py (path:/tmp/pip-fQfUmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:26 INFO - Running setup.py (path:/tmp/pip-YWncBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:26 INFO - Running setup.py (path:/tmp/pip-8XVa_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:26 INFO - Running setup.py (path:/tmp/pip-0ysAZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:26 INFO - Running setup.py (path:/tmp/pip-VJZa1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:26 INFO - Running setup.py (path:/tmp/pip-MvIns5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:26 INFO - Running setup.py (path:/tmp/pip-jQ_43e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:26 INFO - Running setup.py (path:/tmp/pip-fyJxBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:26 INFO - Running setup.py (path:/tmp/pip-tAOoNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:26 INFO - Running setup.py (path:/tmp/pip-_AGsBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:26 INFO - Running setup.py (path:/tmp/pip-s6Etij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:26 INFO - Running setup.py (path:/tmp/pip-ukYcr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:26 INFO - Running setup.py (path:/tmp/pip-5lAZas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:27 INFO - Running setup.py (path:/tmp/pip-McBzeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:27 INFO - Running setup.py (path:/tmp/pip-jP7y_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:27 INFO - Running setup.py (path:/tmp/pip-kXCyU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:27 INFO - Running setup.py install for manifestparser 05:58:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:27 INFO - Running setup.py install for mozcrash 05:58:27 INFO - Running setup.py install for mozdebug 05:58:27 INFO - Running setup.py install for mozdevice 05:58:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:27 INFO - Running setup.py install for mozfile 05:58:27 INFO - Running setup.py install for mozhttpd 05:58:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:27 INFO - Running setup.py install for mozinfo 05:58:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:27 INFO - Running setup.py install for mozInstall 05:58:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:28 INFO - Running setup.py install for mozleak 05:58:28 INFO - Running setup.py install for mozlog 05:58:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:28 INFO - Running setup.py install for moznetwork 05:58:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:28 INFO - Running setup.py install for mozprocess 05:58:28 INFO - Running setup.py install for mozprofile 05:58:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:28 INFO - Running setup.py install for mozrunner 05:58:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:28 INFO - Running setup.py install for mozscreenshot 05:58:28 INFO - Running setup.py install for moztest 05:58:28 INFO - Running setup.py install for mozversion 05:58:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:29 INFO - Cleaning up... 05:58:29 INFO - Return code: 0 05:58:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:29 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')]} 05:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:29 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')]} 05:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:29 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 0x7fa8848f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a1c0>, '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 0x1f7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b550>, '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': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', '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 05:58:29 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 05:58:29 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 05:58:29 INFO - Using env: {'DISPLAY': ':0', 05:58:29 INFO - 'HOME': '/home/cltbld', 05:58:29 INFO - 'LANG': 'en_US.UTF-8', 05:58:29 INFO - 'LANGUAGE': 'en_US:en', 05:58:29 INFO - 'LOGNAME': 'cltbld', 05:58:29 INFO - 'MAIL': '/var/mail/cltbld', 05:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:29 INFO - 'MOZ_NO_REMOTE': '1', 05:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:29 INFO - 'NO_EM_RESTART': '1', 05:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:29 INFO - 'PWD': '/builds/slave/test', 05:58:29 INFO - 'SHELL': '/bin/bash', 05:58:29 INFO - 'SHLVL': '1', 05:58:29 INFO - 'TERM': 'linux', 05:58:29 INFO - 'TMOUT': '86400', 05:58:29 INFO - 'USER': 'cltbld', 05:58:29 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', 05:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:29 INFO - '_': '/tools/buildbot/bin/python'} 05:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:29 INFO - Running setup.py (path:/tmp/pip-S5WnBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:29 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)) 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:29 INFO - Running setup.py (path:/tmp/pip-8YHeNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:29 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)) 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:29 INFO - Running setup.py (path:/tmp/pip-T4eUT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:29 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)) 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:29 INFO - Running setup.py (path:/tmp/pip-JKPP3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:29 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)) 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:29 INFO - Running setup.py (path:/tmp/pip-8FtxM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:29 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)) 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:29 INFO - Running setup.py (path:/tmp/pip-gqXhED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:29 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)) 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:29 INFO - Running setup.py (path:/tmp/pip-yhUNXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:29 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)) 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:29 INFO - Running setup.py (path:/tmp/pip-xe1fEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:29 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)) 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:29 INFO - Running setup.py (path:/tmp/pip-rFsRiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:29 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)) 05:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:29 INFO - Running setup.py (path:/tmp/pip-XW_lzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:30 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)) 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:30 INFO - Running setup.py (path:/tmp/pip-dncIrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:30 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)) 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:30 INFO - Running setup.py (path:/tmp/pip-huGNiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:30 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)) 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:30 INFO - Running setup.py (path:/tmp/pip-7n1LDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:30 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)) 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:30 INFO - Running setup.py (path:/tmp/pip-lozvTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:30 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)) 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:30 INFO - Running setup.py (path:/tmp/pip-Oe4_xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:30 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)) 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:30 INFO - Running setup.py (path:/tmp/pip-EJ970M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:30 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)) 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:30 INFO - Running setup.py (path:/tmp/pip-0OXwS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:30 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)) 05:58:30 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)) 05:58:30 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)) 05:58:30 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)) 05:58:30 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)) 05:58:30 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)) 05:58:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:32 INFO - Downloading blessings-1.6.tar.gz 05:58:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:32 INFO - Installing collected packages: blessings 05:58:32 INFO - Running setup.py install for blessings 05:58:32 INFO - Successfully installed blessings 05:58:32 INFO - Cleaning up... 05:58:32 INFO - Return code: 0 05:58:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:32 INFO - Reading from file tmpfile_stdout 05:58:32 INFO - Current package versions: 05:58:32 INFO - argparse == 1.2.1 05:58:32 INFO - blessings == 1.6 05:58:32 INFO - blobuploader == 1.2.4 05:58:32 INFO - docopt == 0.6.1 05:58:32 INFO - functools32 == 3.2.3-2 05:58:32 INFO - jsonschema == 2.5.1 05:58:32 INFO - manifestparser == 1.1 05:58:32 INFO - mozInstall == 1.12 05:58:32 INFO - mozcrash == 0.17 05:58:32 INFO - mozdebug == 0.1 05:58:32 INFO - mozdevice == 0.48 05:58:32 INFO - mozfile == 1.2 05:58:32 INFO - mozhttpd == 0.7 05:58:32 INFO - mozinfo == 0.9 05:58:32 INFO - mozleak == 0.1 05:58:32 INFO - mozlog == 3.2 05:58:32 INFO - moznetwork == 0.27 05:58:32 INFO - mozprocess == 0.22 05:58:32 INFO - mozprofile == 0.28 05:58:32 INFO - mozrunner == 6.11 05:58:32 INFO - mozscreenshot == 0.1 05:58:32 INFO - mozsystemmonitor == 0.3 05:58:32 INFO - moztest == 0.7 05:58:32 INFO - mozversion == 1.4 05:58:32 INFO - psutil == 3.1.1 05:58:32 INFO - requests == 1.2.3 05:58:32 INFO - wsgiref == 0.1.2 05:58:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:32 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')]} 05:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:32 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')]} 05:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:32 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 0x7fa8848f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a1c0>, '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 0x1f7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b550>, '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': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', '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 05:58:32 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 05:58:32 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 05:58:32 INFO - Using env: {'DISPLAY': ':0', 05:58:32 INFO - 'HOME': '/home/cltbld', 05:58:32 INFO - 'LANG': 'en_US.UTF-8', 05:58:32 INFO - 'LANGUAGE': 'en_US:en', 05:58:32 INFO - 'LOGNAME': 'cltbld', 05:58:32 INFO - 'MAIL': '/var/mail/cltbld', 05:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:32 INFO - 'MOZ_NO_REMOTE': '1', 05:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:32 INFO - 'NO_EM_RESTART': '1', 05:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:32 INFO - 'PWD': '/builds/slave/test', 05:58:32 INFO - 'SHELL': '/bin/bash', 05:58:32 INFO - 'SHLVL': '1', 05:58:32 INFO - 'TERM': 'linux', 05:58:32 INFO - 'TMOUT': '86400', 05:58:32 INFO - 'USER': 'cltbld', 05:58:32 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', 05:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:32 INFO - '_': '/tools/buildbot/bin/python'} 05:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:33 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)) 05:58:33 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)) 05:58:33 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)) 05:58:33 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)) 05:58:33 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)) 05:58:33 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)) 05:58:33 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)) 05:58:33 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)) 05:58:33 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)) 05:58:33 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)) 05:58:33 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)) 05:58:33 INFO - Cleaning up... 05:58:33 INFO - Return code: 0 05:58:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:58:33 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')]} 05:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:33 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')]} 05:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:33 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 0x7fa8848f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a1c0>, '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 0x1f7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b550>, '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': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', '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 05:58:33 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 05:58:33 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 05:58:33 INFO - Using env: {'DISPLAY': ':0', 05:58:33 INFO - 'HOME': '/home/cltbld', 05:58:33 INFO - 'LANG': 'en_US.UTF-8', 05:58:33 INFO - 'LANGUAGE': 'en_US:en', 05:58:33 INFO - 'LOGNAME': 'cltbld', 05:58:33 INFO - 'MAIL': '/var/mail/cltbld', 05:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:33 INFO - 'MOZ_NO_REMOTE': '1', 05:58:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:33 INFO - 'NO_EM_RESTART': '1', 05:58:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:33 INFO - 'PWD': '/builds/slave/test', 05:58:33 INFO - 'SHELL': '/bin/bash', 05:58:33 INFO - 'SHLVL': '1', 05:58:33 INFO - 'TERM': 'linux', 05:58:33 INFO - 'TMOUT': '86400', 05:58:33 INFO - 'USER': 'cltbld', 05:58:33 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', 05:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:33 INFO - '_': '/tools/buildbot/bin/python'} 05:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:58:33 INFO - Cleaning up... 05:58:33 INFO - Return code: 0 05:58:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:58:33 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')]} 05:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:33 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')]} 05:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:33 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 0x7fa8848f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a1c0>, '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 0x1f7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b550>, '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': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', '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 05:58:33 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 05:58:33 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 05:58:33 INFO - Using env: {'DISPLAY': ':0', 05:58:33 INFO - 'HOME': '/home/cltbld', 05:58:33 INFO - 'LANG': 'en_US.UTF-8', 05:58:33 INFO - 'LANGUAGE': 'en_US:en', 05:58:33 INFO - 'LOGNAME': 'cltbld', 05:58:33 INFO - 'MAIL': '/var/mail/cltbld', 05:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:33 INFO - 'MOZ_NO_REMOTE': '1', 05:58:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:33 INFO - 'NO_EM_RESTART': '1', 05:58:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:33 INFO - 'PWD': '/builds/slave/test', 05:58:33 INFO - 'SHELL': '/bin/bash', 05:58:33 INFO - 'SHLVL': '1', 05:58:33 INFO - 'TERM': 'linux', 05:58:33 INFO - 'TMOUT': '86400', 05:58:33 INFO - 'USER': 'cltbld', 05:58:33 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', 05:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:33 INFO - '_': '/tools/buildbot/bin/python'} 05:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:33 INFO - Downloading/unpacking flake8 05:58:33 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 05:58:33 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 05:58:33 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 05:58:33 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 05:58:33 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 05:58:33 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 05:58:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:58:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:58:35 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 05:58:35 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 05:58:35 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 05:58:35 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 05:58:35 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 05:58:35 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 05:58:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:58:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:58:35 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 05:58:35 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 05:58:35 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 05:58:35 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 05:58:35 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 05:58:35 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 05:58:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:58:35 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 05:58:35 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 05:58:35 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 05:58:35 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 05:58:35 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 05:58:35 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 05:58:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:58:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:58:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:58:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:58:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:58:36 INFO - no previously-included directories found matching 'docs/_build' 05:58:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:58:36 INFO - Running setup.py install for pep8 05:58:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:58:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:58:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:58:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:58:36 INFO - no previously-included directories found matching 'docs/_build' 05:58:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:58:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:58:36 INFO - Cleaning up... 05:58:36 INFO - Return code: 0 05:58:36 INFO - Running post-action listener: _resource_record_post_action 05:58:36 INFO - Running post-action listener: _start_resource_monitoring 05:58:36 INFO - Starting resource monitoring. 05:58:36 INFO - ##### 05:58:36 INFO - ##### Finished create-virtualenv step (success) 05:58:36 INFO - ##### 05:58:36 INFO - ##### 05:58:36 INFO - ##### Running install step. 05:58:36 INFO - ##### 05:58:36 INFO - Running pre-action listener: _resource_record_pre_action 05:58:36 INFO - Running main action method: install 05:58:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:36 INFO - Reading from file tmpfile_stdout 05:58:36 INFO - Detecting whether we're running mozinstall >=1.0... 05:58:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:58:36 INFO - Reading from file tmpfile_stdout 05:58:36 INFO - Output received: 05:58:36 INFO - Usage: mozinstall [options] installer 05:58:36 INFO - Options: 05:58:36 INFO - -h, --help show this help message and exit 05:58:36 INFO - -d DEST, --destination=DEST 05:58:36 INFO - Directory to install application into. [default: 05:58:36 INFO - "/builds/slave/test"] 05:58:36 INFO - --app=APP Application being installed. [default: firefox] 05:58:36 INFO - mkdir: /builds/slave/test/build/application 05:58:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:58:52 INFO - Reading from file tmpfile_stdout 05:58:52 INFO - Output received: 05:58:52 INFO - /builds/slave/test/build/application/firefox/firefox 05:58:52 INFO - Running post-action listener: _resource_record_post_action 05:58:52 INFO - ##### 05:58:52 INFO - ##### Finished install step (success) 05:58:52 INFO - ##### 05:58:52 INFO - ##### 05:58:52 INFO - ##### Running run-tests step. 05:58:52 INFO - ##### 05:58:52 INFO - Running pre-action listener: _resource_record_pre_action 05:58:52 INFO - Running main action method: run_tests 05:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:58:52 INFO - Python 2.7.3 05:58:52 INFO - Return code: 0 05:58:52 INFO - grabbing minidump binary from tooltool 05:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:52 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 0x1f7a1c0>, '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 0x1f7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:58:52 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 05:58:52 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 05:58:52 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 05:58:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:58:52 INFO - Return code: 0 05:58:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:58:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:58:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:58:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:58:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:58:53 INFO - Return code: 0 05:58:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 05:58:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 05:58:53 INFO - Using env: {'DISPLAY': ':0', 05:58:53 INFO - 'HOME': '/home/cltbld', 05:58:53 INFO - 'LANG': 'en_US.UTF-8', 05:58:53 INFO - 'LANGUAGE': 'en_US:en', 05:58:53 INFO - 'LOGNAME': 'cltbld', 05:58:53 INFO - 'MAIL': '/var/mail/cltbld', 05:58:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:58:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:53 INFO - 'MOZ_NO_REMOTE': '1', 05:58:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:53 INFO - 'NO_EM_RESTART': '1', 05:58:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:53 INFO - 'PWD': '/builds/slave/test', 05:58:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:58:53 INFO - 'SHELL': '/bin/bash', 05:58:53 INFO - 'SHLVL': '1', 05:58:53 INFO - 'TERM': 'linux', 05:58:53 INFO - 'TMOUT': '86400', 05:58:53 INFO - 'USER': 'cltbld', 05:58:53 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241', 05:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:53 INFO - '_': '/tools/buildbot/bin/python'} 05:58:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 05:58:53 INFO - mozversion application_buildid: 20160627025709 05:58:53 INFO - mozversion application_changeset: 9f311d92805addcd093ba46dabfcf385a0f7fed3 05:58:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:58:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:58:53 INFO - mozversion application_name: Firefox 05:58:53 INFO - mozversion application_remotingname: firefox-dev 05:58:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:58:53 INFO - mozversion application_vendor: Mozilla 05:58:53 INFO - mozversion application_version: 49.0a2 05:58:53 INFO - mozversion platform_buildid: 20160627025709 05:58:53 INFO - mozversion platform_changeset: 9f311d92805addcd093ba46dabfcf385a0f7fed3 05:58:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:58:53 INFO - mozversion platform_version: 49.0a2 05:58:53 INFO - using testdate: 1467032333 05:58:53 INFO - actual date: 1467032333 05:58:53 INFO - starting webserver on 'localhost:41233' 05:58:53 INFO - SUITE-START | Running 2 tests 05:58:53 INFO - TEST-START | dromaeo_css 05:58:53 INFO - operating with platform_type : linux_ 05:58:53 INFO - Initialising browser for dromaeo_css test... 05:58:53 INFO - TEST-INFO | started process 5066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3AYot_/profile http://localhost:41233/getInfo.html) 05:58:57 INFO - PROCESS | 5066 | __metrics Screen width/height:1600/1200 05:58:57 INFO - PROCESS | 5066 | colorDepth:24 05:58:57 INFO - PROCESS | 5066 | Browser inner width/height: 1024/697 05:58:57 INFO - PROCESS | 5066 | __metrics 05:58:58 ERROR - PROCESS | 5066 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:58:58 INFO - PROCESS | 5066 | console.error: PushService: 05:58:58 INFO - PROCESS | 5066 | stateChangeProcessEnqueue: Error transitioning state 05:58:58 INFO - PROCESS | 5066 | UnknownError 05:58:59 INFO - TEST-INFO | 5066: exit 0 05:58:59 INFO - Browser initialized. 05:58:59 INFO - Running cycle 1/1 for dromaeo_css test... 05:58:59 INFO - TEST-INFO | started process 5155 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3AYot_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:11 INFO - PROCESS | 5155 | RSS: Main: 145354752 05:59:11 INFO - PROCESS | 5155 | 06:00:02 INFO - PROCESS | 5155 | 1467032402305 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] 06:02:10 INFO - PROCESS | 5155 | Cycle 1(1): loaded http://localhost:41233/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41233/tests/dromaeo/cssquery-ext.html) 06:02:11 INFO - PROCESS | 5155 | RSS: Main: 254382080 06:02:11 INFO - PROCESS | 5155 | 06:05:13 INFO - PROCESS | 5155 | Cycle 1(1): loaded http://localhost:41233/tests/dromaeo/cssquery-ext.html (next: http://localhost:41233/tests/dromaeo/cssquery-jquery.html) 06:05:14 INFO - PROCESS | 5155 | RSS: Main: 232484864 06:05:14 INFO - PROCESS | 5155 | 06:08:16 INFO - PROCESS | 5155 | Cycle 1(1): loaded http://localhost:41233/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41233/tests/dromaeo/cssquery-mootools.html) 06:08:16 INFO - PROCESS | 5155 | RSS: Main: 222400512 06:08:16 INFO - PROCESS | 5155 | 06:11:18 INFO - PROCESS | 5155 | Cycle 1(1): loaded http://localhost:41233/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41233/tests/dromaeo/cssquery-prototype.html) 06:11:19 INFO - PROCESS | 5155 | RSS: Main: 220454912 06:11:19 INFO - PROCESS | 5155 | 06:14:21 INFO - PROCESS | 5155 | Cycle 1(1): loaded http://localhost:41233/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41233/tests/dromaeo/cssquery-yui.html) 06:14:22 INFO - PROCESS | 5155 | RSS: Main: 214925312 06:14:22 INFO - PROCESS | 5155 | 06:17:24 INFO - PROCESS | 5155 | Cycle 1(1): loaded http://localhost:41233/tests/dromaeo/cssquery-yui.html (next: http://localhost:41233/tests/dromaeo/cssquery-dojo.html) 06:17:25 INFO - PROCESS | 5155 | RSS: Main: 258158592 06:17:25 INFO - PROCESS | 5155 | 06:17:25 INFO - PROCESS | 5155 | __start_tp_report 06:17:25 INFO - PROCESS | 5155 | _x_x_mozilla_page_load 06:17:25 INFO - PROCESS | 5155 | _x_x_mozilla_page_load_details 06:17:25 INFO - PROCESS | 5155 | |i|pagename|runs| 06:17:25 INFO - PROCESS | 5155 | |0;dojo.html;3342.0475164578093;3360.663933606641;3367.494875768634;3393.507941348506;3416.4533674612067;5499.7250137493165;5597.356304025038;5603.60774745768;5612.242347283115;5635.0420428527095;5562.7774889004495;5634.3520495143075;5637.3517045539775;5649.1526271059365;5656.038473459512;4968.950310496903;5091.694498330094;5107.106256405133;5152.845414637567;5190.870228244286;4955.380577427822;5056.19100943849;5097.974510127444;5108.872278193037;5111;5026.698398096126;5030.396352437712;5082.161443361841;5088.058709138802;5136.332276804011;5162.096633089213;5199.064168449678;5202.297689811902;5206.828169687781;5235.110031294689;4961.925571116436;4996.325496058058;5029.874253143664;5092.3125378073855;5094.847154585332;5354.946450535523;5363.436839131874;5367.5169234769055;5374.946250537484;5406.621536492447;5946.375630558816;5999.910001349939;6003.849903752441;6004.609700369462;6005.279366476007;5985.042393217064;6000.33996260411;6057.818265452043;6070.817875463743;6098.298695650013;5691.9146212806845;5733.168690539848;5738.6556806591325;5746.79886203985;5749.338826034976;5967.522598192134;6214.751409943642;6228.408301211378;6230.345813689497;6233.812985610439;5772.538196944234;5775.249217601685;5802.82591522255;5900.321463031721;5905.320888097924;5945.10823376497;5948.256467941507;5948.643081415129;5983.431574000463;5985.311689155716;5766.481016708516;5835.824925252249;5898.911516327258;5904;5913.172155898178;5886.882262354815;5983.491403230687;5983.640981541122;5986.970065149646;6022.608530445507;4564.452265728134;4573.885652858705;4574.222382195035;4577.496475387705;4602.562756538124;4011.097503061846;4039.4546736190237;4080.775557344315;4101.364288535282;4142.834286628501;5682.176084467729;5706.058500347479;5707.315122185281;5717.199592057115;5731.885362292731;6017.217761690952;6021.6989150542295;6023.216981792339;6024.608400453956;6054.031354983182;5595.63628364155;5623.128415095667;5653.462921022497;5665.971670141623;5687.118496633028;5167.6641018333685;5168.01807656544;5172.870678232999;5174.24973378858;5179.8446046618665;6200.7519699211525;6225.564210505221;6227.159333490012;6227.750889964442;6231.594946328474;5865.4134586541;5972.641641501524;6020.217371741645;6026.276846778239;6077.4226448487325;6242.406971337716;6269.404406581368;6275.309715931336;6279.434850863444;6280.497560195082;5734.856628584152;5926.525877929842;5928.140419639214;5932.466078052996;5968.880622387441;5925.555583331354;5936.1986131871645;5990.34106248321;6021.096835474714;6023.789167379121;5834.970825145847;5867.970660146672;5869.911951320648;5878.647281162973;5881.705914704333;5702.144678298123;5726.828195154152;5808.796692115925;5852.678102704393;5872.442117998783;5662.716864156693;5727.427257274239;5731.713414329183;5732.828015159552;5753.280839895013;5854.151148083419;5862.472377486047;5882.676452794966;5887.735051922588;5892.823215303548;5616.971915140398;5638.436156384329;5656.886862262814;5745.597808153389;5766.3368712598585 06:17:25 INFO - PROCESS | 5155 | |1;ext.html;584.5820238529451;636.5416899832119;645.6642545876144;656.1044174701532;658.1476987301444;32122.83938580307;45218.547814521844;46143.30785038227;46197;46203.306950395774;48741;49190;49201.753991230085;49232.50767492324;49382;8552.486850788942;9217.170454659063;9404.435733855957;11046.116310695124;11301.095912327035;11097.278676886017;11195.328280303207;11209.775804483905;11217.495212715447;11221.326720396803;11238.775224495505;11240.831387529193;11308.321500709942;11309.943450282737;11326.150538709588;8546.31629469641;11024.228304018721;11282.887171128348;11301.152413569016;11303.943480282545;10812.72968175794;10877.782444351147;10880.945595272053;11200.103991680728;11213.831792523119;45486.54513454889;45685.54314456846;45941;46083.53916460826;46140.07719845618;3681.9263614727824;3693.759905606127;3954.406838974177;4171.436856024428;4519.84180553679;34586;35563;35602.64397356019;35804.64195358065;35902.46146307808;4645.349651048856;4669.299605059235;4699.694519856198;4745.501722319142;4827.927581086286;357623;359894;360037;360071;360289;39227;40162.39756403656;69608.30391696018;69999;70309;41714;41831.37252941208;41918.790406048385;41953;42018;15279.465218717292;16383.508494745176;16527.421540246276;16533.421330253623;16542.42101526441;13245.73508529824;13460.730785384238;13485.123466974615;13767.449302027806;13783.241921694404;9481.620735170654;9499.762505937408;9503.192228660502;9549.618015279311;9577.042295770367;3606.6753992140307;3637.4722616501135;3667.8716244931834;3681.9079523011605;3699.574548926908;1057.830747080479;1093.2456604942565;1172.7713095946208;1177.3289225141586;1190.6249531397582;34447.13882152966;34486.48270275948;34493.21318694443;34787.826060869535;34936.475952860725;1117.3461048898712;1133.0595605647459;1139.9316041037398;1226.1600803449664;1228.2078059651653;17404.65190696179;17910.194041268172;18187;18358.35745748919;18363.35728249505;531077;536212;537845;537941;541038;65472.69054618881;67031.32968670348;67293.663531683;67314.66342668256;67361;1361.8025386318927;1402.2638114989509;1442.6753980354547;1475.144416238579;1499.2803454341758;33675;35199.47200792041;35324.47013294854;35917.640823592475;35951.82024089967;54521.72739136437;54833.72583137059;55077;55204.44795551993;55337;387958;397446;397932;398789;399146;28236.43527129405;30354.54468182935;31013.224669383446;32760;32836.507452387756;52005.73997130142;53220.4677953231;53511;54152.187717183486;54624.18063729127;43512.516206243905;43728;44008.339874902544;44645.330320045876;45352.31971520364;43498;43983.340249896915;44103.33844992392;44615.27758452793;45655.77172114118;43577;44655.776721116184;44886;45187.54812451833;45269;37004.629953701195;38635;39042.21915561616;39345.60654393534;39566.766933714636;29371.971980980565;29473.55789663114;30013.69986300109;30061.849690752282;30070.548941765453 06:17:25 INFO - PROCESS | 5155 | |2;jquery.html;434.6023388599431;438.8354367112333;442.3298702465763;444.373433458823;453.8411555955414;19106.140223689934;20048;20721.481962950915;21071.051802668877;21114.788852111473;19889.20443182271;20334.389968300973;20391.184352625878;20405.591888162227;20420.081096350663;5625.071863142576;5819.709014549277;5858.091995740667;5877.441643043904;5878.853028674296;4138.379243113542;5338.359396872381;5739.856503587402;6267.091271765591;6424.871502569946;6373.171487706615;6414.9679251603675;6428.8071357859335;6449.774257900975;6484.708188131545;6319.17850679411;6326.145970293997;6419.325970773071;6422.935770642304;6489.383508566679;5796.13058041293;5805;5832.591718579701;5840.678762668052;5841.948449279128;23749;23755.76244237553;23943.401414964592;24386.87806560956;24414.877925610435;2296.7588403217756;2351.9647205291935;2356.8468049576722;2361.622140457536;2503.912363067284;14488.420463181461;14990.850091499055;15070.472533461276;15306.693866122616;15648.295826687712;2035.989820050905;2112.2290364017176;2128.638131517646;2143.217725530186;2188.387251569547;60025.699871500365;61910.69044654748;74403.62798186029;75280.62359688221;77628;11234.719132021764;11331.093512518979;11374.20380573352;11561.76876462466;11629.88370116305;16091.275892584861;16178.11020393866;16232.269547870374;16297.59256018609;16302.429414970657;8553.230209281195;8718.65125394977;8740.912590874137;8790.91209087901;8860.158284963047;8386.916130838736;8398.580070996548;8409.453385529921;8438.831223375499;8600.354973377021;6865.965670171717;7101.89347159793;7121.857562848714;7130.180029296594;7158.2125966143685;2038.541328201143;2054.753429588429;2081.739782527184;2082.33461169703;2143.774903635127;980.5734505490135;1049.5382031905938;1082.8105081610686;1111.5387114347454;1134.5461815273957;19961.85315956436;20380.18479260813;20581.69127463089;20717.58564828695;20897.686534701686;1049.0610903241557;1055.9419231942318;1072.6460268111505;1126.9744532475409;1127.3461392392392;11554.364509952033;11931.343776092399;11960.820587691192;11995.88004119965;12061.095417843697;375661;439985;446712;457692;457818;89476.55261723649;101874.49062754787;104278.47860760648;106870;107159.46420268004;1012.5696578953915;1071.239420011785;1096.8519249901162;1111.6942840718866;1119.64171465132;17413.738793918354;17543.736843947096;17871.73192402141;18222.36221732233;18275.725864112315;40031;41542.376864347665;41877.37183942182;42835.143297134506;43516.34725479057;60388.396116038275;61312.69343653432;61817.38182618116;62275.688621556605;63416.36583634289;8079.596020198849;8598.355123365647;9159.771005724644;9192.632294708405;9460.905390946002;11742.412879356169;13933.094348867291;14293;14332.785008225093;14359.282035898372;11815.291082535075;11944.223625464318;12388;12470.251784892573;12713.55502557406;11919.761604767682;12295.69260768488;12339.259644421363;12435.129540932048;12492.937535312265;12618;12659.873401266237;12693.873061269269;12779.424925878544;12870.292133932724;8144.429889907887;8263.338932885235;8555.91444085576;8576.785580360542;8741.694040708544;11901.821472677744;12180.817287740514;12409.379531023593;12451.948518766301;12503.749925001632 06:17:25 INFO - PROCESS | 5155 | |3;mootools.html;1478.3495262084675;1543.459789073824;1568.7411577089779;1846.7229915512671;1999.1203870297068;9170.908290917088;9558.42649441034;9589.568469418875;9916.206703463724;9973.650922217725;9357;9566.712998610054;9567;9571.2343012559;9572.47351395673;2115.8518903676672;2416.5770990076753;2500.362407586063;2509.962350564743;2556.2203527923975;2489.2158969924417;2504.2362079565723;2513.7988960883176;2519.8740062996867;2520.2943175910773;2384.5946189147885;2405.675233843435;2407.1093695332665;2407.3981504623844;2411.770881766229;2155.644318687415;2449.8162637802147;2524.116559204282;2527.633493143502;2532.9994652112314;2421.2010036687852;2429.125514814665;2431.8662473563945;2443.0716327795326;2447.730749617541;9711.757206069835;9764.609415623367;9768.36505627132;9774.75563110928;9793.167580755644;5501.9174712379345;5677.176809362661;5678.4037676044245;5682.374938756733;5685.545156387479;3650.945235821438;3697.7411581189326;3782.508273924372;3829.291581057513;3850.0182453474185;1171.1158075652913;1185.146694380045;1196.2642974570663;1220.4751956658633;1229.1580267516779;13156.934215328862;13560.254186019765;13582.728345433135;14038.859611403857;14046;4631.258998560214;4658.7437690926645;4672.509386514367;4729.668923175344;4786.44955830084;10019.549120289605;10040.497975101216;10070.798584028278;10080.899191007997;10082.798344033079;5083.288339632454;5276.1030624793875;5285.867853303698;5290.232916227125;5292.52367286946;4849.75751212438;4917.926231106536;4920.6309526785635;5092;5215.348081489814;4067.8169482373364;4097.749742101411;4138.710290279711;4144.626983571493;4150.979245103816;1200.5737963023175;1201.0331682995097;1205.6322821539516;1207.8671346151916;1217.9756404871853;955.145145095136;972.8929817720045;977.6822532676908;985.5170966226498;988.0958922585897;6407.455366293824;6446.5165112615805;6499.3175716549085;6501.187351581052;6862.553933994274;480.97114173149726;482.1923278508484;500.7220992349281;506.1345099879248;507.51532286666145;4593.724376537419;4597.103564804831;4680.087382960358;4714;4719;12025.398730063636;12413;12418.254904705747;12426.689332766753;12462.81305780414;11770;12135.817962730565;12191.329476878856;12486.12597118193;12541.372931353395;9001.729948101567;9227.677031303872;9248;9249.815003700023;9256.8611470828;6321.304656487875;6462.547621666438;6553.803385898431;6595.241547222131;6661.600303981777;10501.579936802442;10543.26197166191;10711.036006759428;10718.946405268236;10862.511186996762;10876.347419154876;11170.329780213213;11186.888131118585;11201.103911686883;11319;7359.080114985627;8422.494650321001;8698.47809131454;8848.690295839615;9067.863982040406;9709.077637624414;9766.07222313879;9766.85349719769;9823.410595364301;9826.361286516354;8276.710315138942;8376.916230837614;8411.4112012161;8496.362772791941;8731.781705457415;8400.117987611457;8418.158184181533;8588.22705956467;8593.65625374978;8769.693060742844;8053.31546818527;8173.18268173178;8176.264136227768;8195.139510351328;8202.548859812767;5029.547340739205;5517.806876759455;5541.861453463695;5684.545236380997;5727.7422515986045;5393.191021346829;5599.356074051536;5611.3266408031295;5714.685692286964;5828.067509198508 06:17:25 INFO - PROCESS | 5155 | |4;prototype.html;354.45944933975693;358.64494150790716;362.7678285897026;366.69930656861385;370.5405297431186;5557.555395568355;5613.270274864272;5618.5786066045;5641.802536911209;5694;5451.945480545193;5525.917111243324;5605.1872478490695;5621.353544342402;5632.324121105463;4367;4370.858279443066;4392.89017774555;4402.185595664796;4408.823647054114;4377.584129507692;4384.276594361926;4389.670774691895;4393.714408563433;4412.382266482695;4345.066445431784;4360.912781744363;4363.192809330269;4382.517923028464;4384.649228061763;4014.658754005913;4279.529251782302;4297.4413326267695;4311.6335111515245;4370.3007518797;3752.4934133891848;3776.9622303776887;3794.3739283018267;3794.867179648699;3810.447485114643;5288.92066619001;5308.8141915033175;5348.946510534884;5350.3312085989255;5359.1425371940695;4658.324542941288;4938.654294199408;4952.900941981176;4957.454679985199;4968.2114438802;5771.278590176228;5801.274840644919;5816.185733997244;5818.2145410369485;5829.562782791308;4138.337865941465;4142.5028996520305;4146.274401979672;4207.905944454464;4209.557996410364;5756.453136951983;5820.894030134261;5903.527717782567;5951.22634057574;6031.125486804389;4114.4365141246135;4155.335146376565;4168.541460439349;4181.84999125243;4246.787660616957;4319.827206911751;4345.97827010863;4351.521332653406;4375.343698445258;4386.495553011445;4814.15752243356;4931.6321306619;4989.478209146245;4991.950080499221;4999.175136102503;5814.156947242626;5831.446012628793;5839.357670656224;5846.269216347957;5851.707414629337;1489.4116823854733;1492.1793013842343;1493.8207415110257;1500.8274048484564;1501.0093338396605;932.7621456528542;951.6716732727198;955.0898203592815;964.392432767352;981.3817295104038;5064.0756512525;5142.280080788692;5150.459201783834;5157.948420515821;5183.367239319602;5372.570194384518;5378.865528361744;5379.838604841861;5398.40746979642;5405.972970135124;4891.779869905863;4910.803567857246;5088.592912566985;5090.516400941905;5106.617003724661;2835.333696581302;2842.445723083979;2842.928926776847;2844.7581955533597;2864.871080801369;5489.752961116759;5507.284053073075;5509.283793106871;5519.206257966177;5533.916991245134;5453.618246722692;5646.971765141148;6150.354212807591;6175.382461753788;6203.348648391944;6256;6266.843328916813;6284.811455656338;6311.873762524816;6313.494920406357;5909.261342332208;6055.608034826131;6069.969650151721;6090.046327531232;6103.664298463627;5977.432143946318;5998.610090344114;5998.98017337045;6011.458968692664;6014.578979471395;6012.939870601238;6143.815685529441;6208.503319734501;6251.499880009497;6275.780347687809;4400.537943516013;4409.911801764011;4418;4423.358613001161;4437.267850804581;5759.222504961776;5961.344252132175;5991.221141251784;5994.970025149846;6003.309619393825;5808.796692115756;5848.590598658053;5883.117272536512;5890.263717035371;5896.233489646319;5859.853503662443;5860.677662728591;5865.677387743715;5871.530277577869;5879.470847623735;5613.550915926798;5780.150351887356;5794.725979821387;5806.216160818235;5808.448197421239;5832.562557808096;5889.499392551681;5898.64608123514;5937.287525496795;5944;5464.26232458613;5775.595708300379;5776.364599893925;5779.942200577941;5794.739236734273 06:17:25 INFO - PROCESS | 5155 | |5;yui.html;734.867723809714;764.438137968593;824.7566967744515;861.2980420956919;888.3293113699154;16182.919085404572;16705;16721.414750483735;17030.318787248525;17437.91281043593;15837.92081039596;15841.366345346172;15940.442084527043;15998;16002.75995860063;726.8037629839953;864.8097418567936;889.4574309671095;892.9107089291051;897.2328658996562;899.8470260055806;900.7748062984253;902.8284625921054;903.1645727701849;904.7014485219862;778.2451022508158;951.5004622573135;954.4511905654242;954.5895265036032;955.7276176289758;795.4908858330673;802.1978021978022;900.9504477253748;908.5729707037682;910.4446287764458;675.9222689390684;681.4684546054086;681.9727210911558;682.0723815610766;682.3688088518101;15132.092074475457;15148.697026059417;15170.089794612359;15190.772138417933;15197.924010379988;14883.702325953529;14942.252887355697;14969;15036;15049.774253386207;13582.59252222435;13639.659008524766;13695.109817861807;13709.931450342785;14064.367103480368;4756.9286460703115;4790.880227994328;4803.1114243864995;4830.178869592178;4877.804887804484;78867.6056619719;78932.60533697295;80861.59569202176;81200;82204.17795822024;12336.691582710324;12468.625941221597;12503.74992500145;12520.436580353906;12573.748525029449;22348.106075757114;22357;22376.88811555932;22398.216062437736;22404;8858.601362938683;8898.777530561658;8904.332175086894;8928.15182557656;8982.326325525612;5001.199808030698;5035.0685123252315;5082.059818933435;5091.363579552556;5221.660592061504;3573.6962358199844;3649.489071529988;3651.397519409321;3686.852525898934;3692;691.8927566227243;718.1705130574195;722.642292065431;724.4964749499047;734.4454936522998;645.583598578914;682.2461180395592;734.4711807498593;762.5158024654273;784.372501998399;9383.202427793578;9743.220542356594;9990.400575965465;10037.548310326052;10165.796684066278;671.1979184874126;745.9850802984018;762.5882023707247;763.5266134996338;791.647716766045;4806.49531799163;5028.823991160365;5049.6212784041345;5081.695098294114;5093.8726531837;76511;114447.42776286065;125445;126977;130510;79782.6010869942;81104;107284;107905.46047269713;108354;96010;96373;97447;97555.51222243985;100525;8937.687180948635;9409.153176214173;9445.905540944503;9526;9973;53575.19637205367;53634;54917.72541137269;55209.171862422896;56829;76245;78380.82247902796;78888;80156;80749.59625201837;10423.739406514898;11797.115216358636;11934.820977685167;12117.27296362221;12619.873801262238;13565.457381704622;13678.247696376795;13804;13928;13956.092853964867;12653.810192846931;13390.263535505252;13471.865281347453;13600.591982240549;13960.58118256454;13301.26843023643;13441.596752097452;13547.79678304846;14017.088889222168;14129.364178611782;12325.876741232472;12683.492660293485;12886.484540618645;13575.592732218049;14160.433582656578;10682.305650132717;10698.41158736277;10865.674029779118;11027.0075693188;11078.667639970814;10981.780364392827;11131.734625004847;11272.323660580063;11276.154288428565;11398.430078496207 06:17:25 INFO - PROCESS | 5155 | __end_tp_report 06:17:25 INFO - PROCESS | 5155 | __start_cc_report 06:17:25 INFO - PROCESS | 5155 | _x_x_mozilla_cycle_collect,897 06:17:25 INFO - PROCESS | 5155 | __end_cc_report 06:17:25 INFO - PROCESS | 5155 | __startTimestamp1467033445105__endTimestamp 06:17:25 INFO - PROCESS | 5155 | 06:17:25 INFO - PROCESS | 5155 | ------- Summary: start ------- 06:17:25 INFO - PROCESS | 5155 | Number of tests: 6 06:17:25 INFO - PROCESS | 5155 | 06:17:25 INFO - PROCESS | 5155 | [#0] dojo.html Cycles:165 Average:5561.43 Median:5738.66 stddev:619.18 (10.8%) stddev-sans-first:596.10 06:17:25 INFO - PROCESS | 5155 | Values: 3342.0 3360.7 3367.5 3393.5 3416.5 5499.7 5597.4 5603.6 5612.2 5635.0 5562.8 5634.4 5637.4 5649.2 5656.0 4969.0 5091.7 5107.1 5152.8 5190.9 4955.4 5056.2 5098.0 5108.9 5111.0 5026.7 5030.4 5082.2 5088.1 5136.3 5162.1 5199.1 5202.3 5206.8 5235.1 4961.9 4996.3 5029.9 5092.3 5094.8 5354.9 5363.4 5367.5 5374.9 5406.6 5946.4 5999.9 6003.8 6004.6 6005.3 5985.0 6000.3 6057.8 6070.8 6098.3 5691.9 5733.2 5738.7 5746.8 5749.3 5967.5 6214.8 6228.4 6230.3 6233.8 5772.5 5775.2 5802.8 5900.3 5905.3 5945.1 5948.3 5948.6 5983.4 5985.3 5766.5 5835.8 5898.9 5904.0 5913.2 5886.9 5983.5 5983.6 5987.0 6022.6 4564.5 4573.9 4574.2 4577.5 4602.6 4011.1 4039.5 4080.8 4101.4 4142.8 5682.2 5706.1 5707.3 5717.2 5731.9 6017.2 6021.7 6023.2 6024.6 6054.0 5595.6 5623.1 5653.5 5666.0 5687.1 5167.7 5168.0 5172.9 5174.2 5179.8 6200.8 6225.6 6227.2 6227.8 6231.6 5865.4 5972.6 6020.2 6026.3 6077.4 6242.4 6269.4 6275.3 6279.4 6280.5 5734.9 5926.5 5928.1 5932.5 5968.9 5925.6 5936.2 5990.3 6021.1 6023.8 5835.0 5868.0 5869.9 5878.6 5881.7 5702.1 5726.8 5808.8 5852.7 5872.4 5662.7 5727.4 5731.7 5732.8 5753.3 5854.2 5862.5 5882.7 5887.7 5892.8 5617.0 5638.4 5656.9 5745.6 5766.3 06:17:25 INFO - PROCESS | 5155 | 06:17:25 INFO - PROCESS | 5155 | [#1] ext.html Cycles:180 Average:60344.92 Median:213296.50 stddev:115794.85 (54.3%) stddev-sans-first:116032.75 06:17:25 INFO - PROCESS | 5155 | Values: 584.6 636.5 645.7 656.1 658.1 32122.8 45218.5 46143.3 46197.0 46203.3 48741.0 49190.0 49201.8 49232.5 49382.0 8552.5 9217.2 9404.4 11046.1 11301.1 11097.3 11195.3 11209.8 11217.5 11221.3 11238.8 11240.8 11308.3 11309.9 11326.2 8546.3 11024.2 11282.9 11301.2 11303.9 10812.7 10877.8 10880.9 11200.1 11213.8 45486.5 45685.5 45941.0 46083.5 46140.1 3681.9 3693.8 3954.4 4171.4 4519.8 34586.0 35563.0 35602.6 35804.6 35902.5 4645.3 4669.3 4699.7 4745.5 4827.9 357623.0 359894.0 360037.0 360071.0 360289.0 39227.0 40162.4 69608.3 69999.0 70309.0 41714.0 41831.4 41918.8 41953.0 42018.0 15279.5 16383.5 16527.4 16533.4 16542.4 13245.7 13460.7 13485.1 13767.4 13783.2 9481.6 9499.8 9503.2 9549.6 9577.0 3606.7 3637.5 3667.9 3681.9 3699.6 1057.8 1093.2 1172.8 1177.3 1190.6 34447.1 34486.5 34493.2 34787.8 34936.5 1117.3 1133.1 1139.9 1226.2 1228.2 17404.7 17910.2 18187.0 18358.4 18363.4 531077.0 536212.0 537845.0 537941.0 541038.0 65472.7 67031.3 67293.7 67314.7 67361.0 1361.8 1402.3 1442.7 1475.1 1499.3 33675.0 35199.5 35324.5 35917.6 35951.8 54521.7 54833.7 55077.0 55204.4 55337.0 387958.0 397446.0 397932.0 398789.0 399146.0 28236.4 30354.5 31013.2 32760.0 32836.5 52005.7 53220.5 53511.0 54152.2 54624.2 43512.5 43728.0 44008.3 44645.3 45352.3 43498.0 43983.3 44103.3 44615.3 45655.8 43577.0 44655.8 44886.0 45187.5 45269.0 37004.6 38635.0 39042.2 39345.6 39566.8 29372.0 29473.6 30013.7 30061.8 30070.5 06:17:25 INFO - PROCESS | 5155 | 06:17:25 INFO - PROCESS | 5155 | [#2] jquery.html Cycles:180 Average:28170.84 Median:2143.50 stddev:72334.45 (3374.6%) stddev-sans-first:72507.39 06:17:25 INFO - PROCESS | 5155 | Values: 434.6 438.8 442.3 444.4 453.8 19106.1 20048.0 20721.5 21071.1 21114.8 19889.2 20334.4 20391.2 20405.6 20420.1 5625.1 5819.7 5858.1 5877.4 5878.9 4138.4 5338.4 5739.9 6267.1 6424.9 6373.2 6415.0 6428.8 6449.8 6484.7 6319.2 6326.1 6419.3 6422.9 6489.4 5796.1 5805.0 5832.6 5840.7 5841.9 23749.0 23755.8 23943.4 24386.9 24414.9 2296.8 2352.0 2356.8 2361.6 2503.9 14488.4 14990.9 15070.5 15306.7 15648.3 2036.0 2112.2 2128.6 2143.2 2188.4 60025.7 61910.7 74403.6 75280.6 77628.0 11234.7 11331.1 11374.2 11561.8 11629.9 16091.3 16178.1 16232.3 16297.6 16302.4 8553.2 8718.7 8740.9 8790.9 8860.2 8386.9 8398.6 8409.5 8438.8 8600.4 6866.0 7101.9 7121.9 7130.2 7158.2 2038.5 2054.8 2081.7 2082.3 2143.8 980.6 1049.5 1082.8 1111.5 1134.5 19961.9 20380.2 20581.7 20717.6 20897.7 1049.1 1055.9 1072.6 1127.0 1127.3 11554.4 11931.3 11960.8 11995.9 12061.1 375661.0 439985.0 446712.0 457692.0 457818.0 89476.6 101874.5 104278.5 106870.0 107159.5 1012.6 1071.2 1096.9 1111.7 1119.6 17413.7 17543.7 17871.7 18222.4 18275.7 40031.0 41542.4 41877.4 42835.1 43516.3 60388.4 61312.7 61817.4 62275.7 63416.4 8079.6 8598.4 9159.8 9192.6 9460.9 11742.4 13933.1 14293.0 14332.8 14359.3 11815.3 11944.2 12388.0 12470.3 12713.6 11919.8 12295.7 12339.3 12435.1 12492.9 12618.0 12659.9 12693.9 12779.4 12870.3 8144.4 8263.3 8555.9 8576.8 8741.7 11901.8 12180.8 12409.4 12451.9 12503.7 06:17:25 INFO - PROCESS | 5155 | 06:17:25 INFO - PROCESS | 5155 | [#3] mootools.html Cycles:180 Average:6299.38 Median:481.58 stddev:3686.32 (765.5%) stddev-sans-first:3678.86 06:17:25 INFO - PROCESS | 5155 | Values: 1478.3 1543.5 1568.7 1846.7 1999.1 9170.9 9558.4 9589.6 9916.2 9973.7 9357.0 9566.7 9567.0 9571.2 9572.5 2115.9 2416.6 2500.4 2510.0 2556.2 2489.2 2504.2 2513.8 2519.9 2520.3 2384.6 2405.7 2407.1 2407.4 2411.8 2155.6 2449.8 2524.1 2527.6 2533.0 2421.2 2429.1 2431.9 2443.1 2447.7 9711.8 9764.6 9768.4 9774.8 9793.2 5501.9 5677.2 5678.4 5682.4 5685.5 3650.9 3697.7 3782.5 3829.3 3850.0 1171.1 1185.1 1196.3 1220.5 1229.2 13156.9 13560.3 13582.7 14038.9 14046.0 4631.3 4658.7 4672.5 4729.7 4786.4 10019.5 10040.5 10070.8 10080.9 10082.8 5083.3 5276.1 5285.9 5290.2 5292.5 4849.8 4917.9 4920.6 5092.0 5215.3 4067.8 4097.7 4138.7 4144.6 4151.0 1200.6 1201.0 1205.6 1207.9 1218.0 955.1 972.9 977.7 985.5 988.1 6407.5 6446.5 6499.3 6501.2 6862.6 481.0 482.2 500.7 506.1 507.5 4593.7 4597.1 4680.1 4714.0 4719.0 12025.4 12413.0 12418.3 12426.7 12462.8 11770.0 12135.8 12191.3 12486.1 12541.4 9001.7 9227.7 9248.0 9249.8 9256.9 6321.3 6462.5 6553.8 6595.2 6661.6 10501.6 10543.3 10711.0 10718.9 10862.5 10876.3 11170.3 11186.9 11201.1 11319.0 7359.1 8422.5 8698.5 8848.7 9067.9 9709.1 9766.1 9766.9 9823.4 9826.4 8276.7 8376.9 8411.4 8496.4 8731.8 8400.1 8418.2 8588.2 8593.7 8769.7 8053.3 8173.2 8176.3 8195.1 8202.5 5029.5 5517.8 5541.9 5684.5 5727.7 5393.2 5599.4 5611.3 5714.7 5828.1 06:17:25 INFO - PROCESS | 5155 | 06:17:25 INFO - PROCESS | 5155 | [#4] prototype.html Cycles:180 Average:4844.80 Median:5452.78 stddev:1429.21 (26.2%) stddev-sans-first:1392.91 06:17:25 INFO - PROCESS | 5155 | Values: 354.5 358.6 362.8 366.7 370.5 5557.6 5613.3 5618.6 5641.8 5694.0 5451.9 5525.9 5605.2 5621.4 5632.3 4367.0 4370.9 4392.9 4402.2 4408.8 4377.6 4384.3 4389.7 4393.7 4412.4 4345.1 4360.9 4363.2 4382.5 4384.6 4014.7 4279.5 4297.4 4311.6 4370.3 3752.5 3777.0 3794.4 3794.9 3810.4 5288.9 5308.8 5348.9 5350.3 5359.1 4658.3 4938.7 4952.9 4957.5 4968.2 5771.3 5801.3 5816.2 5818.2 5829.6 4138.3 4142.5 4146.3 4207.9 4209.6 5756.5 5820.9 5903.5 5951.2 6031.1 4114.4 4155.3 4168.5 4181.8 4246.8 4319.8 4346.0 4351.5 4375.3 4386.5 4814.2 4931.6 4989.5 4992.0 4999.2 5814.2 5831.4 5839.4 5846.3 5851.7 1489.4 1492.2 1493.8 1500.8 1501.0 932.8 951.7 955.1 964.4 981.4 5064.1 5142.3 5150.5 5157.9 5183.4 5372.6 5378.9 5379.8 5398.4 5406.0 4891.8 4910.8 5088.6 5090.5 5106.6 2835.3 2842.4 2842.9 2844.8 2864.9 5489.8 5507.3 5509.3 5519.2 5533.9 5453.6 5647.0 6150.4 6175.4 6203.3 6256.0 6266.8 6284.8 6311.9 6313.5 5909.3 6055.6 6070.0 6090.0 6103.7 5977.4 5998.6 5999.0 6011.5 6014.6 6012.9 6143.8 6208.5 6251.5 6275.8 4400.5 4409.9 4418.0 4423.4 4437.3 5759.2 5961.3 5991.2 5995.0 6003.3 5808.8 5848.6 5883.1 5890.3 5896.2 5859.9 5860.7 5865.7 5871.5 5879.5 5613.6 5780.2 5794.7 5806.2 5808.4 5832.6 5889.5 5898.6 5937.3 5944.0 5464.3 5775.6 5776.4 5779.9 5794.7 06:17:25 INFO - PROCESS | 5155 | 06:17:25 INFO - PROCESS | 5155 | [#5] yui.html Cycles:180 Average:21576.44 Median:4939.50 stddev:31228.29 (632.2%) stddev-sans-first:31276.68 06:17:25 INFO - PROCESS | 5155 | Values: 734.9 764.4 824.8 861.3 888.3 16182.9 16705.0 16721.4 17030.3 17437.9 15837.9 15841.4 15940.4 15998.0 16002.8 726.8 864.8 889.5 892.9 897.2 899.8 900.8 902.8 903.2 904.7 778.2 951.5 954.5 954.6 955.7 795.5 802.2 901.0 908.6 910.4 675.9 681.5 682.0 682.1 682.4 15132.1 15148.7 15170.1 15190.8 15197.9 14883.7 14942.3 14969.0 15036.0 15049.8 13582.6 13639.7 13695.1 13709.9 14064.4 4756.9 4790.9 4803.1 4830.2 4877.8 78867.6 78932.6 80861.6 81200.0 82204.2 12336.7 12468.6 12503.7 12520.4 12573.7 22348.1 22357.0 22376.9 22398.2 22404.0 8858.6 8898.8 8904.3 8928.2 8982.3 5001.2 5035.1 5082.1 5091.4 5221.7 3573.7 3649.5 3651.4 3686.9 3692.0 691.9 718.2 722.6 724.5 734.4 645.6 682.2 734.5 762.5 784.4 9383.2 9743.2 9990.4 10037.5 10165.8 671.2 746.0 762.6 763.5 791.6 4806.5 5028.8 5049.6 5081.7 5093.9 76511.0 114447.4 125445.0 126977.0 130510.0 79782.6 81104.0 107284.0 107905.5 108354.0 96010.0 96373.0 97447.0 97555.5 100525.0 8937.7 9409.2 9445.9 9526.0 9973.0 53575.2 53634.0 54917.7 55209.2 56829.0 76245.0 78380.8 78888.0 80156.0 80749.6 10423.7 11797.1 11934.8 12117.3 12619.9 13565.5 13678.2 13804.0 13928.0 13956.1 12653.8 13390.3 13471.9 13600.6 13960.6 13301.3 13441.6 13547.8 14017.1 14129.4 12325.9 12683.5 12886.5 13575.6 14160.4 10682.3 10698.4 10865.7 11027.0 11078.7 10981.8 11131.7 11272.3 11276.2 11398.4 06:17:25 INFO - PROCESS | 5155 | -------- Summary: end -------- 06:17:25 INFO - PROCESS | 5155 | 06:17:25 INFO - TEST-INFO | 5155: exit 0 06:17:25 INFO - TEST-OK | dromaeo_css | took 1111957ms 06:17:25 INFO - TEST-START | kraken 06:17:25 INFO - operating with platform_type : linux_ 06:17:25 INFO - Initialising browser for kraken test... 06:17:25 INFO - TEST-INFO | started process 5345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi2BEPR/profile http://localhost:41233/getInfo.html) 06:17:29 INFO - PROCESS | 5345 | __metrics Screen width/height:1600/1200 06:17:29 INFO - PROCESS | 5345 | colorDepth:24 06:17:29 INFO - PROCESS | 5345 | Browser inner width/height: 1024/697 06:17:29 INFO - PROCESS | 5345 | __metrics 06:17:30 ERROR - PROCESS | 5345 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:17:30 INFO - PROCESS | 5345 | console.error: PushService: 06:17:30 INFO - PROCESS | 5345 | stateChangeProcessEnqueue: Error transitioning state 06:17:30 INFO - PROCESS | 5345 | UnknownError 06:17:30 INFO - TEST-INFO | 5345: exit 0 06:17:30 INFO - Browser initialized. 06:17:30 INFO - Running cycle 1/1 for kraken test... 06:17:30 INFO - TEST-INFO | started process 5437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi2BEPR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:17:42 INFO - PROCESS | 5437 | RSS: Main: 145780736 06:17:42 INFO - PROCESS | 5437 | 06:17:45 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:41233/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41233/tests/kraken/driver.html?testName=audio-beat-detection) 06:17:46 INFO - PROCESS | 5437 | RSS: Main: 194457600 06:17:46 INFO - PROCESS | 5437 | 06:17:48 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:41233/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41233/tests/kraken/driver.html?testName=audio-dft) 06:17:49 INFO - PROCESS | 5437 | RSS: Main: 192053248 06:17:49 INFO - PROCESS | 5437 | 06:17:52 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:41233/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41233/tests/kraken/driver.html?testName=audio-fft) 06:17:52 INFO - PROCESS | 5437 | RSS: Main: 278908928 06:17:52 INFO - PROCESS | 5437 | 06:17:54 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:41233/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41233/tests/kraken/driver.html?testName=audio-oscillator) 06:17:55 INFO - PROCESS | 5437 | RSS: Main: 187490304 06:17:55 INFO - PROCESS | 5437 | 06:17:57 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:41233/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41233/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:17:58 INFO - PROCESS | 5437 | RSS: Main: 188547072 06:17:58 INFO - PROCESS | 5437 | 06:18:01 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:41233/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41233/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:01 INFO - PROCESS | 5437 | RSS: Main: 222957568 06:18:01 INFO - PROCESS | 5437 | 06:18:05 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:41233/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41233/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:05 INFO - PROCESS | 5437 | RSS: Main: 224313344 06:18:05 INFO - PROCESS | 5437 | 06:18:08 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:41233/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41233/tests/kraken/driver.html?testName=json-parse-financial) 06:18:09 INFO - PROCESS | 5437 | RSS: Main: 223121408 06:18:09 INFO - PROCESS | 5437 | 06:18:10 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:41233/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41233/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:11 INFO - PROCESS | 5437 | RSS: Main: 201637888 06:18:11 INFO - PROCESS | 5437 | 06:18:12 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:41233/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41233/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:13 INFO - PROCESS | 5437 | RSS: Main: 201883648 06:18:13 INFO - PROCESS | 5437 | 06:18:15 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:41233/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41233/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:16 INFO - PROCESS | 5437 | RSS: Main: 209186816 06:18:16 INFO - PROCESS | 5437 | 06:18:18 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:41233/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:19 INFO - PROCESS | 5437 | RSS: Main: 216088576 06:18:19 INFO - PROCESS | 5437 | 06:18:21 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:41233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:18:22 INFO - PROCESS | 5437 | RSS: Main: 218189824 06:18:22 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | Cycle 1(1): loaded http://localhost:41233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41233/tests/kraken/driver.html?testName=ai-astar) 06:18:24 INFO - PROCESS | 5437 | RSS: Main: 260063232 06:18:24 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | __start_tp_report 06:18:24 INFO - PROCESS | 5437 | _x_x_mozilla_page_load 06:18:24 INFO - PROCESS | 5437 | _x_x_mozilla_page_load_details 06:18:24 INFO - PROCESS | 5437 | |i|pagename|runs| 06:18:24 INFO - PROCESS | 5437 | |0;ai-astar;110;104;108;109;109;110;108;108;109;108 06:18:24 INFO - PROCESS | 5437 | |1;audio-beat-detection;159;122;131;193;130;126;124;158;157;125 06:18:24 INFO - PROCESS | 5437 | |2;audio-dft;161;163;162;160;160;161;160;162;163;161 06:18:24 INFO - PROCESS | 5437 | |3;audio-fft;76;74;74;119;74;76;75;76;98;75 06:18:24 INFO - PROCESS | 5437 | |4;audio-oscillator;84;85;119;84;84;85;126;83;84;123 06:18:24 INFO - PROCESS | 5437 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;117 06:18:24 INFO - PROCESS | 5437 | |6;imaging-darkroom;145;145;145;145;146;146;147;146;145;145 06:18:24 INFO - PROCESS | 5437 | |7;imaging-desaturate;95;95;96;94;95;95;95;95;95;96 06:18:24 INFO - PROCESS | 5437 | |8;json-parse-financial;49;51;52;51;51;51;54;55;50;51 06:18:24 INFO - PROCESS | 5437 | |9;json-stringify-tinderbox;61;61;62;62;60;60;60;61;61;60 06:18:24 INFO - PROCESS | 5437 | |10;stanford-crypto-aes;77;76;75;76;77;77;77;82;109;81 06:18:24 INFO - PROCESS | 5437 | |11;stanford-crypto-ccm;126;123;130;125;118;123;120;129;124;120 06:18:24 INFO - PROCESS | 5437 | |12;stanford-crypto-pbkdf2;156;159;156;163;156;155;161;155;155;163 06:18:24 INFO - PROCESS | 5437 | |13;stanford-crypto-sha256-iterative;64;62;63;63;62;65;61;61;64;61 06:18:24 INFO - PROCESS | 5437 | __end_tp_report 06:18:24 INFO - PROCESS | 5437 | __start_cc_report 06:18:24 INFO - PROCESS | 5437 | _x_x_mozilla_cycle_collect,1600 06:18:24 INFO - PROCESS | 5437 | __end_cc_report 06:18:24 INFO - PROCESS | 5437 | __startTimestamp1467033504483__endTimestamp 06:18:24 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | ------- Summary: start ------- 06:18:24 INFO - PROCESS | 5437 | Number of tests: 14 06:18:24 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | [#0] ai-astar Cycles:10 Average:108.30 Median:109.00 stddev:1.70 (1.6%) stddev-sans-first:1.69 06:18:24 INFO - PROCESS | 5437 | Values: 110.0 104.0 108.0 109.0 109.0 110.0 108.0 108.0 109.0 108.0 06:18:24 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:144.00 stddev:23.34 (16.2%) stddev-sans-first:23.98 06:18:24 INFO - PROCESS | 5437 | Values: 159.0 122.0 131.0 193.0 130.0 126.0 124.0 158.0 157.0 125.0 06:18:24 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.16 (0.7%) stddev-sans-first:1.22 06:18:24 INFO - PROCESS | 5437 | Values: 161.0 163.0 162.0 160.0 160.0 161.0 160.0 162.0 163.0 161.0 06:18:24 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.50 stddev:14.99 (19.9%) stddev-sans-first:15.76 06:18:24 INFO - PROCESS | 5437 | Values: 76.0 74.0 74.0 119.0 74.0 76.0 75.0 76.0 98.0 75.0 06:18:24 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:84.00 stddev:18.69 (22.3%) stddev-sans-first:19.34 06:18:24 INFO - PROCESS | 5437 | Values: 84.0 85.0 119.0 84.0 84.0 85.0 126.0 83.0 84.0 123.0 06:18:24 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:18:24 INFO - PROCESS | 5437 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 06:18:24 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 06:18:24 INFO - PROCESS | 5437 | Values: 145.0 145.0 145.0 145.0 146.0 146.0 147.0 146.0 145.0 145.0 06:18:24 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:18:24 INFO - PROCESS | 5437 | Values: 95.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 95.0 96.0 06:18:24 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.00 stddev:1.78 (3.5%) stddev-sans-first:1.64 06:18:24 INFO - PROCESS | 5437 | Values: 49.0 51.0 52.0 51.0 51.0 51.0 54.0 55.0 50.0 51.0 06:18:24 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 06:18:24 INFO - PROCESS | 5437 | Values: 61.0 61.0 62.0 62.0 60.0 60.0 60.0 61.0 61.0 60.0 06:18:24 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:77.00 stddev:10.19 (13.2%) stddev-sans-first:10.72 06:18:24 INFO - PROCESS | 5437 | Values: 77.0 76.0 75.0 76.0 77.0 77.0 77.0 82.0 109.0 81.0 06:18:24 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:124.50 stddev:3.88 (3.1%) stddev-sans-first:4.03 06:18:24 INFO - PROCESS | 5437 | Values: 126.0 123.0 130.0 125.0 118.0 123.0 120.0 129.0 124.0 120.0 06:18:24 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.90 Median:157.50 stddev:3.31 (2.1%) stddev-sans-first:3.44 06:18:24 INFO - PROCESS | 5437 | Values: 156.0 159.0 156.0 163.0 156.0 155.0 161.0 155.0 155.0 163.0 06:18:24 INFO - PROCESS | 5437 | 06:18:24 INFO - PROCESS | 5437 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.43 (2.3%) stddev-sans-first:1.42 06:18:24 INFO - PROCESS | 5437 | Values: 64.0 62.0 63.0 63.0 62.0 65.0 61.0 61.0 64.0 61.0 06:18:24 INFO - PROCESS | 5437 | -------- Summary: end -------- 06:18:24 INFO - PROCESS | 5437 | 06:18:25 INFO - TEST-INFO | 5437: exit 0 06:18:25 INFO - TEST-OK | kraken | took 59662ms 06:18:25 INFO - SUITE-END | took 1171s 06:18:25 INFO - Completed test suite (00:19:31) 06:18:25 INFO - javascript benchmark 06:18:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3342.0475164578093, 3360.663933606641, 3367.494875768634, 3393.507941348506, 3416.4533674612067, 5499.7250137493165, 5597.356304025038, 5603.60774745768, 5612.242347283115, 5635.0420428527095, 5562.7774889004495, 5634.3520495143075, 5637.3517045539775, 5649.1526271059365, 5656.038473459512, 4968.950310496903, 5091.694498330094, 5107.106256405133, 5152.845414637567, 5190.870228244286, 4955.380577427822, 5056.19100943849, 5097.974510127444, 5108.872278193037, 5111.0, 5026.698398096126, 5030.396352437712, 5082.161443361841, 5088.058709138802, 5136.332276804011, 5162.096633089213, 5199.064168449678, 5202.297689811902, 5206.828169687781, 5235.110031294689, 4961.925571116436, 4996.325496058058, 5029.874253143664, 5092.3125378073855, 5094.847154585332, 5354.946450535523, 5363.436839131874, 5367.5169234769055, 5374.946250537484, 5406.621536492447, 5946.375630558816, 5999.910001349939, 6003.849903752441, 6004.609700369462, 6005.279366476007, 5985.042393217064, 6000.33996260411, 6057.818265452043, 6070.817875463743, 6098.298695650013, 5691.9146212806845, 5733.168690539848, 5738.6556806591325, 5746.79886203985, 5749.338826034976, 5967.522598192134, 6214.751409943642, 6228.408301211378, 6230.345813689497, 6233.812985610439, 5772.538196944234, 5775.249217601685, 5802.82591522255, 5900.321463031721, 5905.320888097924, 5945.10823376497, 5948.256467941507, 5948.643081415129, 5983.431574000463, 5985.311689155716, 5766.481016708516, 5835.824925252249, 5898.911516327258, 5904.0, 5913.172155898178, 5886.882262354815, 5983.491403230687, 5983.640981541122, 5986.970065149646, 6022.608530445507, 4564.452265728134, 4573.885652858705, 4574.222382195035, 4577.496475387705, 4602.562756538124, 4011.097503061846, 4039.4546736190237, 4080.775557344315, 4101.364288535282, 4142.834286628501, 5682.176084467729, 5706.058500347479, 5707.315122185281, 5717.199592057115, 5731.885362292731, 6017.217761690952, 6021.6989150542295, 6023.216981792339, 6024.608400453956, 6054.031354983182, 5595.63628364155, 5623.128415095667, 5653.462921022497, 5665.971670141623, 5687.118496633028, 5167.6641018333685, 5168.01807656544, 5172.870678232999, 5174.24973378858, 5179.8446046618665, 6200.7519699211525, 6225.564210505221, 6227.159333490012, 6227.750889964442, 6231.594946328474, 5865.4134586541, 5972.641641501524, 6020.217371741645, 6026.276846778239, 6077.4226448487325, 6242.406971337716, 6269.404406581368, 6275.309715931336, 6279.434850863444, 6280.497560195082, 5734.856628584152, 5926.525877929842, 5928.140419639214, 5932.466078052996, 5968.880622387441, 5925.555583331354, 5936.1986131871645, 5990.34106248321, 6021.096835474714, 6023.789167379121, 5834.970825145847, 5867.970660146672, 5869.911951320648, 5878.647281162973, 5881.705914704333, 5702.144678298123, 5726.828195154152, 5808.796692115925, 5852.678102704393, 5872.442117998783, 5662.716864156693, 5727.427257274239, 5731.713414329183, 5732.828015159552, 5753.280839895013, 5854.151148083419, 5862.472377486047, 5882.676452794966, 5887.735051922588, 5892.823215303548, 5616.971915140398, 5638.436156384329, 5656.886862262814, 5745.597808153389, 5766.3368712598585], "value": 5521.21011877161, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.5820238529451, 636.5416899832119, 645.6642545876144, 656.1044174701532, 658.1476987301444, 32122.83938580307, 45218.547814521844, 46143.30785038227, 46197.0, 46203.306950395774, 48741.0, 49190.0, 49201.753991230085, 49232.50767492324, 49382.0, 8552.486850788942, 9217.170454659063, 9404.435733855957, 11046.116310695124, 11301.095912327035, 11097.278676886017, 11195.328280303207, 11209.775804483905, 11217.495212715447, 11221.326720396803, 11238.775224495505, 11240.831387529193, 11308.321500709942, 11309.943450282737, 11326.150538709588, 8546.31629469641, 11024.228304018721, 11282.887171128348, 11301.152413569016, 11303.943480282545, 10812.72968175794, 10877.782444351147, 10880.945595272053, 11200.103991680728, 11213.831792523119, 45486.54513454889, 45685.54314456846, 45941.0, 46083.53916460826, 46140.07719845618, 3681.9263614727824, 3693.759905606127, 3954.406838974177, 4171.436856024428, 4519.84180553679, 34586.0, 35563.0, 35602.64397356019, 35804.64195358065, 35902.46146307808, 4645.349651048856, 4669.299605059235, 4699.694519856198, 4745.501722319142, 4827.927581086286, 357623.0, 359894.0, 360037.0, 360071.0, 360289.0, 39227.0, 40162.39756403656, 69608.30391696018, 69999.0, 70309.0, 41714.0, 41831.37252941208, 41918.790406048385, 41953.0, 42018.0, 15279.465218717292, 16383.508494745176, 16527.421540246276, 16533.421330253623, 16542.42101526441, 13245.73508529824, 13460.730785384238, 13485.123466974615, 13767.449302027806, 13783.241921694404, 9481.620735170654, 9499.762505937408, 9503.192228660502, 9549.618015279311, 9577.042295770367, 3606.6753992140307, 3637.4722616501135, 3667.8716244931834, 3681.9079523011605, 3699.574548926908, 1057.830747080479, 1093.2456604942565, 1172.7713095946208, 1177.3289225141586, 1190.6249531397582, 34447.13882152966, 34486.48270275948, 34493.21318694443, 34787.826060869535, 34936.475952860725, 1117.3461048898712, 1133.0595605647459, 1139.9316041037398, 1226.1600803449664, 1228.2078059651653, 17404.65190696179, 17910.194041268172, 18187.0, 18358.35745748919, 18363.35728249505, 531077.0, 536212.0, 537845.0, 537941.0, 541038.0, 65472.69054618881, 67031.32968670348, 67293.663531683, 67314.66342668256, 67361.0, 1361.8025386318927, 1402.2638114989509, 1442.6753980354547, 1475.144416238579, 1499.2803454341758, 33675.0, 35199.47200792041, 35324.47013294854, 35917.640823592475, 35951.82024089967, 54521.72739136437, 54833.72583137059, 55077.0, 55204.44795551993, 55337.0, 387958.0, 397446.0, 397932.0, 398789.0, 399146.0, 28236.43527129405, 30354.54468182935, 31013.224669383446, 32760.0, 32836.507452387756, 52005.73997130142, 53220.4677953231, 53511.0, 54152.187717183486, 54624.18063729127, 43512.516206243905, 43728.0, 44008.339874902544, 44645.330320045876, 45352.31971520364, 43498.0, 43983.340249896915, 44103.33844992392, 44615.27758452793, 45655.77172114118, 43577.0, 44655.776721116184, 44886.0, 45187.54812451833, 45269.0, 37004.629953701195, 38635.0, 39042.21915561616, 39345.60654393534, 39566.766933714636, 29371.971980980565, 29473.55789663114, 30013.69986300109, 30061.849690752282, 30070.548941765453], "value": 20674.71119628494, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.6023388599431, 438.8354367112333, 442.3298702465763, 444.373433458823, 453.8411555955414, 19106.140223689934, 20048.0, 20721.481962950915, 21071.051802668877, 21114.788852111473, 19889.20443182271, 20334.389968300973, 20391.184352625878, 20405.591888162227, 20420.081096350663, 5625.071863142576, 5819.709014549277, 5858.091995740667, 5877.441643043904, 5878.853028674296, 4138.379243113542, 5338.359396872381, 5739.856503587402, 6267.091271765591, 6424.871502569946, 6373.171487706615, 6414.9679251603675, 6428.8071357859335, 6449.774257900975, 6484.708188131545, 6319.17850679411, 6326.145970293997, 6419.325970773071, 6422.935770642304, 6489.383508566679, 5796.13058041293, 5805.0, 5832.591718579701, 5840.678762668052, 5841.948449279128, 23749.0, 23755.76244237553, 23943.401414964592, 24386.87806560956, 24414.877925610435, 2296.7588403217756, 2351.9647205291935, 2356.8468049576722, 2361.622140457536, 2503.912363067284, 14488.420463181461, 14990.850091499055, 15070.472533461276, 15306.693866122616, 15648.295826687712, 2035.989820050905, 2112.2290364017176, 2128.638131517646, 2143.217725530186, 2188.387251569547, 60025.699871500365, 61910.69044654748, 74403.62798186029, 75280.62359688221, 77628.0, 11234.719132021764, 11331.093512518979, 11374.20380573352, 11561.76876462466, 11629.88370116305, 16091.275892584861, 16178.11020393866, 16232.269547870374, 16297.59256018609, 16302.429414970657, 8553.230209281195, 8718.65125394977, 8740.912590874137, 8790.91209087901, 8860.158284963047, 8386.916130838736, 8398.580070996548, 8409.453385529921, 8438.831223375499, 8600.354973377021, 6865.965670171717, 7101.89347159793, 7121.857562848714, 7130.180029296594, 7158.2125966143685, 2038.541328201143, 2054.753429588429, 2081.739782527184, 2082.33461169703, 2143.774903635127, 980.5734505490135, 1049.5382031905938, 1082.8105081610686, 1111.5387114347454, 1134.5461815273957, 19961.85315956436, 20380.18479260813, 20581.69127463089, 20717.58564828695, 20897.686534701686, 1049.0610903241557, 1055.9419231942318, 1072.6460268111505, 1126.9744532475409, 1127.3461392392392, 11554.364509952033, 11931.343776092399, 11960.820587691192, 11995.88004119965, 12061.095417843697, 375661.0, 439985.0, 446712.0, 457692.0, 457818.0, 89476.55261723649, 101874.49062754787, 104278.47860760648, 106870.0, 107159.46420268004, 1012.5696578953915, 1071.239420011785, 1096.8519249901162, 1111.6942840718866, 1119.64171465132, 17413.738793918354, 17543.736843947096, 17871.73192402141, 18222.36221732233, 18275.725864112315, 40031.0, 41542.376864347665, 41877.37183942182, 42835.143297134506, 43516.34725479057, 60388.396116038275, 61312.69343653432, 61817.38182618116, 62275.688621556605, 63416.36583634289, 8079.596020198849, 8598.355123365647, 9159.771005724644, 9192.632294708405, 9460.905390946002, 11742.412879356169, 13933.094348867291, 14293.0, 14332.785008225093, 14359.282035898372, 11815.291082535075, 11944.223625464318, 12388.0, 12470.251784892573, 12713.55502557406, 11919.761604767682, 12295.69260768488, 12339.259644421363, 12435.129540932048, 12492.937535312265, 12618.0, 12659.873401266237, 12693.873061269269, 12779.424925878544, 12870.292133932724, 8144.429889907887, 8263.338932885235, 8555.91444085576, 8576.785580360542, 8741.694040708544, 11901.821472677744, 12180.817287740514, 12409.379531023593, 12451.948518766301, 12503.749925001632], "value": 9844.201821078417, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.3495262084675, 1543.459789073824, 1568.7411577089779, 1846.7229915512671, 1999.1203870297068, 9170.908290917088, 9558.42649441034, 9589.568469418875, 9916.206703463724, 9973.650922217725, 9357.0, 9566.712998610054, 9567.0, 9571.2343012559, 9572.47351395673, 2115.8518903676672, 2416.5770990076753, 2500.362407586063, 2509.962350564743, 2556.2203527923975, 2489.2158969924417, 2504.2362079565723, 2513.7988960883176, 2519.8740062996867, 2520.2943175910773, 2384.5946189147885, 2405.675233843435, 2407.1093695332665, 2407.3981504623844, 2411.770881766229, 2155.644318687415, 2449.8162637802147, 2524.116559204282, 2527.633493143502, 2532.9994652112314, 2421.2010036687852, 2429.125514814665, 2431.8662473563945, 2443.0716327795326, 2447.730749617541, 9711.757206069835, 9764.609415623367, 9768.36505627132, 9774.75563110928, 9793.167580755644, 5501.9174712379345, 5677.176809362661, 5678.4037676044245, 5682.374938756733, 5685.545156387479, 3650.945235821438, 3697.7411581189326, 3782.508273924372, 3829.291581057513, 3850.0182453474185, 1171.1158075652913, 1185.146694380045, 1196.2642974570663, 1220.4751956658633, 1229.1580267516779, 13156.934215328862, 13560.254186019765, 13582.728345433135, 14038.859611403857, 14046.0, 4631.258998560214, 4658.7437690926645, 4672.509386514367, 4729.668923175344, 4786.44955830084, 10019.549120289605, 10040.497975101216, 10070.798584028278, 10080.899191007997, 10082.798344033079, 5083.288339632454, 5276.1030624793875, 5285.867853303698, 5290.232916227125, 5292.52367286946, 4849.75751212438, 4917.926231106536, 4920.6309526785635, 5092.0, 5215.348081489814, 4067.8169482373364, 4097.749742101411, 4138.710290279711, 4144.626983571493, 4150.979245103816, 1200.5737963023175, 1201.0331682995097, 1205.6322821539516, 1207.8671346151916, 1217.9756404871853, 955.145145095136, 972.8929817720045, 977.6822532676908, 985.5170966226498, 988.0958922585897, 6407.455366293824, 6446.5165112615805, 6499.3175716549085, 6501.187351581052, 6862.553933994274, 480.97114173149726, 482.1923278508484, 500.7220992349281, 506.1345099879248, 507.51532286666145, 4593.724376537419, 4597.103564804831, 4680.087382960358, 4714.0, 4719.0, 12025.398730063636, 12413.0, 12418.254904705747, 12426.689332766753, 12462.81305780414, 11770.0, 12135.817962730565, 12191.329476878856, 12486.12597118193, 12541.372931353395, 9001.729948101567, 9227.677031303872, 9248.0, 9249.815003700023, 9256.8611470828, 6321.304656487875, 6462.547621666438, 6553.803385898431, 6595.241547222131, 6661.600303981777, 10501.579936802442, 10543.26197166191, 10711.036006759428, 10718.946405268236, 10862.511186996762, 10876.347419154876, 11170.329780213213, 11186.888131118585, 11201.103911686883, 11319.0, 7359.080114985627, 8422.494650321001, 8698.47809131454, 8848.690295839615, 9067.863982040406, 9709.077637624414, 9766.07222313879, 9766.85349719769, 9823.410595364301, 9826.361286516354, 8276.710315138942, 8376.916230837614, 8411.4112012161, 8496.362772791941, 8731.781705457415, 8400.117987611457, 8418.158184181533, 8588.22705956467, 8593.65625374978, 8769.693060742844, 8053.31546818527, 8173.18268173178, 8176.264136227768, 8195.139510351328, 8202.548859812767, 5029.547340739205, 5517.806876759455, 5541.861453463695, 5684.545236380997, 5727.7422515986045, 5393.191021346829, 5599.356074051536, 5611.3266408031295, 5714.685692286964, 5828.067509198508], "value": 4895.385279833033, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.45944933975693, 358.64494150790716, 362.7678285897026, 366.69930656861385, 370.5405297431186, 5557.555395568355, 5613.270274864272, 5618.5786066045, 5641.802536911209, 5694.0, 5451.945480545193, 5525.917111243324, 5605.1872478490695, 5621.353544342402, 5632.324121105463, 4367.0, 4370.858279443066, 4392.89017774555, 4402.185595664796, 4408.823647054114, 4377.584129507692, 4384.276594361926, 4389.670774691895, 4393.714408563433, 4412.382266482695, 4345.066445431784, 4360.912781744363, 4363.192809330269, 4382.517923028464, 4384.649228061763, 4014.658754005913, 4279.529251782302, 4297.4413326267695, 4311.6335111515245, 4370.3007518797, 3752.4934133891848, 3776.9622303776887, 3794.3739283018267, 3794.867179648699, 3810.447485114643, 5288.92066619001, 5308.8141915033175, 5348.946510534884, 5350.3312085989255, 5359.1425371940695, 4658.324542941288, 4938.654294199408, 4952.900941981176, 4957.454679985199, 4968.2114438802, 5771.278590176228, 5801.274840644919, 5816.185733997244, 5818.2145410369485, 5829.562782791308, 4138.337865941465, 4142.5028996520305, 4146.274401979672, 4207.905944454464, 4209.557996410364, 5756.453136951983, 5820.894030134261, 5903.527717782567, 5951.22634057574, 6031.125486804389, 4114.4365141246135, 4155.335146376565, 4168.541460439349, 4181.84999125243, 4246.787660616957, 4319.827206911751, 4345.97827010863, 4351.521332653406, 4375.343698445258, 4386.495553011445, 4814.15752243356, 4931.6321306619, 4989.478209146245, 4991.950080499221, 4999.175136102503, 5814.156947242626, 5831.446012628793, 5839.357670656224, 5846.269216347957, 5851.707414629337, 1489.4116823854733, 1492.1793013842343, 1493.8207415110257, 1500.8274048484564, 1501.0093338396605, 932.7621456528542, 951.6716732727198, 955.0898203592815, 964.392432767352, 981.3817295104038, 5064.0756512525, 5142.280080788692, 5150.459201783834, 5157.948420515821, 5183.367239319602, 5372.570194384518, 5378.865528361744, 5379.838604841861, 5398.40746979642, 5405.972970135124, 4891.779869905863, 4910.803567857246, 5088.592912566985, 5090.516400941905, 5106.617003724661, 2835.333696581302, 2842.445723083979, 2842.928926776847, 2844.7581955533597, 2864.871080801369, 5489.752961116759, 5507.284053073075, 5509.283793106871, 5519.206257966177, 5533.916991245134, 5453.618246722692, 5646.971765141148, 6150.354212807591, 6175.382461753788, 6203.348648391944, 6256.0, 6266.843328916813, 6284.811455656338, 6311.873762524816, 6313.494920406357, 5909.261342332208, 6055.608034826131, 6069.969650151721, 6090.046327531232, 6103.664298463627, 5977.432143946318, 5998.610090344114, 5998.98017337045, 6011.458968692664, 6014.578979471395, 6012.939870601238, 6143.815685529441, 6208.503319734501, 6251.499880009497, 6275.780347687809, 4400.537943516013, 4409.911801764011, 4418.0, 4423.358613001161, 4437.267850804581, 5759.222504961776, 5961.344252132175, 5991.221141251784, 5994.970025149846, 6003.309619393825, 5808.796692115756, 5848.590598658053, 5883.117272536512, 5890.263717035371, 5896.233489646319, 5859.853503662443, 5860.677662728591, 5865.677387743715, 5871.530277577869, 5879.470847623735, 5613.550915926798, 5780.150351887356, 5794.725979821387, 5806.216160818235, 5808.448197421239, 5832.562557808096, 5889.499392551681, 5898.64608123514, 5937.287525496795, 5944.0, 5464.26232458613, 5775.595708300379, 5776.364599893925, 5779.942200577941, 5794.739236734273], "value": 4393.06402878761, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.867723809714, 764.438137968593, 824.7566967744515, 861.2980420956919, 888.3293113699154, 16182.919085404572, 16705.0, 16721.414750483735, 17030.318787248525, 17437.91281043593, 15837.92081039596, 15841.366345346172, 15940.442084527043, 15998.0, 16002.75995860063, 726.8037629839953, 864.8097418567936, 889.4574309671095, 892.9107089291051, 897.2328658996562, 899.8470260055806, 900.7748062984253, 902.8284625921054, 903.1645727701849, 904.7014485219862, 778.2451022508158, 951.5004622573135, 954.4511905654242, 954.5895265036032, 955.7276176289758, 795.4908858330673, 802.1978021978022, 900.9504477253748, 908.5729707037682, 910.4446287764458, 675.9222689390684, 681.4684546054086, 681.9727210911558, 682.0723815610766, 682.3688088518101, 15132.092074475457, 15148.697026059417, 15170.089794612359, 15190.772138417933, 15197.924010379988, 14883.702325953529, 14942.252887355697, 14969.0, 15036.0, 15049.774253386207, 13582.59252222435, 13639.659008524766, 13695.109817861807, 13709.931450342785, 14064.367103480368, 4756.9286460703115, 4790.880227994328, 4803.1114243864995, 4830.178869592178, 4877.804887804484, 78867.6056619719, 78932.60533697295, 80861.59569202176, 81200.0, 82204.17795822024, 12336.691582710324, 12468.625941221597, 12503.74992500145, 12520.436580353906, 12573.748525029449, 22348.106075757114, 22357.0, 22376.88811555932, 22398.216062437736, 22404.0, 8858.601362938683, 8898.777530561658, 8904.332175086894, 8928.15182557656, 8982.326325525612, 5001.199808030698, 5035.0685123252315, 5082.059818933435, 5091.363579552556, 5221.660592061504, 3573.6962358199844, 3649.489071529988, 3651.397519409321, 3686.852525898934, 3692.0, 691.8927566227243, 718.1705130574195, 722.642292065431, 724.4964749499047, 734.4454936522998, 645.583598578914, 682.2461180395592, 734.4711807498593, 762.5158024654273, 784.372501998399, 9383.202427793578, 9743.220542356594, 9990.400575965465, 10037.548310326052, 10165.796684066278, 671.1979184874126, 745.9850802984018, 762.5882023707247, 763.5266134996338, 791.647716766045, 4806.49531799163, 5028.823991160365, 5049.6212784041345, 5081.695098294114, 5093.8726531837, 76511.0, 114447.42776286065, 125445.0, 126977.0, 130510.0, 79782.6010869942, 81104.0, 107284.0, 107905.46047269713, 108354.0, 96010.0, 96373.0, 97447.0, 97555.51222243985, 100525.0, 8937.687180948635, 9409.153176214173, 9445.905540944503, 9526.0, 9973.0, 53575.19637205367, 53634.0, 54917.72541137269, 55209.171862422896, 56829.0, 76245.0, 78380.82247902796, 78888.0, 80156.0, 80749.59625201837, 10423.739406514898, 11797.115216358636, 11934.820977685167, 12117.27296362221, 12619.873801262238, 13565.457381704622, 13678.247696376795, 13804.0, 13928.0, 13956.092853964867, 12653.810192846931, 13390.263535505252, 13471.865281347453, 13600.591982240549, 13960.58118256454, 13301.26843023643, 13441.596752097452, 13547.79678304846, 14017.088889222168, 14129.364178611782, 12325.876741232472, 12683.492660293485, 12886.484540618645, 13575.592732218049, 14160.433582656578, 10682.305650132717, 10698.41158736277, 10865.674029779118, 11027.0075693188, 11078.667639970814, 10981.780364392827, 11131.734625004847, 11272.323660580063, 11276.154288428565, 11398.430078496207], "value": 7901.227653284103, "unit": "score"}], "name": "dromaeo_css", "value": 7588.53063401314, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 108.0, 109.0, 109.0, 110.0, 108.0, 108.0, 109.0, 108.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 122.0, 131.0, 193.0, 130.0, 126.0, 124.0, 158.0, 157.0, 125.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 160.0, 160.0, 161.0, 160.0, 162.0, 163.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 119.0, 74.0, 76.0, 75.0, 76.0, 98.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 119.0, 84.0, 84.0, 85.0, 126.0, 83.0, 84.0, 123.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 147.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 51.0, 52.0, 51.0, 51.0, 51.0, 54.0, 55.0, 50.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 60.0, 60.0, 60.0, 61.0, 61.0, 60.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 76.0, 77.0, 77.0, 77.0, 82.0, 109.0, 81.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 123.0, 130.0, 125.0, 118.0, 123.0, 120.0, 129.0, 124.0, 120.0], "value": 123.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 156.0, 163.0, 156.0, 155.0, 161.0, 155.0, 155.0, 163.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 63.0, 62.0, 65.0, 61.0, 61.0, 64.0, 61.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1484.2, "alertThreshold": 2.0}]} 06:18:25 INFO - Return code: 0 06:18:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:18:25 ERROR - # TBPL SUCCESS # 06:18:25 INFO - Running post-action listener: _resource_record_post_action 06:18:25 INFO - ##### 06:18:25 INFO - ##### Finished run-tests step (success) 06:18:25 INFO - ##### 06:18:25 INFO - Running post-run listener: _resource_record_post_run 06:18:25 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 270336; Write bytes: 508727296; Read time: 200; Write time: 358276 06:18:25 INFO - TinderboxPrint: CPU usage
13.1% 06:18:25 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 200 06:18:25 INFO - TinderboxPrint: I/O write bytes / time
508,727,296 / 358,276 06:18:25 INFO - TinderboxPrint: CPU idle
8,247.8 (86.9%) 06:18:25 INFO - TinderboxPrint: CPU user
1,198.6 (12.6%) 06:18:25 INFO - TinderboxPrint: Swap in / out
0 / 0 06:18:25 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 260382720; Read time: 0; Write time: 213544 06:18:25 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 270336; Write bytes: 248344576; Read time: 200; Write time: 144732 06:18:26 INFO - Running post-run listener: _upload_blobber_files 06:18:26 INFO - Blob upload gear active. 06:18:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:18:26 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 06:18:26 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:18:26 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:18:26 INFO - (blobuploader) - INFO - Open directory for files ... 06:18:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:18:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:18:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:27 INFO - (blobuploader) - INFO - Done attempting. 06:18:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:18:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:18:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:31 INFO - (blobuploader) - INFO - Done attempting. 06:18:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:18:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:18:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:32 INFO - (blobuploader) - INFO - Done attempting. 06:18:32 INFO - (blobuploader) - INFO - Iteration through files over. 06:18:32 INFO - Return code: 0 06:18:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:18:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:18:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f06aae89b05732cccde8b191b35f38de31aa12930b0a0610044b5830db0821dd4483569433a697fb2ac62d45b4dd3135f2d257b367e60b8df324633cf62726b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/545b001647c6eb1f94dd84814e6f23460ec5aba4e2f4fae01a8d34f6cbb2c64a0a52008ae3dc15b72f55ef9b5eeb4ad627e5ecc21b13a8c173cc0a0caef60dc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1024c85eef65fc0ee22f0d41838744ade552f47c7e2f9ffc63223f4e65c5d78cfb369794776a1a2063bef7ac37c0679464463c99b74e44d798a6ef57d85173dd"} 06:18:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:18:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:18:32 INFO - Contents: 06:18:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f06aae89b05732cccde8b191b35f38de31aa12930b0a0610044b5830db0821dd4483569433a697fb2ac62d45b4dd3135f2d257b367e60b8df324633cf62726b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/545b001647c6eb1f94dd84814e6f23460ec5aba4e2f4fae01a8d34f6cbb2c64a0a52008ae3dc15b72f55ef9b5eeb4ad627e5ecc21b13a8c173cc0a0caef60dc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1024c85eef65fc0ee22f0d41838744ade552f47c7e2f9ffc63223f4e65c5d78cfb369794776a1a2063bef7ac37c0679464463c99b74e44d798a6ef57d85173dd"} 06:18:32 INFO - Running post-run listener: copy_logs_to_upload_dir 06:18:32 INFO - Copying logs to upload dir... 06:18:32 INFO - mkdir: /builds/slave/test/build/upload/logs 06:18:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.508839 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-27 06:18:32.297774) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:18:32.301233) ========= 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=923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f06aae89b05732cccde8b191b35f38de31aa12930b0a0610044b5830db0821dd4483569433a697fb2ac62d45b4dd3135f2d257b367e60b8df324633cf62726b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/545b001647c6eb1f94dd84814e6f23460ec5aba4e2f4fae01a8d34f6cbb2c64a0a52008ae3dc15b72f55ef9b5eeb4ad627e5ecc21b13a8c173cc0a0caef60dc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1024c85eef65fc0ee22f0d41838744ade552f47c7e2f9ffc63223f4e65c5d78cfb369794776a1a2063bef7ac37c0679464463c99b74e44d798a6ef57d85173dd"} build_url:https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f06aae89b05732cccde8b191b35f38de31aa12930b0a0610044b5830db0821dd4483569433a697fb2ac62d45b4dd3135f2d257b367e60b8df324633cf62726b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/545b001647c6eb1f94dd84814e6f23460ec5aba4e2f4fae01a8d34f6cbb2c64a0a52008ae3dc15b72f55ef9b5eeb4ad627e5ecc21b13a8c173cc0a0caef60dc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1024c85eef65fc0ee22f0d41838744ade552f47c7e2f9ffc63223f4e65c5d78cfb369794776a1a2063bef7ac37c0679464463c99b74e44d798a6ef57d85173dd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:18:32.326229) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:18:32.326610) ========= 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=923d835db2ba3686ebe126b700000192-1467032280.456028-1997198241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:18:32.409350) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:18:32.409694) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:18:32.410052) ========= ========= Total master_lag: 0.17 =========