builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1467112591.82 results: success (0) buildid: 20160628011243 builduid: 64df821e7e064754a8719cb36275fac5 revision: f6a7c43fb847 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 04:16:31.820148) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 04:16:31.820742) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 04:16:31.821015) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 04:16:31.849388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:16:31.849759) ========= 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=df17445c3590ff7897617a0e00000225-1467112513.481295-677044372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 04:16:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-06-28 04:16:32 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130932 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:16:31.995545) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:16:31.995885) ========= 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=df17445c3590ff7897617a0e00000225-1467112513.481295-677044372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020320 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:16:32.046164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 04:16:32.046587) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f6a7c43fb847 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f6a7c43fb847 --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=df17445c3590ff7897617a0e00000225-1467112513.481295-677044372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 04:16:32,462 Setting DEBUG logging. 2016-06-28 04:16:32,462 attempt 1/10 2016-06-28 04:16:32,462 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f6a7c43fb847?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 04:16:33,899 unpacking tar archive at: mozilla-inbound-f6a7c43fb847/testing/mozharness/ program finished with exit code 0 elapsedTime=1.790186 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 04:16:33.850727) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 04:16:33.851075) ========= script_repo_revision: f6a7c43fb847 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 04:16:33.851483) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 04:16:33.851966) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 04:16:33.863566) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-28 04:16:33.864029) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=df17445c3590ff7897617a0e00000225-1467112513.481295-677044372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:16:34 INFO - MultiFileLogger online at 20160628 04:16:34 in /builds/slave/test 04:16:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:16:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:16:34 INFO - {'append_to_log': False, 04:16:34 INFO - 'base_work_dir': '/builds/slave/test', 04:16:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:16:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:16:34 INFO - 'branch': 'Mozilla-Inbound', 04:16:34 INFO - 'buildbot_json_path': 'buildprops.json', 04:16:34 INFO - 'config_files': ('talos/linux_config.py',), 04:16:34 INFO - 'default_actions': ('clobber', 04:16:34 INFO - 'read-buildbot-config', 04:16:34 INFO - 'download-and-extract', 04:16:34 INFO - 'populate-webroot', 04:16:34 INFO - 'create-virtualenv', 04:16:34 INFO - 'install', 04:16:34 INFO - 'run-tests'), 04:16:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:16:34 INFO - 'download_minidump_stackwalk': True, 04:16:34 INFO - 'download_symbols': 'ondemand', 04:16:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:16:34 INFO - 'tooltool.py': '/tools/tooltool.py', 04:16:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:16:34 INFO - '/tools/misc-python/virtualenv.py')}, 04:16:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:16:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:16:34 INFO - 'installer_path': 'installer.exe', 04:16:34 INFO - 'log_level': 'info', 04:16:34 INFO - 'log_name': 'talos', 04:16:34 INFO - 'log_to_console': True, 04:16:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:16:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:16:34 INFO - 'opt_config_files': (), 04:16:34 INFO - 'pip_index': False, 04:16:34 INFO - 'sps_profile': False, 04:16:34 INFO - 'sps_profile_interval': 0, 04:16:34 INFO - 'suite': 'dromaeojs', 04:16:34 INFO - 'system_bits': '32', 04:16:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:16:34 INFO - 'title': 'talos-linux64-ix-021', 04:16:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:16:34 INFO - 'use_talos_json': True, 04:16:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:16:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:16:34 INFO - 'work_dir': 'build'} 04:16:34 INFO - ##### 04:16:34 INFO - ##### Running clobber step. 04:16:34 INFO - ##### 04:16:34 INFO - Running pre-action listener: _resource_record_pre_action 04:16:34 INFO - Running main action method: clobber 04:16:34 INFO - rmtree: /builds/slave/test/build 04:16:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:16:34 INFO - Running post-action listener: _resource_record_post_action 04:16:34 INFO - ##### 04:16:34 INFO - ##### Finished clobber step (success) 04:16:34 INFO - ##### 04:16:34 INFO - ##### 04:16:34 INFO - ##### Running read-buildbot-config step. 04:16:34 INFO - ##### 04:16:34 INFO - Running pre-action listener: _resource_record_pre_action 04:16:34 INFO - Running main action method: read_buildbot_config 04:16:34 INFO - Using buildbot properties: 04:16:34 INFO - { 04:16:34 INFO - "project": "", 04:16:34 INFO - "product": "firefox", 04:16:34 INFO - "script_repo_revision": "production", 04:16:34 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:16:34 INFO - "repository": "", 04:16:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:16:34 INFO - "buildid": "20160628011243", 04:16:34 INFO - "pgo_build": "True", 04:16:34 INFO - "basedir": "/builds/slave/test", 04:16:34 INFO - "buildnumber": 1181, 04:16:34 INFO - "slavename": "talos-linux64-ix-021", 04:16:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:16:34 INFO - "platform": "ubuntu64_hw", 04:16:34 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:16:34 INFO - "branch": "mozilla-inbound", 04:16:34 INFO - "repo_path": "integration/mozilla-inbound", 04:16:34 INFO - "revision": "f6a7c43fb847", 04:16:34 INFO - "stage_platform": "linux64-pgo", 04:16:34 INFO - "builduid": "64df821e7e064754a8719cb36275fac5", 04:16:34 INFO - "slavebuilddir": "test" 04:16:34 INFO - } 04:16:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:16:34 INFO - Running post-action listener: _resource_record_post_action 04:16:34 INFO - ##### 04:16:34 INFO - ##### Finished read-buildbot-config step (success) 04:16:34 INFO - ##### 04:16:34 INFO - ##### 04:16:34 INFO - ##### Running download-and-extract step. 04:16:34 INFO - ##### 04:16:34 INFO - Running pre-action listener: _resource_record_pre_action 04:16:34 INFO - Running main action method: download_and_extract 04:16:34 INFO - mkdir: /builds/slave/test/build/tests 04:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:34 INFO - https://queue.taskcluster.net/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:16:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:16:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:16:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:16:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:16:36 INFO - Downloaded 1361 bytes. 04:16:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:16:36 INFO - Using the following test package requirements: 04:16:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:16:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:16:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:36 INFO - u'jsshell-linux-x86_64.zip'], 04:16:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:16:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:16:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:16:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:16:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:16:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:16:36 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')]} 04:16:36 INFO - https://queue.taskcluster.net/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:16:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:16:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:16:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:16:38 INFO - Downloaded 24282877 bytes. 04:16:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:16:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:16:39 INFO - Return code: 0 04:16:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:39 INFO - https://queue.taskcluster.net/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:16:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:16:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:16:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:16:46 INFO - Downloaded 24282877 bytes. 04:16:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:16:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:16:47 INFO - Return code: 0 04:16:47 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')]} 04:16:47 INFO - https://queue.taskcluster.net/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:16:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:16:48 INFO - Downloaded 14405240 bytes. 04:16:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:16:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:16:48 INFO - Return code: 0 04:16:48 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')]} 04:16:48 INFO - https://queue.taskcluster.net/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:16:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:16:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:16:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:16:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:16:50 INFO - Downloaded 60326177 bytes. 04:16:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:16:50 INFO - mkdir: /builds/slave/test/properties 04:16:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:16:50 INFO - Writing to file /builds/slave/test/properties/build_url 04:16:50 INFO - Contents: 04:16:50 INFO - build_url:https://queue.taskcluster.net/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:16:50 INFO - Running post-action listener: _resource_record_post_action 04:16:50 INFO - Running post-action listener: set_extra_try_arguments 04:16:50 INFO - ##### 04:16:50 INFO - ##### Finished download-and-extract step (success) 04:16:50 INFO - ##### 04:16:50 INFO - ##### 04:16:50 INFO - ##### Running populate-webroot step. 04:16:50 INFO - ##### 04:16:50 INFO - Running pre-action listener: _resource_record_pre_action 04:16:50 INFO - Running main action method: populate_webroot 04:16:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:16:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:16:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:16:50 INFO - '--tppagecycles', 04:16:50 INFO - '7'], 04:16:50 INFO - 'tests': ['tsvgm']}}, 04:16:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:16:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:16:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:16:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:16:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:16:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:16:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:50 INFO - 'talos_options': ['--disable-e10s'], 04:16:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:50 INFO - 'talos_options': ['--disable-e10s'], 04:16:50 INFO - 'tests': ['damp', 'tps']}, 04:16:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:50 INFO - 'tests': ['damp', 'tps']}, 04:16:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:16:50 INFO - 'tests': ['dromaeo_dom']}, 04:16:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:16:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:16:50 INFO - 'tests': ['basic_compositor_video']}, 04:16:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:16:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:16:50 INFO - 'tests': ['a11yr', 04:16:50 INFO - 'ts_paint', 04:16:50 INFO - 'tpaint', 04:16:50 INFO - 'sessionrestore', 04:16:50 INFO - 'sessionrestore_no_auto_restore', 04:16:50 INFO - 'tabpaint']}, 04:16:50 INFO - 'other-e10s': {'tests': ['a11yr', 04:16:50 INFO - 'ts_paint', 04:16:50 INFO - 'tpaint', 04:16:50 INFO - 'sessionrestore', 04:16:50 INFO - 'sessionrestore_no_auto_restore', 04:16:50 INFO - 'tabpaint']}, 04:16:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:16:50 INFO - 'ts_paint', 04:16:50 INFO - 'tpaint', 04:16:50 INFO - 'sessionrestore', 04:16:50 INFO - 'sessionrestore_no_auto_restore', 04:16:50 INFO - 'tabpaint']}, 04:16:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:16:50 INFO - 'ts_paint', 04:16:50 INFO - 'tpaint', 04:16:50 INFO - 'sessionrestore', 04:16:50 INFO - 'sessionrestore_no_auto_restore', 04:16:50 INFO - 'tabpaint']}, 04:16:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:16:50 INFO - 'tests': ['a11yr', 04:16:50 INFO - 'ts_paint', 04:16:50 INFO - 'tpaint', 04:16:50 INFO - 'sessionrestore', 04:16:50 INFO - 'sessionrestore_no_auto_restore', 04:16:50 INFO - 'tabpaint']}, 04:16:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:16:50 INFO - 'tests': ['a11yr', 04:16:50 INFO - 'ts_paint', 04:16:50 INFO - 'tpaint', 04:16:50 INFO - 'sessionrestore', 04:16:50 INFO - 'sessionrestore_no_auto_restore', 04:16:50 INFO - 'tabpaint']}, 04:16:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:16:50 INFO - 'tests': ['tsvgx', 04:16:50 INFO - 'tsvgr_opacity', 04:16:50 INFO - 'tart', 04:16:50 INFO - 'tscrollx', 04:16:50 INFO - 'cart']}, 04:16:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:16:50 INFO - 'tsvgr_opacity', 04:16:50 INFO - 'tart', 04:16:50 INFO - 'tscrollx', 04:16:50 INFO - 'cart']}, 04:16:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:50 INFO - 'talos_options': ['--disable-e10s'], 04:16:50 INFO - 'tests': ['tp5o']}, 04:16:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:50 INFO - 'tests': ['tp5o']}, 04:16:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:50 INFO - 'talos_options': ['--disable-e10s', 04:16:50 INFO - '--xperf_path', 04:16:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:50 INFO - 'tests': ['tp5n']}, 04:16:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:50 INFO - 'talos_options': ['--xperf_path', 04:16:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:50 INFO - 'tests': ['tp5n']}}, 04:16:50 INFO - 'talos.zip': {'path': '', 04:16:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:16:50 INFO - Running post-action listener: _resource_record_post_action 04:16:50 INFO - ##### 04:16:50 INFO - ##### Finished populate-webroot step (success) 04:16:50 INFO - ##### 04:16:50 INFO - ##### 04:16:50 INFO - ##### Running create-virtualenv step. 04:16:50 INFO - ##### 04:16:50 INFO - Running pre-action listener: _resource_record_pre_action 04:16:50 INFO - Running main action method: create_virtualenv 04:16:50 INFO - Creating virtualenv /builds/slave/test/build/venv 04:16:50 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 04:16:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:16:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:16:51 INFO - Using real prefix '/usr' 04:16:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:16:51 INFO - Installing distribute.............................................................................................................................................................................................done. 04:16:53 INFO - Installing pip.................done. 04:16:53 INFO - Return code: 0 04:16:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:16:53 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')]} 04:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:53 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')]} 04:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:53 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 0x7f376399df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a520>, '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 0x1a2b420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b8b0>, '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': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', '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 04:16:53 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 04:16:53 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 04:16:53 INFO - Using env: {'DISPLAY': ':0', 04:16:53 INFO - 'HOME': '/home/cltbld', 04:16:53 INFO - 'LANG': 'en_US.UTF-8', 04:16:53 INFO - 'LANGUAGE': 'en_US:en', 04:16:53 INFO - 'LOGNAME': 'cltbld', 04:16:53 INFO - 'MAIL': '/var/mail/cltbld', 04:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:53 INFO - 'MOZ_NO_REMOTE': '1', 04:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:53 INFO - 'NO_EM_RESTART': '1', 04:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:53 INFO - 'PWD': '/builds/slave/test', 04:16:53 INFO - 'SHELL': '/bin/bash', 04:16:53 INFO - 'SHLVL': '1', 04:16:53 INFO - 'TERM': 'linux', 04:16:53 INFO - 'TMOUT': '86400', 04:16:53 INFO - 'USER': 'cltbld', 04:16:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', 04:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:53 INFO - '_': '/tools/buildbot/bin/python'} 04:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:53 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 04:16:53 INFO - Cleaning up... 04:16:54 INFO - Return code: 0 04:16:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:16:54 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')]} 04:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:54 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')]} 04:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:54 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 0x7f376399df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a520>, '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 0x1a2b420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b8b0>, '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': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', '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 04:16:54 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 04:16:54 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 04:16:54 INFO - Using env: {'DISPLAY': ':0', 04:16:54 INFO - 'HOME': '/home/cltbld', 04:16:54 INFO - 'LANG': 'en_US.UTF-8', 04:16:54 INFO - 'LANGUAGE': 'en_US:en', 04:16:54 INFO - 'LOGNAME': 'cltbld', 04:16:54 INFO - 'MAIL': '/var/mail/cltbld', 04:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:54 INFO - 'MOZ_NO_REMOTE': '1', 04:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:54 INFO - 'NO_EM_RESTART': '1', 04:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:54 INFO - 'PWD': '/builds/slave/test', 04:16:54 INFO - 'SHELL': '/bin/bash', 04:16:54 INFO - 'SHLVL': '1', 04:16:54 INFO - 'TERM': 'linux', 04:16:54 INFO - 'TMOUT': '86400', 04:16:54 INFO - 'USER': 'cltbld', 04:16:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', 04:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:54 INFO - '_': '/tools/buildbot/bin/python'} 04:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:54 INFO - Downloading/unpacking psutil>=3.1.1 04:16:54 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 04:16:54 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 04:16:54 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 04:16:54 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 04:16:54 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 04:16:54 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 04:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:16:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:56 INFO - Installing collected packages: psutil 04:16:56 INFO - Running setup.py install for psutil 04:16:56 INFO - building 'psutil._psutil_linux' extension 04:16:56 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 04:16:56 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 04:16:56 INFO - building 'psutil._psutil_posix' extension 04:16:56 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 04:16:56 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 04:16:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:56 INFO - Successfully installed psutil 04:16:56 INFO - Cleaning up... 04:16:56 INFO - Return code: 0 04:16:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:16:56 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')]} 04:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:56 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')]} 04:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:56 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 0x7f376399df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a520>, '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 0x1a2b420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b8b0>, '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': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', '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 04:16:56 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 04:16:56 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 04:16:56 INFO - Using env: {'DISPLAY': ':0', 04:16:56 INFO - 'HOME': '/home/cltbld', 04:16:56 INFO - 'LANG': 'en_US.UTF-8', 04:16:56 INFO - 'LANGUAGE': 'en_US:en', 04:16:56 INFO - 'LOGNAME': 'cltbld', 04:16:56 INFO - 'MAIL': '/var/mail/cltbld', 04:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:56 INFO - 'MOZ_NO_REMOTE': '1', 04:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:56 INFO - 'NO_EM_RESTART': '1', 04:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:56 INFO - 'PWD': '/builds/slave/test', 04:16:56 INFO - 'SHELL': '/bin/bash', 04:16:56 INFO - 'SHLVL': '1', 04:16:56 INFO - 'TERM': 'linux', 04:16:56 INFO - 'TMOUT': '86400', 04:16:56 INFO - 'USER': 'cltbld', 04:16:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', 04:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:56 INFO - '_': '/tools/buildbot/bin/python'} 04:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:16:56 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 04:16:56 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 04:16:56 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 04:16:56 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 04:16:56 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 04:16:56 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 04:16:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:16:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:16:58 INFO - Installing collected packages: mozsystemmonitor 04:16:58 INFO - Running setup.py install for mozsystemmonitor 04:16:58 INFO - Successfully installed mozsystemmonitor 04:16:58 INFO - Cleaning up... 04:16:59 INFO - Return code: 0 04:16:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:16:59 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')]} 04:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:59 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')]} 04:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:59 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 0x7f376399df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a520>, '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 0x1a2b420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b8b0>, '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': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', '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 04:16:59 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 04:16:59 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 04:16:59 INFO - Using env: {'DISPLAY': ':0', 04:16:59 INFO - 'HOME': '/home/cltbld', 04:16:59 INFO - 'LANG': 'en_US.UTF-8', 04:16:59 INFO - 'LANGUAGE': 'en_US:en', 04:16:59 INFO - 'LOGNAME': 'cltbld', 04:16:59 INFO - 'MAIL': '/var/mail/cltbld', 04:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:59 INFO - 'MOZ_NO_REMOTE': '1', 04:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:59 INFO - 'NO_EM_RESTART': '1', 04:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:59 INFO - 'PWD': '/builds/slave/test', 04:16:59 INFO - 'SHELL': '/bin/bash', 04:16:59 INFO - 'SHLVL': '1', 04:16:59 INFO - 'TERM': 'linux', 04:16:59 INFO - 'TMOUT': '86400', 04:16:59 INFO - 'USER': 'cltbld', 04:16:59 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', 04:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:59 INFO - '_': '/tools/buildbot/bin/python'} 04:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:59 INFO - Downloading/unpacking jsonschema==2.5.1 04:16:59 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 04:16:59 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 04:16:59 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 04:16:59 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 04:16:59 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 04:16:59 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 04:17:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:17:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:17:01 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 04:17:01 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 04:17:01 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 04:17:01 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 04:17:01 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 04:17:01 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 04:17:01 INFO - Downloading functools32-3.2.3-2.tar.gz 04:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:17:01 INFO - warning: no files found matching '*.txt' 04:17:01 INFO - no previously-included directories found matching 'build' 04:17:01 INFO - no previously-included directories found matching 'dist' 04:17:01 INFO - no previously-included directories found matching '.git*' 04:17:01 INFO - Installing collected packages: jsonschema, functools32 04:17:01 INFO - Running setup.py install for functools32 04:17:01 INFO - warning: no files found matching '*.txt' 04:17:01 INFO - no previously-included directories found matching 'build' 04:17:01 INFO - no previously-included directories found matching 'dist' 04:17:01 INFO - no previously-included directories found matching '.git*' 04:17:01 INFO - Successfully installed jsonschema functools32 04:17:01 INFO - Cleaning up... 04:17:01 INFO - Return code: 0 04:17:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:17:01 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')]} 04:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:01 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')]} 04:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:01 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 0x7f376399df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a520>, '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 0x1a2b420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b8b0>, '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': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', '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 04:17:01 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 04:17:01 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 04:17:01 INFO - Using env: {'DISPLAY': ':0', 04:17:01 INFO - 'HOME': '/home/cltbld', 04:17:01 INFO - 'LANG': 'en_US.UTF-8', 04:17:01 INFO - 'LANGUAGE': 'en_US:en', 04:17:01 INFO - 'LOGNAME': 'cltbld', 04:17:01 INFO - 'MAIL': '/var/mail/cltbld', 04:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:01 INFO - 'MOZ_NO_REMOTE': '1', 04:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:01 INFO - 'NO_EM_RESTART': '1', 04:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:01 INFO - 'PWD': '/builds/slave/test', 04:17:01 INFO - 'SHELL': '/bin/bash', 04:17:01 INFO - 'SHLVL': '1', 04:17:01 INFO - 'TERM': 'linux', 04:17:01 INFO - 'TMOUT': '86400', 04:17:01 INFO - 'USER': 'cltbld', 04:17:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', 04:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:01 INFO - '_': '/tools/buildbot/bin/python'} 04:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:01 INFO - Downloading/unpacking blobuploader==1.2.4 04:17:01 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 04:17:01 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 04:17:01 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 04:17:01 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 04:17:01 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 04:17:01 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 04:17:03 INFO - Downloading blobuploader-1.2.4.tar.gz 04:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:17:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:17:03 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 04:17:03 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 04:17:03 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 04:17:03 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 04:17:03 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 04:17:03 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 04:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:17:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:17:04 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 04:17:04 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 04:17:04 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 04:17:04 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 04:17:04 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 04:17:04 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 04:17:04 INFO - Downloading docopt-0.6.1.tar.gz 04:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:17:04 INFO - Installing collected packages: blobuploader, requests, docopt 04:17:04 INFO - Running setup.py install for blobuploader 04:17:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:17:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:17:04 INFO - Running setup.py install for requests 04:17:04 INFO - Running setup.py install for docopt 04:17:05 INFO - Successfully installed blobuploader requests docopt 04:17:05 INFO - Cleaning up... 04:17:05 INFO - Return code: 0 04:17:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:05 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')]} 04:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:05 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')]} 04:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:05 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 0x7f376399df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a520>, '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 0x1a2b420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b8b0>, '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': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', '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 04:17:05 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 04:17:05 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 04:17:05 INFO - Using env: {'DISPLAY': ':0', 04:17:05 INFO - 'HOME': '/home/cltbld', 04:17:05 INFO - 'LANG': 'en_US.UTF-8', 04:17:05 INFO - 'LANGUAGE': 'en_US:en', 04:17:05 INFO - 'LOGNAME': 'cltbld', 04:17:05 INFO - 'MAIL': '/var/mail/cltbld', 04:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:05 INFO - 'MOZ_NO_REMOTE': '1', 04:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:05 INFO - 'NO_EM_RESTART': '1', 04:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:05 INFO - 'PWD': '/builds/slave/test', 04:17:05 INFO - 'SHELL': '/bin/bash', 04:17:05 INFO - 'SHLVL': '1', 04:17:05 INFO - 'TERM': 'linux', 04:17:05 INFO - 'TMOUT': '86400', 04:17:05 INFO - 'USER': 'cltbld', 04:17:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', 04:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:05 INFO - '_': '/tools/buildbot/bin/python'} 04:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:05 INFO - Running setup.py (path:/tmp/pip-dAMm70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:05 INFO - Running setup.py (path:/tmp/pip-O4sX0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:05 INFO - Running setup.py (path:/tmp/pip-0q2Xhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:05 INFO - Running setup.py (path:/tmp/pip-Rk0PIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:05 INFO - Running setup.py (path:/tmp/pip-qGbDUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:05 INFO - Running setup.py (path:/tmp/pip-BpVB1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:05 INFO - Running setup.py (path:/tmp/pip-2gZBQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:05 INFO - Running setup.py (path:/tmp/pip-ulRVcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:05 INFO - Running setup.py (path:/tmp/pip-NGkfxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:05 INFO - Running setup.py (path:/tmp/pip-lBan8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:06 INFO - Running setup.py (path:/tmp/pip-Rsm1Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:06 INFO - Running setup.py (path:/tmp/pip-EBskwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:06 INFO - Running setup.py (path:/tmp/pip-zktJNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:06 INFO - Running setup.py (path:/tmp/pip-3yd1r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:06 INFO - Running setup.py (path:/tmp/pip-DYHgTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:06 INFO - Running setup.py (path:/tmp/pip-xr4pgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:06 INFO - Running setup.py (path:/tmp/pip-XS039l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:17:06 INFO - Running setup.py install for manifestparser 04:17:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:17:06 INFO - Running setup.py install for mozcrash 04:17:06 INFO - Running setup.py install for mozdebug 04:17:06 INFO - Running setup.py install for mozdevice 04:17:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:17:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:17:06 INFO - Running setup.py install for mozfile 04:17:07 INFO - Running setup.py install for mozhttpd 04:17:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Running setup.py install for mozinfo 04:17:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Running setup.py install for mozInstall 04:17:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Running setup.py install for mozleak 04:17:07 INFO - Running setup.py install for mozlog 04:17:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Running setup.py install for moznetwork 04:17:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Running setup.py install for mozprocess 04:17:07 INFO - Running setup.py install for mozprofile 04:17:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Running setup.py install for mozrunner 04:17:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:17:07 INFO - Running setup.py install for mozscreenshot 04:17:08 INFO - Running setup.py install for moztest 04:17:08 INFO - Running setup.py install for mozversion 04:17:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:17:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:17:08 INFO - Cleaning up... 04:17:08 INFO - Return code: 0 04:17:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17: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')]} 04:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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')]} 04:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:08 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 0x7f376399df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a520>, '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 0x1a2b420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b8b0>, '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': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', '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 04:17:08 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 04:17:08 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 04:17:08 INFO - Using env: {'DISPLAY': ':0', 04:17:08 INFO - 'HOME': '/home/cltbld', 04:17:08 INFO - 'LANG': 'en_US.UTF-8', 04:17:08 INFO - 'LANGUAGE': 'en_US:en', 04:17:08 INFO - 'LOGNAME': 'cltbld', 04:17:08 INFO - 'MAIL': '/var/mail/cltbld', 04:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:08 INFO - 'MOZ_NO_REMOTE': '1', 04:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:08 INFO - 'NO_EM_RESTART': '1', 04:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:08 INFO - 'PWD': '/builds/slave/test', 04:17:08 INFO - 'SHELL': '/bin/bash', 04:17:08 INFO - 'SHLVL': '1', 04:17:08 INFO - 'TERM': 'linux', 04:17:08 INFO - 'TMOUT': '86400', 04:17:08 INFO - 'USER': 'cltbld', 04:17:08 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', 04:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:08 INFO - '_': '/tools/buildbot/bin/python'} 04:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:08 INFO - Running setup.py (path:/tmp/pip-XMYJG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:08 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)) 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:08 INFO - Running setup.py (path:/tmp/pip-LP5GaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:08 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)) 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:08 INFO - Running setup.py (path:/tmp/pip-RSmR71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:08 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)) 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:08 INFO - Running setup.py (path:/tmp/pip-N6octq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:08 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)) 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:08 INFO - Running setup.py (path:/tmp/pip-QPgsjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:08 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)) 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:08 INFO - Running setup.py (path:/tmp/pip-h9jBxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:08 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)) 04:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:08 INFO - Running setup.py (path:/tmp/pip-WqEMIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:09 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)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:09 INFO - Running setup.py (path:/tmp/pip-mCGbGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:09 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)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:09 INFO - Running setup.py (path:/tmp/pip-PhDjW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:09 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)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:09 INFO - Running setup.py (path:/tmp/pip-l_jEMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:09 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)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:09 INFO - Running setup.py (path:/tmp/pip-_pSN27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:09 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)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:09 INFO - Running setup.py (path:/tmp/pip-wdUd2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:09 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)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:09 INFO - Running setup.py (path:/tmp/pip-fevjGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:09 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)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:09 INFO - Running setup.py (path:/tmp/pip-JUSbjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:09 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)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:09 INFO - Running setup.py (path:/tmp/pip-fRZI1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:09 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)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:09 INFO - Running setup.py (path:/tmp/pip-Ngcv01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:09 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)) 04:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:09 INFO - Running setup.py (path:/tmp/pip-SpHKyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:09 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)) 04:17:09 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)) 04:17:09 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)) 04:17:09 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)) 04:17:09 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)) 04:17:09 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)) 04:17:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:11 INFO - Downloading blessings-1.6.tar.gz 04:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:17:11 INFO - Installing collected packages: blessings 04:17:11 INFO - Running setup.py install for blessings 04:17:11 INFO - Successfully installed blessings 04:17:11 INFO - Cleaning up... 04:17:11 INFO - Return code: 0 04:17:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:17:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:12 INFO - Reading from file tmpfile_stdout 04:17:12 INFO - Current package versions: 04:17:12 INFO - argparse == 1.2.1 04:17:12 INFO - blessings == 1.6 04:17:12 INFO - blobuploader == 1.2.4 04:17:12 INFO - docopt == 0.6.1 04:17:12 INFO - functools32 == 3.2.3-2 04:17:12 INFO - jsonschema == 2.5.1 04:17:12 INFO - manifestparser == 1.1 04:17:12 INFO - mozInstall == 1.12 04:17:12 INFO - mozcrash == 0.17 04:17:12 INFO - mozdebug == 0.1 04:17:12 INFO - mozdevice == 0.48 04:17:12 INFO - mozfile == 1.2 04:17:12 INFO - mozhttpd == 0.7 04:17:12 INFO - mozinfo == 0.9 04:17:12 INFO - mozleak == 0.1 04:17:12 INFO - mozlog == 3.2 04:17:12 INFO - moznetwork == 0.27 04:17:12 INFO - mozprocess == 0.22 04:17:12 INFO - mozprofile == 0.28 04:17:12 INFO - mozrunner == 6.11 04:17:12 INFO - mozscreenshot == 0.1 04:17:12 INFO - mozsystemmonitor == 0.3 04:17:12 INFO - moztest == 0.7 04:17:12 INFO - mozversion == 1.4 04:17:12 INFO - psutil == 3.1.1 04:17:12 INFO - requests == 1.2.3 04:17:12 INFO - wsgiref == 0.1.2 04:17:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:12 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')]} 04:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:12 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')]} 04:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:12 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 0x7f376399df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a520>, '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 0x1a2b420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b8b0>, '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': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', '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 04:17:12 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 04:17:12 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 04:17:12 INFO - Using env: {'DISPLAY': ':0', 04:17:12 INFO - 'HOME': '/home/cltbld', 04:17:12 INFO - 'LANG': 'en_US.UTF-8', 04:17:12 INFO - 'LANGUAGE': 'en_US:en', 04:17:12 INFO - 'LOGNAME': 'cltbld', 04:17:12 INFO - 'MAIL': '/var/mail/cltbld', 04:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:12 INFO - 'MOZ_NO_REMOTE': '1', 04:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:12 INFO - 'NO_EM_RESTART': '1', 04:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:12 INFO - 'PWD': '/builds/slave/test', 04:17:12 INFO - 'SHELL': '/bin/bash', 04:17:12 INFO - 'SHLVL': '1', 04:17:12 INFO - 'TERM': 'linux', 04:17:12 INFO - 'TMOUT': '86400', 04:17:12 INFO - 'USER': 'cltbld', 04:17:12 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', 04:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:12 INFO - '_': '/tools/buildbot/bin/python'} 04:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:12 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)) 04:17:12 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)) 04:17:12 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)) 04:17:12 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)) 04:17:12 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)) 04:17:12 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)) 04:17:12 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)) 04:17:12 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)) 04:17:12 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)) 04:17:12 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)) 04:17:12 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)) 04:17:12 INFO - Cleaning up... 04:17:12 INFO - Return code: 0 04:17:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:17:12 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')]} 04:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:12 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')]} 04:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:12 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 0x7f376399df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a520>, '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 0x1a2b420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b8b0>, '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': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', '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 04:17:12 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 04:17:12 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 04:17:12 INFO - Using env: {'DISPLAY': ':0', 04:17:12 INFO - 'HOME': '/home/cltbld', 04:17:12 INFO - 'LANG': 'en_US.UTF-8', 04:17:12 INFO - 'LANGUAGE': 'en_US:en', 04:17:12 INFO - 'LOGNAME': 'cltbld', 04:17:12 INFO - 'MAIL': '/var/mail/cltbld', 04:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:12 INFO - 'MOZ_NO_REMOTE': '1', 04:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:12 INFO - 'NO_EM_RESTART': '1', 04:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:12 INFO - 'PWD': '/builds/slave/test', 04:17:12 INFO - 'SHELL': '/bin/bash', 04:17:12 INFO - 'SHLVL': '1', 04:17:12 INFO - 'TERM': 'linux', 04:17:12 INFO - 'TMOUT': '86400', 04:17:12 INFO - 'USER': 'cltbld', 04:17:12 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', 04:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:12 INFO - '_': '/tools/buildbot/bin/python'} 04:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:17:12 INFO - Cleaning up... 04:17:12 INFO - Return code: 0 04:17:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:17:12 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')]} 04:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:12 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')]} 04:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:12 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 0x7f376399df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a520>, '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 0x1a2b420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b8b0>, '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': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', '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 04:17:12 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 04:17:12 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 04:17:12 INFO - Using env: {'DISPLAY': ':0', 04:17:12 INFO - 'HOME': '/home/cltbld', 04:17:12 INFO - 'LANG': 'en_US.UTF-8', 04:17:12 INFO - 'LANGUAGE': 'en_US:en', 04:17:12 INFO - 'LOGNAME': 'cltbld', 04:17:12 INFO - 'MAIL': '/var/mail/cltbld', 04:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:12 INFO - 'MOZ_NO_REMOTE': '1', 04:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:12 INFO - 'NO_EM_RESTART': '1', 04:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:12 INFO - 'PWD': '/builds/slave/test', 04:17:12 INFO - 'SHELL': '/bin/bash', 04:17:12 INFO - 'SHLVL': '1', 04:17:12 INFO - 'TERM': 'linux', 04:17:12 INFO - 'TMOUT': '86400', 04:17:12 INFO - 'USER': 'cltbld', 04:17:12 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', 04:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:12 INFO - '_': '/tools/buildbot/bin/python'} 04:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:12 INFO - Downloading/unpacking flake8 04:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:17:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:17:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:17:15 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 04:17:15 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 04:17:15 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 04:17:15 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 04:17:15 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 04:17:15 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 04:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:17:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:15 INFO - no previously-included directories found matching 'docs/_build' 04:17:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:17:15 INFO - Running setup.py install for pep8 04:17:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:15 INFO - no previously-included directories found matching 'docs/_build' 04:17:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:17:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:17:15 INFO - Cleaning up... 04:17:15 INFO - Return code: 0 04:17:15 INFO - Running post-action listener: _resource_record_post_action 04:17:15 INFO - Running post-action listener: _start_resource_monitoring 04:17:15 INFO - Starting resource monitoring. 04:17:15 INFO - ##### 04:17:15 INFO - ##### Finished create-virtualenv step (success) 04:17:15 INFO - ##### 04:17:15 INFO - ##### 04:17:15 INFO - ##### Running install step. 04:17:15 INFO - ##### 04:17:15 INFO - Running pre-action listener: _resource_record_pre_action 04:17:15 INFO - Running main action method: install 04:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:15 INFO - Reading from file tmpfile_stdout 04:17:15 INFO - Detecting whether we're running mozinstall >=1.0... 04:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:17:15 INFO - Reading from file tmpfile_stdout 04:17:15 INFO - Output received: 04:17:15 INFO - Usage: mozinstall [options] installer 04:17:15 INFO - Options: 04:17:15 INFO - -h, --help show this help message and exit 04:17:15 INFO - -d DEST, --destination=DEST 04:17:15 INFO - Directory to install application into. [default: 04:17:15 INFO - "/builds/slave/test"] 04:17:15 INFO - --app=APP Application being installed. [default: firefox] 04:17:15 INFO - mkdir: /builds/slave/test/build/application 04:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:17:33 INFO - Reading from file tmpfile_stdout 04:17:33 INFO - Output received: 04:17:33 INFO - /builds/slave/test/build/application/firefox/firefox 04:17:33 INFO - Running post-action listener: _resource_record_post_action 04:17:33 INFO - ##### 04:17:33 INFO - ##### Finished install step (success) 04:17:33 INFO - ##### 04:17:33 INFO - ##### 04:17:33 INFO - ##### Running run-tests step. 04:17:33 INFO - ##### 04:17:33 INFO - Running pre-action listener: _resource_record_pre_action 04:17:33 INFO - Running main action method: run_tests 04:17:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:17:33 INFO - Python 2.7.3 04:17:33 INFO - Return code: 0 04:17:33 INFO - grabbing minidump binary from tooltool 04:17: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')]} 04:17:33 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 0x1a2a520>, '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 0x1a2b420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2b8b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:17:33 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 04:17:33 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 04:17:33 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 04:17:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:17:33 INFO - Return code: 0 04:17:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:17:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:17:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:17:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:17:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:17:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:17:34 INFO - Return code: 0 04:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 04:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 04:17:34 INFO - Using env: {'DISPLAY': ':0', 04:17:34 INFO - 'HOME': '/home/cltbld', 04:17:34 INFO - 'LANG': 'en_US.UTF-8', 04:17:34 INFO - 'LANGUAGE': 'en_US:en', 04:17:34 INFO - 'LOGNAME': 'cltbld', 04:17:34 INFO - 'MAIL': '/var/mail/cltbld', 04:17:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:17:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:34 INFO - 'MOZ_NO_REMOTE': '1', 04:17:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:34 INFO - 'NO_EM_RESTART': '1', 04:17:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:34 INFO - 'PWD': '/builds/slave/test', 04:17:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:17:34 INFO - 'SHELL': '/bin/bash', 04:17:34 INFO - 'SHLVL': '1', 04:17:34 INFO - 'TERM': 'linux', 04:17:34 INFO - 'TMOUT': '86400', 04:17:34 INFO - 'USER': 'cltbld', 04:17:34 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467112513.481295-677044372', 04:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:34 INFO - '_': '/tools/buildbot/bin/python'} 04:17:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 04:17:34 INFO - mozversion application_buildid: 20160628011243 04:17:34 INFO - mozversion application_changeset: f6a7c43fb8475ce9458ce3fb315d1d593277fade 04:17:34 INFO - mozversion application_display_name: Nightly 04:17:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:17:34 INFO - mozversion application_name: Firefox 04:17:34 INFO - mozversion application_remotingname: firefox 04:17:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:17:34 INFO - mozversion application_vendor: Mozilla 04:17:34 INFO - mozversion application_version: 50.0a1 04:17:34 INFO - mozversion platform_buildid: 20160628011243 04:17:34 INFO - mozversion platform_changeset: f6a7c43fb8475ce9458ce3fb315d1d593277fade 04:17:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:17:34 INFO - mozversion platform_version: 50.0a1 04:17:34 INFO - using testdate: 1467112654 04:17:34 INFO - actual date: 1467112654 04:17:34 INFO - starting webserver on 'localhost:49855' 04:17:34 INFO - SUITE-START | Running 2 tests 04:17:34 INFO - TEST-START | dromaeo_css 04:17:34 INFO - operating with platform_type : linux_ 04:17:34 INFO - Initialising browser for dromaeo_css test... 04:17:34 INFO - TEST-INFO | started process 7664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyVeovw/profile http://localhost:49855/getInfo.html) 04:17:39 INFO - PROCESS | 7664 | __metrics Screen width/height:1600/1200 04:17:39 INFO - PROCESS | 7664 | colorDepth:24 04:17:39 INFO - PROCESS | 7664 | Browser inner width/height: 1024/697 04:17:39 INFO - PROCESS | 7664 | __metrics 04:17:40 INFO - PROCESS | 7664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:17:40 INFO - PROCESS | 7664 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:17:41 INFO - TEST-INFO | 7664: exit 0 04:17:41 INFO - Browser initialized. 04:17:41 INFO - Running cycle 1/1 for dromaeo_css test... 04:17:41 INFO - TEST-INFO | started process 7754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyVeovw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:17:53 INFO - PROCESS | 7754 | RSS: Main: 157532160 04:17:53 INFO - PROCESS | 7754 | 04:18:44 INFO - PROCESS | 7754 | 1467112724938 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] 04:20:53 INFO - PROCESS | 7754 | Cycle 1(1): loaded http://localhost:49855/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49855/tests/dromaeo/cssquery-ext.html) 04:20:54 INFO - PROCESS | 7754 | RSS: Main: 257142784 04:20:54 INFO - PROCESS | 7754 | 04:23:56 INFO - PROCESS | 7754 | Cycle 1(1): loaded http://localhost:49855/tests/dromaeo/cssquery-ext.html (next: http://localhost:49855/tests/dromaeo/cssquery-jquery.html) 04:23:57 INFO - PROCESS | 7754 | RSS: Main: 238641152 04:23:57 INFO - PROCESS | 7754 | 04:26:59 INFO - PROCESS | 7754 | Cycle 1(1): loaded http://localhost:49855/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49855/tests/dromaeo/cssquery-mootools.html) 04:26:59 INFO - PROCESS | 7754 | RSS: Main: 242909184 04:26:59 INFO - PROCESS | 7754 | 04:30:01 INFO - PROCESS | 7754 | Cycle 1(1): loaded http://localhost:49855/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49855/tests/dromaeo/cssquery-prototype.html) 04:30:02 INFO - PROCESS | 7754 | RSS: Main: 239947776 04:30:02 INFO - PROCESS | 7754 | 04:33:04 INFO - PROCESS | 7754 | Cycle 1(1): loaded http://localhost:49855/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49855/tests/dromaeo/cssquery-yui.html) 04:33:05 INFO - PROCESS | 7754 | RSS: Main: 229896192 04:33:05 INFO - PROCESS | 7754 | 04:36:08 INFO - PROCESS | 7754 | Cycle 1(1): loaded http://localhost:49855/tests/dromaeo/cssquery-yui.html (next: http://localhost:49855/tests/dromaeo/cssquery-dojo.html) 04:36:08 INFO - PROCESS | 7754 | RSS: Main: 274317312 04:36:08 INFO - PROCESS | 7754 | 04:36:08 INFO - PROCESS | 7754 | __start_tp_report 04:36:08 INFO - PROCESS | 7754 | _x_x_mozilla_page_load 04:36:08 INFO - PROCESS | 7754 | _x_x_mozilla_page_load_details 04:36:08 INFO - PROCESS | 7754 | |i|pagename|runs| 04:36:08 INFO - PROCESS | 7754 | |0;dojo.html;3039.6960303969604;3061.1122774395426;3070.554769558414;3095.3035566997414;3116.2832548513843;5119.1297479428495;5222.268882356473;5232.529072383485;5304.57563394928;5334.279872217255;5241.39723931748;5247.580193584514;5253.4221235664045;5279.260903473517;5305.761240744167;4746.027064451788;4830.2030165022725;4833.830815921444;4840.273958906157;4961.603071754251;4901.975490122544;4903.509649035086;4913.582345500637;4918.581920536759;4960.627952903528;4654.441467023962;4760.309755085494;4760.785764640582;4774.331593576902;4830.903381932377;4755.9286610700865;4775.71345719258;4833.202521583935;4846.854594362175;4872.878178045542;4696.436427628706;4793.2810078488155;4821.252705830602;4824.5899098576665;4859.538343857328;5196.636235463519;5253.080710875582;5288.365396152448;5312.814051508218;5364.517193452608;5684.261046064026;5712.828615141552;5733.140028995643;5739.397363276879;5741.024025915563;5523.337199536041;5581.888362232773;5721.7711291548285;5738.684372359518;5781.913271300934;5264.105102132647;5344.812931547416;5367.677939323653;5367.785288588452;5370.516653501165;5837.591368604242;5854;5866.911996320058;5877.38287479817;5885.941140588539;5423.891522169613;5543.805966791143;5579.2746942897975;5647.802326918538;5648.51987581052;5687.857803554944;5730.34101078373;5739.8565035874435;5744.339400968942;5748.655080695172;5666.206731057655;5682.318121825325;5688.431156884361;5699.373068962411;5701.315842098892;5455.509004189642;5572.331320241597;5672.290963629546;5674.77300907959;5682.943170568324;4331.523532411432;4333.956660433355;4334.45819272591;4336.956630433719;4370.322599997005;3871.7870517121264;3894.1157236069753;3897.668698160688;3929.744566603219;3955.248502784462;5139.794408223704;5146.871328216825;5270.8155214567305;5331.866703332447;5334.1732031535175;5697.487226149667;5702.771889124471;5716.42835716425;5717.456841600041;5755.050416681284;5355.732213389315;5356.7857285708915;5361.839144825662;5363.19552067193;5364.8658783529945;4695.765211739467;4787.42550893888;4839.032193561302;4839.177339852234;4861.489543597942;5847.853803654858;5852.473277404969;5855.941440585625;5862.12068189775;5863.20846685692;5559.471850174227;5636.126400407943;5646.915296270641;5648.181013753065;5648.661080335193;5652.689102099424;5776.566757493289;5777.7977770777825;5852.853678658068;5860.824175274749;5516.448355164452;5517.172424136412;5517.393086760533;5535.640183388067;5537.5569954404355;5496.340439147328;5534.252875861868;5618.438156184349;5630.296212973379;5632.127020311858;5496.5053145217125;5554.389017208023;5556.388797232382;5559.416261292506;5606.18710286998;5504.256925315031;5544.528715059265;5546.861328466821;5550.8057217997175;5551.944480555143;5223.3209682741;5328.360596728262;5374.946250537445;5420.430854760351;5486.149646804752;5577.972110139423;5581.525570326406;5586.916196257141;5594;5596.832095037155;5381.165919282517;5407.540359069523;5431.6740995540395;5445.292112025411;5447.155690867922 04:36:08 INFO - PROCESS | 7754 | |1;ext.html;591.1546488521416;618.1438707390264;621.0776996160698;631.4096319940855;644.0725355488097;32103;35213.82393088034;41742.16515669689;42924.356134658;42927;43535.78232108835;43794.12411751763;43958.12083758331;43959.340609890874;43995.78002109985;8967.95516022419;9122;9129.726108216764;9132;9134.771630709252;8876.644934202624;8975.506347150904;8994.730158095235;8998;9001.23489503393;9006.234470070052;9015.864762028576;9033.59348829301;9039.32205084618;9043.14090161437;9029.142231487998;9067.229285510739;9075.047120052366;9075.500847453388;9089.500077495735;8954.820903581893;9031.729048128567;9041.321900857462;9054.411463254868;9054.411463254868;42575.7871210645;42982.57017429817;42982.785086074684;42983;43010.784946075066;3769.6984241260634;3769.9434508482395;3799.1831756172555;3936.2717897188827;4132.607402296777;32936;32942;32999.835000825085;33103.66896331054;34666.653333466595;4032.2338755636333;4059.939100913489;4089.6932730045364;4130.215259100762;4187.497500299953;371696;373210;374802;375662;376090;33263.50104748431;56856.43143568511;57272.14091788627;57362.42637573654;57613.71193144008;34141.829290853886;36592.81703591465;36611.4508282376;36631.633683663356;36660;14422.42310307576;14557.344919478648;14563.199024053778;14587.781183282259;14603.488877889224;11876.10929180315;11907.226030308002;11913.285202887855;11929.821052684216;11969.581064662694;8071.959640201879;8219;8249.175082491704;8273.172682731678;8322.583870806435;3165.715085642303;3167.3394348747165;3179.2210908327147;3194.297254603983;3205.759568032407;987.9407235565889;1000.2797985450464;1035.2753072849036;1082.7780305037447;1094.2449709700281;31013.534796978063;31696.683033169833;32046.519302210487;32056.83971580127;32425;1087.8840654926094;1154.936478493674;1219.5243854896598;1235.172434468908;1241.3606992398923;16781.83218167827;16797.83202167987;16826.495205143867;16828.663426731397;16864.662706745796;556286;561613;562443;563112;568157;58751;60332;60391.094133588034;60395.39604603986;60407;1231.132051903406;1324.086380397542;1361.2649169448584;1364.5087768403366;1378.9862101379258;32403.837980809945;33379.33241335208;33661.66338336683;34109.65890341164;34402.31195376129;54484;56371.43628563826;56413.71793141008;61152;61235;519069;523703;524061.3157078968;525686;527832;37279.81360093182;42434.5756542443;43011.13977720366;44462.77768611136;45208.54791452175;48315.5168448311;48816.755916220194;48989.2651610219;49456.25815612841;49859.501404986935;41452.37821432621;41916.580834192486;42199;42325.576744233396;43354.349684754125;41442.58557414387;41803.37294940639;41969.160616788104;42003.7899810499;42699;36516.26967460689;36890.8155459221;37006.814965925;41224;42057;35540.46689299611;37554;38147;38568.228635427695;38631;28260.71739282581;28499.857500712365;28520.714792851806;28744.712552874204;28759.71240287654 04:36:08 INFO - PROCESS | 7754 | |2;jquery.html;374.42053964103167;388.215804075767;389.47615457210054;399.7122072108081;409.4431573060637;17773.200205990728;18570.53573660656;20445.48886277842;20854.270100546484;20930.581388372222;11166.274192177503;11453.541858325678;11729.354885481316;11732.648020559376;11732.882671173285;5025.321581586485;5296.9735151324385;5318.547923426513;5320.574354051686;5323.866903327428;3793.1465420280356;5442.047641662713;5732.856678583027;5742.569307301948;5823.650580965155;5585.2459917910965;5795.043817770063;5799.130130480419;5813.186153938452;5822.301323841145;5821.27234095738;5860.355360910317;5881.617694849864;5907.14346419771;5919.023361145384;3552.2007548301426;5304.655197412156;5608.887822243532;5614.550835933156;5672.574556908207;13535.864641353559;13620.659483512893;14822.40710371584;22586.322410327553;22630.321090367317;2393.640953856918;2407.6749638798888;2589.9870500647567;2621.8426894386207;2679.7454241846995;9871.851922221173;10221.080102790784;10294.485275736184;10389.636362727268;14011.369488373048;1925.3261358524544;1942.553212761073;1974.5458544534695;1974.7531558555181;2037.9796202037937;75499.62250188769;78120;78965;79224;79471.20528794696;10553;10624.36253824773;11368.658940231806;11626.593069242535;11930.522779088913;15180.316885739947;15214.543563693107;15295;15314.387424503118;15324.387024518894;7925.405594580429;8098.75703728889;8185.631646575918;8264;8277.089520152778;7664.156942736295;7683.846323073507;7802.141764405911;7896.249856263646;7977.242161994601;4702.929456058162;4736.194846876039;4758.881027974259;4795.904081918342;4821.734804585782;1822.3621732393822;1824.8430215726867;1848.7798053284766;1908.1699460734626;1965.0960558143129;909.481595490564;938.5635679408971;958.2046901072233;969.8254314223508;992.811365840488;18595.44213673592;18782;19156.04219789005;19529.21883124659;20089.497762556053;961.3703024518951;986.9259805514615;1011.206203130539;1034.4052170002278;1074.505727365405;9812.264080194014;10958.28771129874;10977.83533247002;10999.890001100046;11018.669439916815;480727;487687;488918;518393;531435;95970.52014740021;103060;104086.4795676032;104319;104391;992.1764935103846;1021.8569400283966;1024.7335692719798;1043.1758910460803;1044.5769463367349;18077.548061298574;18321.17554710068;18733.90633046826;18784.651808637125;18805.435836924913;42987.78506107449;43573.346399804665;43990.340144898495;44633.33050004188;46024.539754602025;62155.689221553606;62941.68529157325;63523.04715429365;63736.68131659312;64355.034674478986;8316.833663326579;8364.163583641588;8439.70461033861;8497.660093596187;8515.82968340642;9301.023392543957;10734;13376.598702038955;13935.860641393456;13945.233012184022;12013.75972480563;12094.75810483803;12212.694682633006;12313.815292770436;12497.437615307515;12037.75924481523;12058.155929085231;12152.21010634306;12158.088143389105;12159.513619455123;12165.330906799856;12289.324087174933;12464.626061218178;12486.937565312115;12606.810897836724;7083.185433675193;7542.698292068256;7724.420668450001;8201.95899020525;8439.240468357877;8685.001224859223;11900.28598284071;11927.701807454883;12048.75902481963;12115 04:36:08 INFO - PROCESS | 7754 | |3;mootools.html;1292.4248709324343;1408.908420952638;1442.2572375226757;1529.5334922848526;1671.156066186575;8197.672093116276;8579.313654907608;8596.785080372985;8837.072107428723;8841.823163536725;8541.572921353938;8726.38915275931;8729.34529910256;8736.956315218431;8742.912570874289;2292;2328.045501344449;2328.15022516781;2330.2892617751577;2332;2334.9066037358484;2335.754745751697;2374.7387787343378;2376.3821406434276;2378.8453750506246;2316.536692661466;2330.1262026739973;2335.5212181502834;2361.327021798788;2363.4800343924308;2283.760205178449;2303.216906251874;2305.458217318937;2307.296274636227;2326.5695846268495;2251.8311126665567;2253.053717438663;2257.8532395394245;2257.9435514112115;2295.21962532738;8468.957655211747;8682.565871706389;8735.606897689619;8737.388382813206;8738.781530461725;5103.7192954387865;5226.686398816083;5231.319928409321;5232.607554433394;5232.973835130838;3203.7917535360125;3214.228585139573;3243.96756032439;3245.8539365728598;3261.7768336873673;1143.6283207957365;1181.2144923625865;1186.0926391310654;1209.818527220915;1235.765204611121;11769;11836.171467997243;11868.228565143238;11889.227200231957;11994.700132496757;4329.545397733255;4342.913141737147;4453.042595841909;4512.4133862597655;4549.021960278556;9466.574004169828;9499.762505937408;9500.762480938032;9507.619695212252;9510.286728495252;5190.532852043334;5201.479852014768;5201.557867581222;5209.218617207373;5210.921836172461;4353.934690979638;4583.770811459413;4709.576138147583;4720.103180395782;4765.7140571565815;3616.9819150904605;3674.963250367462;3765.5104836371097;3777.867774627875;3795.35478968576;1058.3491152940885;1097.7145942054963;1103.7020004598714;1118.3960661242838;1120.383788916109;712.3304094151481;924;940.9294302927171;944.9716508504756;956.1346980982222;5567.025770490229;5633.63381380209;5650.802221922213;5687.402822703557;5887.528997680175;947.2516711797603;951.1297163095828;962.0571839597094;968.070652173921;984.4831463481729;3902.2195560887935;3985.601439855991;4026.859059932888;4042.8787136385367;4173;10562.630307939186;10848;10960.725981850359;10971.122310215324;11002.33985960845;10736.141108711441;10786.352818830896;10828.187885908588;10829.133669306437;10845.186611004206;8061.556614386148;8093.554854482943;8228.547429891294;8231.135730748185;8232.547209903392;5393.757280922289;5397.460253974571;5444.02007638613;5465.535429488538;5476.863078423071;9956.950215248877;9986.450745209084;10001.899981000097;10017.198624110199;10038.598456061676;9756.170725488413;10010.749731256778;10044.899551004397;10281.588736450458;10292;7100.360967512948;7442.813929651586;7642;7717.1896950819355;7856.921430785847;8529.82940341202;8602.225799678059;8631.784205394915;8677.956610216908;8680.82638347217;7528.962355188408;7778.844423111619;7806.726764563213;7808.726694565663;7876.72431464896;7405.925940740523;7510.586917719578;7595.886061708969;7626.351760100453;7785.961070194613;6521.087047813215;6562.770303039561;6574.671266436755;6576.934230657824;6587.670616469061;4932.901341973069;4959.156943319716;5104.617153713561;5105.387353517602;5149.2276158576515;4950.282209079592;5025.974870125626;5030.245463180552;5081.949180508148;5112.769925353294 04:36:08 INFO - PROCESS | 7754 | |4;prototype.html;313.9340738444927;314.5439113285735;324.36910209642247;325.0929905563477;335.15875153365045;5319.813806516768;5355.169948657959;5365.114756065254;5390.272313237717;5411.83764487065;4935.6545041847085;5137.332146820918;5220.556252718514;5240.187770895508;5300.920486192701;4139;4168.353905144708;4176.665866730655;4201.264778663737;4209.894752631186;4199.496060472748;4203.48674477188;4214.536400995888;4224.767637779921;4248.405223268729;3880.5731369549326;3964.583718709537;4027.375756757707;4055.2700513907635;4129.6696264298935;4079.8788926471275;4086.734362266443;4110.219058378899;4110.848962290548;4112.876613701579;3587.6232995535615;3598.838052287653;3599.964000359989;3606.945895811565;3613.7713177519768;4892.779824907888;5134.306868572769;5140.588752899759;5174.844754657366;5194.662346947436;4659.394278743742;4676.883077923045;4694.624430045622;4727.321800760715;4745.21703918853;5455.618106732531;5490.270564772084;5495.945040549624;5525.889482210374;5558.499735023867;3901.7073719471155;3943.684505239574;3965.861194858166;3967.1552727981625;4043.818028188709;5745.511631511326;5755.884882302331;5764.481196692276;5769.394213607553;5789.073748200268;4009.4787677601726;4033.6773058155277;4044.939325910114;4069.5146271610647;4073.3889916512167;3818.312703713358;4039.434479172918;4096.897577560525;4103.871435355301;4103.938440923389;4610.331501932201;4628.884277893012;4631.096936097429;4652.674312798139;4670.439547254351;5559.442656378031;5569.777208911679;5574.358948720868;5575.526080283222;5593.412691667398;1369.88355989742;1409.6757745718542;1413.943442262298;1431.5705288413642;1434.2971943747698;902.9142231487998;910.886139232596;914.0996118822954;917.6283605139929;922.9215516681157;4770.451398089264;4795.304680821261;4798.832040878552;4837.4920633332995;4868.610511159099;5072.847814565569;5078.085944529947;5079.619028572872;5083.288339632454;5112.872178195575;4454.202644559757;4756.548127927841;4787.3537072495465;4793.664443488922;4818.95181048185;2696.9595456068173;2698.745083536165;2709.878055487508;2712.5795501697266;2714.172177485846;5143.537081662594;5216.66091704038;5218.243354713545;5238.711870847063;5244.711540865213;4717.481077081518;5096.64237077301;5125.948740512547;5144.71704056273;5186.8215349553275;5057.673470203674;5178.679436743681;5186.533212010937;5195.7142357170715;5213.374395072616;4995.025969935828;4998.900241946766;5041.294218809443;5080.094964388354;5084;4801.927971080367;4974.37820272466;4979.800807967786;5003.949960500348;5009.09472505953;5170.482951704799;5213.973930130325;5223.216517522402;5250.501202385767;5259.894802104013;3701.833417496273;3744.6332088786853;3771.283456143324;3775.716821238363;3834.731568790158;5478.80824171168;5651.350094739158;5656;5664.886702266014;5761.2222349983895;5497.065498865282;5504.366997795305;5534;5534.778608855761;5562.833115006556;5249.317588713443;5536.809585939042;5551.694656793915;5570.270567422015;5582.888342233214;5355.598330125178;5411.864703382447;5428.185772134211;5473.17902314656;5485.122380419114;5511;5580.298009107261;5649.971750141223;5654.604177707521;5662.433756624305;5274.551663108526;5453.672779633234;5455.18172274162;5475.315585551806;5484.533814625642 04:36:08 INFO - PROCESS | 7754 | |5;yui.html;681.0669382945366;713.0017974835226;760.9840862448631;804.9798755031123;829.4940086547207;14044;15005.099694018367;15152.318145683443;15165.545033649008;15166.696666066671;13726.931365343184;13991.440342386293;14011.64970875726;14020;14028.859711402883;646.644345609915;757.4243574883074;761.3034073822446;766.1074847802304;780.6526095887332;785.0618510879501;785.1481142959896;785.3834739729314;787.2560430393281;787.8700014497601;819.0417211862106;819.5410570080744;820.8768684697284;820.9014918209823;820.9876851847227;682.556338380052;789.8775689768066;809.7854068671807;809.9473534220316;810.9148539403366;587.8941790477712;590.0706387439757;590.583638534832;590.6426611899782;591.9852003699899;13408.26254555999;13487.595372138852;13488.730225395535;13496.730065398637;13604.659883502893;13131.212127272394;14389.208593527352;14485.78271325931;14631.70736585273;14721.043132196373;12604.936975315157;12767.680807979781;12863.614091577268;13011.284379359131;13488.797668034988;4336.392904993303;4420.889477763081;4443.844465443694;4528.275475923836;4542.772861356952;73411.89084014163;73429.63285183594;74281.6285918567;74567;79062;11041.083216021423;11062.157185006352;11124.221304508768;11284.774304514029;11308.943455282835;20956.266530671353;21077.683834742493;21110.894445527672;21120;21120.78879211219;8438;8443.36674749384;8477.74566762998;8508.446950948168;8686.34852386061;4562.498125206224;4830.830920917751;4850.6362022847725;4885.193942999436;5044.8234311798915;3207.7594180436095;3299.2411745298236;3315.61870384904;3316.6020077590842;3317.950230746541;582.8746819433842;607.6840043177523;610.4841409009468;613.6348872420903;620.0884699491739;602.8884656338591;606.2785285510229;683.1392445518683;684.8596037812237;709.5281637710865;9044.41211321262;9174.128457796498;9459.432434053979;9464.432134071978;9514.524273786283;646.1115965547373;667.5360624366019;712.2734810493267;713.2867132867133;769.9384049276044;4347.956520434818;4662.6269898408045;4690.132325519789;4723.551262630044;4829.444613869379;108477.45761271143;109468.4526577362;113344;116364.41817791027;116730;93124;97542;97633;98312.50843745879;98489.50755246179;53909.65225869306;71125;76844.23155768482;79180.6040969803;86889.5655521731;9550.570224339783;9619.134277915022;9706.272029597667;9785.412875227508;10076.69769906904;49221.54134813161;55771.40466811837;56841.71579142078;58228.12657810051;60598.394016059276;44205.33691994687;45138;45284.773576131905;77723.61138194273;80460.19539804761;11859.466324015613;12667.176633518791;13167.341632918507;13257.07200495956;13953.720925581634;13364.933175334061;14881.312386598187;15261.465848695243;15372.252563281962;15771.427432296097;14071.718565628425;14235.64410889736;14343.426262949783;14572;14764.261786910827;13193.934030329787;13507.662308442368;13626;13638.93180534091;13986.16083035021;13723.245221512912;13922.443102275796;14096.154230746188;14138.858611414165;14496.492622758153;10875.728106797393;11340.376279304717;11609.88390116088;11639.41802909868;11680.883191167979;11048.171387146156;11426.143039271921;11469.31184128955;11480.425978701198;11518.53925842957 04:36:08 INFO - PROCESS | 7754 | __end_tp_report 04:36:08 INFO - PROCESS | 7754 | __start_cc_report 04:36:08 INFO - PROCESS | 7754 | _x_x_mozilla_cycle_collect,871 04:36:08 INFO - PROCESS | 7754 | __end_cc_report 04:36:08 INFO - PROCESS | 7754 | __startTimestamp1467113768594__endTimestamp 04:36:08 INFO - PROCESS | 7754 | 04:36:08 INFO - PROCESS | 7754 | ------- Summary: start ------- 04:36:08 INFO - PROCESS | 7754 | Number of tests: 6 04:36:08 INFO - PROCESS | 7754 | 04:36:08 INFO - PROCESS | 7754 | [#0] dojo.html Cycles:165 Average:5255.27 Median:5431.67 stddev:592.74 (10.9%) stddev-sans-first:568.51 04:36:08 INFO - PROCESS | 7754 | Values: 3039.7 3061.1 3070.6 3095.3 3116.3 5119.1 5222.3 5232.5 5304.6 5334.3 5241.4 5247.6 5253.4 5279.3 5305.8 4746.0 4830.2 4833.8 4840.3 4961.6 4902.0 4903.5 4913.6 4918.6 4960.6 4654.4 4760.3 4760.8 4774.3 4830.9 4755.9 4775.7 4833.2 4846.9 4872.9 4696.4 4793.3 4821.3 4824.6 4859.5 5196.6 5253.1 5288.4 5312.8 5364.5 5684.3 5712.8 5733.1 5739.4 5741.0 5523.3 5581.9 5721.8 5738.7 5781.9 5264.1 5344.8 5367.7 5367.8 5370.5 5837.6 5854.0 5866.9 5877.4 5885.9 5423.9 5543.8 5579.3 5647.8 5648.5 5687.9 5730.3 5739.9 5744.3 5748.7 5666.2 5682.3 5688.4 5699.4 5701.3 5455.5 5572.3 5672.3 5674.8 5682.9 4331.5 4334.0 4334.5 4337.0 4370.3 3871.8 3894.1 3897.7 3929.7 3955.2 5139.8 5146.9 5270.8 5331.9 5334.2 5697.5 5702.8 5716.4 5717.5 5755.1 5355.7 5356.8 5361.8 5363.2 5364.9 4695.8 4787.4 4839.0 4839.2 4861.5 5847.9 5852.5 5855.9 5862.1 5863.2 5559.5 5636.1 5646.9 5648.2 5648.7 5652.7 5776.6 5777.8 5852.9 5860.8 5516.4 5517.2 5517.4 5535.6 5537.6 5496.3 5534.3 5618.4 5630.3 5632.1 5496.5 5554.4 5556.4 5559.4 5606.2 5504.3 5544.5 5546.9 5550.8 5551.9 5223.3 5328.4 5374.9 5420.4 5486.1 5578.0 5581.5 5586.9 5594.0 5596.8 5381.2 5407.5 5431.7 5445.3 5447.2 04:36:08 INFO - PROCESS | 7754 | 04:36:08 INFO - PROCESS | 7754 | [#1] ext.html Cycles:180 Average:63461.38 Median:23052.04 stddev:131423.81 (570.1%) stddev-sans-first:131707.72 04:36:08 INFO - PROCESS | 7754 | Values: 591.2 618.1 621.1 631.4 644.1 32103.0 35213.8 41742.2 42924.4 42927.0 43535.8 43794.1 43958.1 43959.3 43995.8 8968.0 9122.0 9129.7 9132.0 9134.8 8876.6 8975.5 8994.7 8998.0 9001.2 9006.2 9015.9 9033.6 9039.3 9043.1 9029.1 9067.2 9075.0 9075.5 9089.5 8954.8 9031.7 9041.3 9054.4 9054.4 42575.8 42982.6 42982.8 42983.0 43010.8 3769.7 3769.9 3799.2 3936.3 4132.6 32936.0 32942.0 32999.8 33103.7 34666.7 4032.2 4059.9 4089.7 4130.2 4187.5 371696.0 373210.0 374802.0 375662.0 376090.0 33263.5 56856.4 57272.1 57362.4 57613.7 34141.8 36592.8 36611.5 36631.6 36660.0 14422.4 14557.3 14563.2 14587.8 14603.5 11876.1 11907.2 11913.3 11929.8 11969.6 8072.0 8219.0 8249.2 8273.2 8322.6 3165.7 3167.3 3179.2 3194.3 3205.8 987.9 1000.3 1035.3 1082.8 1094.2 31013.5 31696.7 32046.5 32056.8 32425.0 1087.9 1154.9 1219.5 1235.2 1241.4 16781.8 16797.8 16826.5 16828.7 16864.7 556286.0 561613.0 562443.0 563112.0 568157.0 58751.0 60332.0 60391.1 60395.4 60407.0 1231.1 1324.1 1361.3 1364.5 1379.0 32403.8 33379.3 33661.7 34109.7 34402.3 54484.0 56371.4 56413.7 61152.0 61235.0 519069.0 523703.0 524061.3 525686.0 527832.0 37279.8 42434.6 43011.1 44462.8 45208.5 48315.5 48816.8 48989.3 49456.3 49859.5 41452.4 41916.6 42199.0 42325.6 43354.3 41442.6 41803.4 41969.2 42003.8 42699.0 36516.3 36890.8 37006.8 41224.0 42057.0 35540.5 37554.0 38147.0 38568.2 38631.0 28260.7 28499.9 28520.7 28744.7 28759.7 04:36:08 INFO - PROCESS | 7754 | 04:36:08 INFO - PROCESS | 7754 | [#2] jquery.html Cycles:180 Average:29409.17 Median:2650.79 stddev:82998.81 (3131.1%) stddev-sans-first:83203.01 04:36:08 INFO - PROCESS | 7754 | Values: 374.4 388.2 389.5 399.7 409.4 17773.2 18570.5 20445.5 20854.3 20930.6 11166.3 11453.5 11729.4 11732.6 11732.9 5025.3 5297.0 5318.5 5320.6 5323.9 3793.1 5442.0 5732.9 5742.6 5823.7 5585.2 5795.0 5799.1 5813.2 5822.3 5821.3 5860.4 5881.6 5907.1 5919.0 3552.2 5304.7 5608.9 5614.6 5672.6 13535.9 13620.7 14822.4 22586.3 22630.3 2393.6 2407.7 2590.0 2621.8 2679.7 9871.9 10221.1 10294.5 10389.6 14011.4 1925.3 1942.6 1974.5 1974.8 2038.0 75499.6 78120.0 78965.0 79224.0 79471.2 10553.0 10624.4 11368.7 11626.6 11930.5 15180.3 15214.5 15295.0 15314.4 15324.4 7925.4 8098.8 8185.6 8264.0 8277.1 7664.2 7683.8 7802.1 7896.2 7977.2 4702.9 4736.2 4758.9 4795.9 4821.7 1822.4 1824.8 1848.8 1908.2 1965.1 909.5 938.6 958.2 969.8 992.8 18595.4 18782.0 19156.0 19529.2 20089.5 961.4 986.9 1011.2 1034.4 1074.5 9812.3 10958.3 10977.8 10999.9 11018.7 480727.0 487687.0 488918.0 518393.0 531435.0 95970.5 103060.0 104086.5 104319.0 104391.0 992.2 1021.9 1024.7 1043.2 1044.6 18077.5 18321.2 18733.9 18784.7 18805.4 42987.8 43573.3 43990.3 44633.3 46024.5 62155.7 62941.7 63523.0 63736.7 64355.0 8316.8 8364.2 8439.7 8497.7 8515.8 9301.0 10734.0 13376.6 13935.9 13945.2 12013.8 12094.8 12212.7 12313.8 12497.4 12037.8 12058.2 12152.2 12158.1 12159.5 12165.3 12289.3 12464.6 12486.9 12606.8 7083.2 7542.7 7724.4 8202.0 8439.2 8685.0 11900.3 11927.7 12048.8 12115.0 04:36:08 INFO - PROCESS | 7754 | 04:36:08 INFO - PROCESS | 7754 | [#3] mootools.html Cycles:180 Average:5673.16 Median:5028.11 stddev:3237.39 (64.4%) stddev-sans-first:3229.73 04:36:08 INFO - PROCESS | 7754 | Values: 1292.4 1408.9 1442.3 1529.5 1671.2 8197.7 8579.3 8596.8 8837.1 8841.8 8541.6 8726.4 8729.3 8737.0 8742.9 2292.0 2328.0 2328.2 2330.3 2332.0 2334.9 2335.8 2374.7 2376.4 2378.8 2316.5 2330.1 2335.5 2361.3 2363.5 2283.8 2303.2 2305.5 2307.3 2326.6 2251.8 2253.1 2257.9 2257.9 2295.2 8469.0 8682.6 8735.6 8737.4 8738.8 5103.7 5226.7 5231.3 5232.6 5233.0 3203.8 3214.2 3244.0 3245.9 3261.8 1143.6 1181.2 1186.1 1209.8 1235.8 11769.0 11836.2 11868.2 11889.2 11994.7 4329.5 4342.9 4453.0 4512.4 4549.0 9466.6 9499.8 9500.8 9507.6 9510.3 5190.5 5201.5 5201.6 5209.2 5210.9 4353.9 4583.8 4709.6 4720.1 4765.7 3617.0 3675.0 3765.5 3777.9 3795.4 1058.3 1097.7 1103.7 1118.4 1120.4 712.3 924.0 940.9 945.0 956.1 5567.0 5633.6 5650.8 5687.4 5887.5 947.3 951.1 962.1 968.1 984.5 3902.2 3985.6 4026.9 4042.9 4173.0 10562.6 10848.0 10960.7 10971.1 11002.3 10736.1 10786.4 10828.2 10829.1 10845.2 8061.6 8093.6 8228.5 8231.1 8232.5 5393.8 5397.5 5444.0 5465.5 5476.9 9957.0 9986.5 10001.9 10017.2 10038.6 9756.2 10010.7 10044.9 10281.6 10292.0 7100.4 7442.8 7642.0 7717.2 7856.9 8529.8 8602.2 8631.8 8678.0 8680.8 7529.0 7778.8 7806.7 7808.7 7876.7 7405.9 7510.6 7595.9 7626.4 7786.0 6521.1 6562.8 6574.7 6576.9 6587.7 4932.9 4959.2 5104.6 5105.4 5149.2 4950.3 5026.0 5030.2 5081.9 5112.8 04:36:08 INFO - PROCESS | 7754 | 04:36:08 INFO - PROCESS | 7754 | [#4] prototype.html Cycles:180 Average:4486.41 Median:5049.48 stddev:1298.22 (25.7%) stddev-sans-first:1263.52 04:36:08 INFO - PROCESS | 7754 | Values: 313.9 314.5 324.4 325.1 335.2 5319.8 5355.2 5365.1 5390.3 5411.8 4935.7 5137.3 5220.6 5240.2 5300.9 4139.0 4168.4 4176.7 4201.3 4209.9 4199.5 4203.5 4214.5 4224.8 4248.4 3880.6 3964.6 4027.4 4055.3 4129.7 4079.9 4086.7 4110.2 4110.8 4112.9 3587.6 3598.8 3600.0 3606.9 3613.8 4892.8 5134.3 5140.6 5174.8 5194.7 4659.4 4676.9 4694.6 4727.3 4745.2 5455.6 5490.3 5495.9 5525.9 5558.5 3901.7 3943.7 3965.9 3967.2 4043.8 5745.5 5755.9 5764.5 5769.4 5789.1 4009.5 4033.7 4044.9 4069.5 4073.4 3818.3 4039.4 4096.9 4103.9 4103.9 4610.3 4628.9 4631.1 4652.7 4670.4 5559.4 5569.8 5574.4 5575.5 5593.4 1369.9 1409.7 1413.9 1431.6 1434.3 902.9 910.9 914.1 917.6 922.9 4770.5 4795.3 4798.8 4837.5 4868.6 5072.8 5078.1 5079.6 5083.3 5112.9 4454.2 4756.5 4787.4 4793.7 4819.0 2697.0 2698.7 2709.9 2712.6 2714.2 5143.5 5216.7 5218.2 5238.7 5244.7 4717.5 5096.6 5125.9 5144.7 5186.8 5057.7 5178.7 5186.5 5195.7 5213.4 4995.0 4998.9 5041.3 5080.1 5084.0 4801.9 4974.4 4979.8 5003.9 5009.1 5170.5 5214.0 5223.2 5250.5 5259.9 3701.8 3744.6 3771.3 3775.7 3834.7 5478.8 5651.4 5656.0 5664.9 5761.2 5497.1 5504.4 5534.0 5534.8 5562.8 5249.3 5536.8 5551.7 5570.3 5582.9 5355.6 5411.9 5428.2 5473.2 5485.1 5511.0 5580.3 5650.0 5654.6 5662.4 5274.6 5453.7 5455.2 5475.3 5484.5 04:36:08 INFO - PROCESS | 7754 | 04:36:08 INFO - PROCESS | 7754 | [#5] yui.html Cycles:180 Average:19972.48 Median:4612.56 stddev:28443.96 (616.7%) stddev-sans-first:28486.87 04:36:08 INFO - PROCESS | 7754 | Values: 681.1 713.0 761.0 805.0 829.5 14044.0 15005.1 15152.3 15165.5 15166.7 13726.9 13991.4 14011.6 14020.0 14028.9 646.6 757.4 761.3 766.1 780.7 785.1 785.1 785.4 787.3 787.9 819.0 819.5 820.9 820.9 821.0 682.6 789.9 809.8 809.9 810.9 587.9 590.1 590.6 590.6 592.0 13408.3 13487.6 13488.7 13496.7 13604.7 13131.2 14389.2 14485.8 14631.7 14721.0 12604.9 12767.7 12863.6 13011.3 13488.8 4336.4 4420.9 4443.8 4528.3 4542.8 73411.9 73429.6 74281.6 74567.0 79062.0 11041.1 11062.2 11124.2 11284.8 11308.9 20956.3 21077.7 21110.9 21120.0 21120.8 8438.0 8443.4 8477.7 8508.4 8686.3 4562.5 4830.8 4850.6 4885.2 5044.8 3207.8 3299.2 3315.6 3316.6 3318.0 582.9 607.7 610.5 613.6 620.1 602.9 606.3 683.1 684.9 709.5 9044.4 9174.1 9459.4 9464.4 9514.5 646.1 667.5 712.3 713.3 769.9 4348.0 4662.6 4690.1 4723.6 4829.4 108477.5 109468.5 113344.0 116364.4 116730.0 93124.0 97542.0 97633.0 98312.5 98489.5 53909.7 71125.0 76844.2 79180.6 86889.6 9550.6 9619.1 9706.3 9785.4 10076.7 49221.5 55771.4 56841.7 58228.1 60598.4 44205.3 45138.0 45284.8 77723.6 80460.2 11859.5 12667.2 13167.3 13257.1 13953.7 13364.9 14881.3 15261.5 15372.3 15771.4 14071.7 14235.6 14343.4 14572.0 14764.3 13193.9 13507.7 13626.0 13638.9 13986.2 13723.2 13922.4 14096.2 14138.9 14496.5 10875.7 11340.4 11609.9 11639.4 11680.9 11048.2 11426.1 11469.3 11480.4 11518.5 04:36:08 INFO - PROCESS | 7754 | -------- Summary: end -------- 04:36:08 INFO - PROCESS | 7754 | 04:36:09 INFO - TEST-INFO | 7754: exit 0 04:36:09 INFO - TEST-OK | dromaeo_css | took 1115076ms 04:36:09 INFO - TEST-START | kraken 04:36:09 INFO - operating with platform_type : linux_ 04:36:09 INFO - Initialising browser for kraken test... 04:36:09 INFO - TEST-INFO | started process 7942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcR8HKL/profile http://localhost:49855/getInfo.html) 04:36:14 INFO - PROCESS | 7942 | __metrics Screen width/height:1600/1200 04:36:14 INFO - PROCESS | 7942 | colorDepth:24 04:36:14 INFO - PROCESS | 7942 | Browser inner width/height: 1024/697 04:36:14 INFO - PROCESS | 7942 | __metrics 04:36:15 INFO - PROCESS | 7942 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:36:15 INFO - PROCESS | 7942 | console.error: PushService: 04:36:16 INFO - PROCESS | 7942 | stateChangeProcessEnqueue: Error transitioning state 04:36:16 INFO - PROCESS | 7942 | UnknownError 04:36:16 INFO - TEST-INFO | 7942: exit 0 04:36:16 INFO - Browser initialized. 04:36:16 INFO - Running cycle 1/1 for kraken test... 04:36:16 INFO - TEST-INFO | started process 8029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcR8HKL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:28 INFO - PROCESS | 8029 | RSS: Main: 157184000 04:36:28 INFO - PROCESS | 8029 | 04:36:30 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:49855/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49855/tests/kraken/driver.html?testName=audio-beat-detection) 04:36:31 INFO - PROCESS | 8029 | RSS: Main: 214802432 04:36:31 INFO - PROCESS | 8029 | 04:36:34 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:49855/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49855/tests/kraken/driver.html?testName=audio-dft) 04:36:34 INFO - PROCESS | 8029 | RSS: Main: 203718656 04:36:34 INFO - PROCESS | 8029 | 04:36:38 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:49855/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49855/tests/kraken/driver.html?testName=audio-fft) 04:36:38 INFO - PROCESS | 8029 | RSS: Main: 268197888 04:36:38 INFO - PROCESS | 8029 | 04:36:40 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:49855/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49855/tests/kraken/driver.html?testName=audio-oscillator) 04:36:41 INFO - PROCESS | 8029 | RSS: Main: 179613696 04:36:41 INFO - PROCESS | 8029 | 04:36:43 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:49855/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49855/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:36:44 INFO - PROCESS | 8029 | RSS: Main: 184365056 04:36:44 INFO - PROCESS | 8029 | 04:36:47 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:49855/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49855/tests/kraken/driver.html?testName=imaging-darkroom) 04:36:47 INFO - PROCESS | 8029 | RSS: Main: 218468352 04:36:47 INFO - PROCESS | 8029 | 04:36:51 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:49855/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49855/tests/kraken/driver.html?testName=imaging-desaturate) 04:36:51 INFO - PROCESS | 8029 | RSS: Main: 220086272 04:36:51 INFO - PROCESS | 8029 | 04:36:54 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:49855/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49855/tests/kraken/driver.html?testName=json-parse-financial) 04:36:55 INFO - PROCESS | 8029 | RSS: Main: 219918336 04:36:55 INFO - PROCESS | 8029 | 04:36:56 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:49855/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49855/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:36:57 INFO - PROCESS | 8029 | RSS: Main: 207007744 04:36:57 INFO - PROCESS | 8029 | 04:36:59 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:49855/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49855/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:36:59 INFO - PROCESS | 8029 | RSS: Main: 211091456 04:36:59 INFO - PROCESS | 8029 | 04:37:01 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:49855/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49855/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:37:02 INFO - PROCESS | 8029 | RSS: Main: 220934144 04:37:02 INFO - PROCESS | 8029 | 04:37:05 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:49855/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49855/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:37:05 INFO - PROCESS | 8029 | RSS: Main: 223014912 04:37:05 INFO - PROCESS | 8029 | 04:37:08 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:49855/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49855/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:37:08 INFO - PROCESS | 8029 | RSS: Main: 224268288 04:37:08 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | Cycle 1(1): loaded http://localhost:49855/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49855/tests/kraken/driver.html?testName=ai-astar) 04:37:10 INFO - PROCESS | 8029 | RSS: Main: 266416128 04:37:10 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | __start_tp_report 04:37:10 INFO - PROCESS | 8029 | _x_x_mozilla_page_load 04:37:10 INFO - PROCESS | 8029 | _x_x_mozilla_page_load_details 04:37:10 INFO - PROCESS | 8029 | |i|pagename|runs| 04:37:10 INFO - PROCESS | 8029 | |0;ai-astar;102;112;113;112;112;112;111;111;111;111 04:37:10 INFO - PROCESS | 8029 | |1;audio-beat-detection;151;126;134;195;126;136;126;157;164;125 04:37:10 INFO - PROCESS | 8029 | |2;audio-dft;161;161;161;161;160;160;160;161;161;162 04:37:10 INFO - PROCESS | 8029 | |3;audio-fft;75;74;76;122;76;77;75;75;98;75 04:37:10 INFO - PROCESS | 8029 | |4;audio-oscillator;85;84;117;84;85;85;115;85;84;122 04:37:10 INFO - PROCESS | 8029 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 04:37:10 INFO - PROCESS | 8029 | |6;imaging-darkroom;146;146;146;145;146;146;145;145;145;146 04:37:10 INFO - PROCESS | 8029 | |7;imaging-desaturate;94;94;94;94;95;95;96;95;95;95 04:37:10 INFO - PROCESS | 8029 | |8;json-parse-financial;52;53;51;52;51;53;52;51;52;55 04:37:10 INFO - PROCESS | 8029 | |9;json-stringify-tinderbox;62;63;60;62;61;62;61;61;61;62 04:37:10 INFO - PROCESS | 8029 | |10;stanford-crypto-aes;81;79;85;79;80;80;80;82;89;81 04:37:10 INFO - PROCESS | 8029 | |11;stanford-crypto-ccm;135;129;126;132;123;131;124;133;149;121 04:37:10 INFO - PROCESS | 8029 | |12;stanford-crypto-pbkdf2;161;164;158;158;157;157;157;156;158;155 04:37:10 INFO - PROCESS | 8029 | |13;stanford-crypto-sha256-iterative;63;63;63;62;63;63;63;62;63;63 04:37:10 INFO - PROCESS | 8029 | __end_tp_report 04:37:10 INFO - PROCESS | 8029 | __start_cc_report 04:37:10 INFO - PROCESS | 8029 | _x_x_mozilla_cycle_collect,1618 04:37:10 INFO - PROCESS | 8029 | __end_cc_report 04:37:10 INFO - PROCESS | 8029 | __startTimestamp1467113830848__endTimestamp 04:37:10 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | ------- Summary: start ------- 04:37:10 INFO - PROCESS | 8029 | Number of tests: 14 04:37:10 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.13 (2.8%) stddev-sans-first:0.71 04:37:10 INFO - PROCESS | 8029 | Values: 102.0 112.0 113.0 112.0 112.0 112.0 111.0 111.0 111.0 111.0 04:37:10 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:143.50 stddev:22.89 (16.0%) stddev-sans-first:24.14 04:37:10 INFO - PROCESS | 8029 | Values: 151.0 126.0 134.0 195.0 126.0 136.0 126.0 157.0 164.0 125.0 04:37:10 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 04:37:10 INFO - PROCESS | 8029 | Values: 161.0 161.0 161.0 161.0 160.0 160.0 160.0 161.0 161.0 162.0 04:37:10 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.50 stddev:15.68 (20.8%) stddev-sans-first:16.40 04:37:10 INFO - PROCESS | 8029 | Values: 75.0 74.0 76.0 122.0 76.0 77.0 75.0 75.0 98.0 75.0 04:37:10 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:84.50 stddev:16.24 (19.2%) stddev-sans-first:16.85 04:37:10 INFO - PROCESS | 8029 | Values: 85.0 84.0 117.0 84.0 85.0 85.0 115.0 85.0 84.0 122.0 04:37:10 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 04:37:10 INFO - PROCESS | 8029 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 04:37:10 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:37:10 INFO - PROCESS | 8029 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 04:37:10 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 04:37:10 INFO - PROCESS | 8029 | Values: 94.0 94.0 94.0 94.0 95.0 95.0 96.0 95.0 95.0 95.0 04:37:10 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:1.23 (2.4%) stddev-sans-first:1.30 04:37:10 INFO - PROCESS | 8029 | Values: 52.0 53.0 51.0 52.0 51.0 53.0 52.0 51.0 52.0 55.0 04:37:10 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 04:37:10 INFO - PROCESS | 8029 | Values: 62.0 63.0 60.0 62.0 61.0 62.0 61.0 61.0 61.0 62.0 04:37:10 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.00 stddev:3.13 (3.9%) stddev-sans-first:3.32 04:37:10 INFO - PROCESS | 8029 | Values: 81.0 79.0 85.0 79.0 80.0 80.0 80.0 82.0 89.0 81.0 04:37:10 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:131.50 stddev:8.04 (6.1%) stddev-sans-first:8.35 04:37:10 INFO - PROCESS | 8029 | Values: 135.0 129.0 126.0 132.0 123.0 131.0 124.0 133.0 149.0 121.0 04:37:10 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:158.00 stddev:2.60 (1.6%) stddev-sans-first:2.54 04:37:10 INFO - PROCESS | 8029 | Values: 161.0 164.0 158.0 158.0 157.0 157.0 157.0 156.0 158.0 155.0 04:37:10 INFO - PROCESS | 8029 | 04:37:10 INFO - PROCESS | 8029 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 04:37:10 INFO - PROCESS | 8029 | Values: 63.0 63.0 63.0 62.0 63.0 63.0 63.0 62.0 63.0 63.0 04:37:10 INFO - PROCESS | 8029 | -------- Summary: end -------- 04:37:10 INFO - PROCESS | 8029 | 04:37:11 INFO - TEST-INFO | 8029: exit 0 04:37:11 INFO - TEST-OK | kraken | took 62498ms 04:37:11 INFO - SUITE-END | took 1177s 04:37:12 INFO - Completed test suite (00:19:37) 04:37:12 INFO - javascript benchmark 04:37:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3039.6960303969604, 3061.1122774395426, 3070.554769558414, 3095.3035566997414, 3116.2832548513843, 5119.1297479428495, 5222.268882356473, 5232.529072383485, 5304.57563394928, 5334.279872217255, 5241.39723931748, 5247.580193584514, 5253.4221235664045, 5279.260903473517, 5305.761240744167, 4746.027064451788, 4830.2030165022725, 4833.830815921444, 4840.273958906157, 4961.603071754251, 4901.975490122544, 4903.509649035086, 4913.582345500637, 4918.581920536759, 4960.627952903528, 4654.441467023962, 4760.309755085494, 4760.785764640582, 4774.331593576902, 4830.903381932377, 4755.9286610700865, 4775.71345719258, 4833.202521583935, 4846.854594362175, 4872.878178045542, 4696.436427628706, 4793.2810078488155, 4821.252705830602, 4824.5899098576665, 4859.538343857328, 5196.636235463519, 5253.080710875582, 5288.365396152448, 5312.814051508218, 5364.517193452608, 5684.261046064026, 5712.828615141552, 5733.140028995643, 5739.397363276879, 5741.024025915563, 5523.337199536041, 5581.888362232773, 5721.7711291548285, 5738.684372359518, 5781.913271300934, 5264.105102132647, 5344.812931547416, 5367.677939323653, 5367.785288588452, 5370.516653501165, 5837.591368604242, 5854.0, 5866.911996320058, 5877.38287479817, 5885.941140588539, 5423.891522169613, 5543.805966791143, 5579.2746942897975, 5647.802326918538, 5648.51987581052, 5687.857803554944, 5730.34101078373, 5739.8565035874435, 5744.339400968942, 5748.655080695172, 5666.206731057655, 5682.318121825325, 5688.431156884361, 5699.373068962411, 5701.315842098892, 5455.509004189642, 5572.331320241597, 5672.290963629546, 5674.77300907959, 5682.943170568324, 4331.523532411432, 4333.956660433355, 4334.45819272591, 4336.956630433719, 4370.322599997005, 3871.7870517121264, 3894.1157236069753, 3897.668698160688, 3929.744566603219, 3955.248502784462, 5139.794408223704, 5146.871328216825, 5270.8155214567305, 5331.866703332447, 5334.1732031535175, 5697.487226149667, 5702.771889124471, 5716.42835716425, 5717.456841600041, 5755.050416681284, 5355.732213389315, 5356.7857285708915, 5361.839144825662, 5363.19552067193, 5364.8658783529945, 4695.765211739467, 4787.42550893888, 4839.032193561302, 4839.177339852234, 4861.489543597942, 5847.853803654858, 5852.473277404969, 5855.941440585625, 5862.12068189775, 5863.20846685692, 5559.471850174227, 5636.126400407943, 5646.915296270641, 5648.181013753065, 5648.661080335193, 5652.689102099424, 5776.566757493289, 5777.7977770777825, 5852.853678658068, 5860.824175274749, 5516.448355164452, 5517.172424136412, 5517.393086760533, 5535.640183388067, 5537.5569954404355, 5496.340439147328, 5534.252875861868, 5618.438156184349, 5630.296212973379, 5632.127020311858, 5496.5053145217125, 5554.389017208023, 5556.388797232382, 5559.416261292506, 5606.18710286998, 5504.256925315031, 5544.528715059265, 5546.861328466821, 5550.8057217997175, 5551.944480555143, 5223.3209682741, 5328.360596728262, 5374.946250537445, 5420.430854760351, 5486.149646804752, 5577.972110139423, 5581.525570326406, 5586.916196257141, 5594.0, 5596.832095037155, 5381.165919282517, 5407.540359069523, 5431.6740995540395, 5445.292112025411, 5447.155690867922], "value": 5215.716693845194, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.1546488521416, 618.1438707390264, 621.0776996160698, 631.4096319940855, 644.0725355488097, 32103.0, 35213.82393088034, 41742.16515669689, 42924.356134658, 42927.0, 43535.78232108835, 43794.12411751763, 43958.12083758331, 43959.340609890874, 43995.78002109985, 8967.95516022419, 9122.0, 9129.726108216764, 9132.0, 9134.771630709252, 8876.644934202624, 8975.506347150904, 8994.730158095235, 8998.0, 9001.23489503393, 9006.234470070052, 9015.864762028576, 9033.59348829301, 9039.32205084618, 9043.14090161437, 9029.142231487998, 9067.229285510739, 9075.047120052366, 9075.500847453388, 9089.500077495735, 8954.820903581893, 9031.729048128567, 9041.321900857462, 9054.411463254868, 9054.411463254868, 42575.7871210645, 42982.57017429817, 42982.785086074684, 42983.0, 43010.784946075066, 3769.6984241260634, 3769.9434508482395, 3799.1831756172555, 3936.2717897188827, 4132.607402296777, 32936.0, 32942.0, 32999.835000825085, 33103.66896331054, 34666.653333466595, 4032.2338755636333, 4059.939100913489, 4089.6932730045364, 4130.215259100762, 4187.497500299953, 371696.0, 373210.0, 374802.0, 375662.0, 376090.0, 33263.50104748431, 56856.43143568511, 57272.14091788627, 57362.42637573654, 57613.71193144008, 34141.829290853886, 36592.81703591465, 36611.4508282376, 36631.633683663356, 36660.0, 14422.42310307576, 14557.344919478648, 14563.199024053778, 14587.781183282259, 14603.488877889224, 11876.10929180315, 11907.226030308002, 11913.285202887855, 11929.821052684216, 11969.581064662694, 8071.959640201879, 8219.0, 8249.175082491704, 8273.172682731678, 8322.583870806435, 3165.715085642303, 3167.3394348747165, 3179.2210908327147, 3194.297254603983, 3205.759568032407, 987.9407235565889, 1000.2797985450464, 1035.2753072849036, 1082.7780305037447, 1094.2449709700281, 31013.534796978063, 31696.683033169833, 32046.519302210487, 32056.83971580127, 32425.0, 1087.8840654926094, 1154.936478493674, 1219.5243854896598, 1235.172434468908, 1241.3606992398923, 16781.83218167827, 16797.83202167987, 16826.495205143867, 16828.663426731397, 16864.662706745796, 556286.0, 561613.0, 562443.0, 563112.0, 568157.0, 58751.0, 60332.0, 60391.094133588034, 60395.39604603986, 60407.0, 1231.132051903406, 1324.086380397542, 1361.2649169448584, 1364.5087768403366, 1378.9862101379258, 32403.837980809945, 33379.33241335208, 33661.66338336683, 34109.65890341164, 34402.31195376129, 54484.0, 56371.43628563826, 56413.71793141008, 61152.0, 61235.0, 519069.0, 523703.0, 524061.3157078968, 525686.0, 527832.0, 37279.81360093182, 42434.5756542443, 43011.13977720366, 44462.77768611136, 45208.54791452175, 48315.5168448311, 48816.755916220194, 48989.2651610219, 49456.25815612841, 49859.501404986935, 41452.37821432621, 41916.580834192486, 42199.0, 42325.576744233396, 43354.349684754125, 41442.58557414387, 41803.37294940639, 41969.160616788104, 42003.7899810499, 42699.0, 36516.26967460689, 36890.8155459221, 37006.814965925, 41224.0, 42057.0, 35540.46689299611, 37554.0, 38147.0, 38568.228635427695, 38631.0, 28260.71739282581, 28499.857500712365, 28520.714792851806, 28744.712552874204, 28759.71240287654], "value": 19378.834038156176, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.42053964103167, 388.215804075767, 389.47615457210054, 399.7122072108081, 409.4431573060637, 17773.200205990728, 18570.53573660656, 20445.48886277842, 20854.270100546484, 20930.581388372222, 11166.274192177503, 11453.541858325678, 11729.354885481316, 11732.648020559376, 11732.882671173285, 5025.321581586485, 5296.9735151324385, 5318.547923426513, 5320.574354051686, 5323.866903327428, 3793.1465420280356, 5442.047641662713, 5732.856678583027, 5742.569307301948, 5823.650580965155, 5585.2459917910965, 5795.043817770063, 5799.130130480419, 5813.186153938452, 5822.301323841145, 5821.27234095738, 5860.355360910317, 5881.617694849864, 5907.14346419771, 5919.023361145384, 3552.2007548301426, 5304.655197412156, 5608.887822243532, 5614.550835933156, 5672.574556908207, 13535.864641353559, 13620.659483512893, 14822.40710371584, 22586.322410327553, 22630.321090367317, 2393.640953856918, 2407.6749638798888, 2589.9870500647567, 2621.8426894386207, 2679.7454241846995, 9871.851922221173, 10221.080102790784, 10294.485275736184, 10389.636362727268, 14011.369488373048, 1925.3261358524544, 1942.553212761073, 1974.5458544534695, 1974.7531558555181, 2037.9796202037937, 75499.62250188769, 78120.0, 78965.0, 79224.0, 79471.20528794696, 10553.0, 10624.36253824773, 11368.658940231806, 11626.593069242535, 11930.522779088913, 15180.316885739947, 15214.543563693107, 15295.0, 15314.387424503118, 15324.387024518894, 7925.405594580429, 8098.75703728889, 8185.631646575918, 8264.0, 8277.089520152778, 7664.156942736295, 7683.846323073507, 7802.141764405911, 7896.249856263646, 7977.242161994601, 4702.929456058162, 4736.194846876039, 4758.881027974259, 4795.904081918342, 4821.734804585782, 1822.3621732393822, 1824.8430215726867, 1848.7798053284766, 1908.1699460734626, 1965.0960558143129, 909.481595490564, 938.5635679408971, 958.2046901072233, 969.8254314223508, 992.811365840488, 18595.44213673592, 18782.0, 19156.04219789005, 19529.21883124659, 20089.497762556053, 961.3703024518951, 986.9259805514615, 1011.206203130539, 1034.4052170002278, 1074.505727365405, 9812.264080194014, 10958.28771129874, 10977.83533247002, 10999.890001100046, 11018.669439916815, 480727.0, 487687.0, 488918.0, 518393.0, 531435.0, 95970.52014740021, 103060.0, 104086.4795676032, 104319.0, 104391.0, 992.1764935103846, 1021.8569400283966, 1024.7335692719798, 1043.1758910460803, 1044.5769463367349, 18077.548061298574, 18321.17554710068, 18733.90633046826, 18784.651808637125, 18805.435836924913, 42987.78506107449, 43573.346399804665, 43990.340144898495, 44633.33050004188, 46024.539754602025, 62155.689221553606, 62941.68529157325, 63523.04715429365, 63736.68131659312, 64355.034674478986, 8316.833663326579, 8364.163583641588, 8439.70461033861, 8497.660093596187, 8515.82968340642, 9301.023392543957, 10734.0, 13376.598702038955, 13935.860641393456, 13945.233012184022, 12013.75972480563, 12094.75810483803, 12212.694682633006, 12313.815292770436, 12497.437615307515, 12037.75924481523, 12058.155929085231, 12152.21010634306, 12158.088143389105, 12159.513619455123, 12165.330906799856, 12289.324087174933, 12464.626061218178, 12486.937565312115, 12606.810897836724, 7083.185433675193, 7542.698292068256, 7724.420668450001, 8201.95899020525, 8439.240468357877, 8685.001224859223, 11900.28598284071, 11927.701807454883, 12048.75902481963, 12115.0], "value": 9065.219811912897, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.4248709324343, 1408.908420952638, 1442.2572375226757, 1529.5334922848526, 1671.156066186575, 8197.672093116276, 8579.313654907608, 8596.785080372985, 8837.072107428723, 8841.823163536725, 8541.572921353938, 8726.38915275931, 8729.34529910256, 8736.956315218431, 8742.912570874289, 2292.0, 2328.045501344449, 2328.15022516781, 2330.2892617751577, 2332.0, 2334.9066037358484, 2335.754745751697, 2374.7387787343378, 2376.3821406434276, 2378.8453750506246, 2316.536692661466, 2330.1262026739973, 2335.5212181502834, 2361.327021798788, 2363.4800343924308, 2283.760205178449, 2303.216906251874, 2305.458217318937, 2307.296274636227, 2326.5695846268495, 2251.8311126665567, 2253.053717438663, 2257.8532395394245, 2257.9435514112115, 2295.21962532738, 8468.957655211747, 8682.565871706389, 8735.606897689619, 8737.388382813206, 8738.781530461725, 5103.7192954387865, 5226.686398816083, 5231.319928409321, 5232.607554433394, 5232.973835130838, 3203.7917535360125, 3214.228585139573, 3243.96756032439, 3245.8539365728598, 3261.7768336873673, 1143.6283207957365, 1181.2144923625865, 1186.0926391310654, 1209.818527220915, 1235.765204611121, 11769.0, 11836.171467997243, 11868.228565143238, 11889.227200231957, 11994.700132496757, 4329.545397733255, 4342.913141737147, 4453.042595841909, 4512.4133862597655, 4549.021960278556, 9466.574004169828, 9499.762505937408, 9500.762480938032, 9507.619695212252, 9510.286728495252, 5190.532852043334, 5201.479852014768, 5201.557867581222, 5209.218617207373, 5210.921836172461, 4353.934690979638, 4583.770811459413, 4709.576138147583, 4720.103180395782, 4765.7140571565815, 3616.9819150904605, 3674.963250367462, 3765.5104836371097, 3777.867774627875, 3795.35478968576, 1058.3491152940885, 1097.7145942054963, 1103.7020004598714, 1118.3960661242838, 1120.383788916109, 712.3304094151481, 924.0, 940.9294302927171, 944.9716508504756, 956.1346980982222, 5567.025770490229, 5633.63381380209, 5650.802221922213, 5687.402822703557, 5887.528997680175, 947.2516711797603, 951.1297163095828, 962.0571839597094, 968.070652173921, 984.4831463481729, 3902.2195560887935, 3985.601439855991, 4026.859059932888, 4042.8787136385367, 4173.0, 10562.630307939186, 10848.0, 10960.725981850359, 10971.122310215324, 11002.33985960845, 10736.141108711441, 10786.352818830896, 10828.187885908588, 10829.133669306437, 10845.186611004206, 8061.556614386148, 8093.554854482943, 8228.547429891294, 8231.135730748185, 8232.547209903392, 5393.757280922289, 5397.460253974571, 5444.02007638613, 5465.535429488538, 5476.863078423071, 9956.950215248877, 9986.450745209084, 10001.899981000097, 10017.198624110199, 10038.598456061676, 9756.170725488413, 10010.749731256778, 10044.899551004397, 10281.588736450458, 10292.0, 7100.360967512948, 7442.813929651586, 7642.0, 7717.1896950819355, 7856.921430785847, 8529.82940341202, 8602.225799678059, 8631.784205394915, 8677.956610216908, 8680.82638347217, 7528.962355188408, 7778.844423111619, 7806.726764563213, 7808.726694565663, 7876.72431464896, 7405.925940740523, 7510.586917719578, 7595.886061708969, 7626.351760100453, 7785.961070194613, 6521.087047813215, 6562.770303039561, 6574.671266436755, 6576.934230657824, 6587.670616469061, 4932.901341973069, 4959.156943319716, 5104.617153713561, 5105.387353517602, 5149.2276158576515, 4950.282209079592, 5025.974870125626, 5030.245463180552, 5081.949180508148, 5112.769925353294], "value": 4531.38381137119, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.9340738444927, 314.5439113285735, 324.36910209642247, 325.0929905563477, 335.15875153365045, 5319.813806516768, 5355.169948657959, 5365.114756065254, 5390.272313237717, 5411.83764487065, 4935.6545041847085, 5137.332146820918, 5220.556252718514, 5240.187770895508, 5300.920486192701, 4139.0, 4168.353905144708, 4176.665866730655, 4201.264778663737, 4209.894752631186, 4199.496060472748, 4203.48674477188, 4214.536400995888, 4224.767637779921, 4248.405223268729, 3880.5731369549326, 3964.583718709537, 4027.375756757707, 4055.2700513907635, 4129.6696264298935, 4079.8788926471275, 4086.734362266443, 4110.219058378899, 4110.848962290548, 4112.876613701579, 3587.6232995535615, 3598.838052287653, 3599.964000359989, 3606.945895811565, 3613.7713177519768, 4892.779824907888, 5134.306868572769, 5140.588752899759, 5174.844754657366, 5194.662346947436, 4659.394278743742, 4676.883077923045, 4694.624430045622, 4727.321800760715, 4745.21703918853, 5455.618106732531, 5490.270564772084, 5495.945040549624, 5525.889482210374, 5558.499735023867, 3901.7073719471155, 3943.684505239574, 3965.861194858166, 3967.1552727981625, 4043.818028188709, 5745.511631511326, 5755.884882302331, 5764.481196692276, 5769.394213607553, 5789.073748200268, 4009.4787677601726, 4033.6773058155277, 4044.939325910114, 4069.5146271610647, 4073.3889916512167, 3818.312703713358, 4039.434479172918, 4096.897577560525, 4103.871435355301, 4103.938440923389, 4610.331501932201, 4628.884277893012, 4631.096936097429, 4652.674312798139, 4670.439547254351, 5559.442656378031, 5569.777208911679, 5574.358948720868, 5575.526080283222, 5593.412691667398, 1369.88355989742, 1409.6757745718542, 1413.943442262298, 1431.5705288413642, 1434.2971943747698, 902.9142231487998, 910.886139232596, 914.0996118822954, 917.6283605139929, 922.9215516681157, 4770.451398089264, 4795.304680821261, 4798.832040878552, 4837.4920633332995, 4868.610511159099, 5072.847814565569, 5078.085944529947, 5079.619028572872, 5083.288339632454, 5112.872178195575, 4454.202644559757, 4756.548127927841, 4787.3537072495465, 4793.664443488922, 4818.95181048185, 2696.9595456068173, 2698.745083536165, 2709.878055487508, 2712.5795501697266, 2714.172177485846, 5143.537081662594, 5216.66091704038, 5218.243354713545, 5238.711870847063, 5244.711540865213, 4717.481077081518, 5096.64237077301, 5125.948740512547, 5144.71704056273, 5186.8215349553275, 5057.673470203674, 5178.679436743681, 5186.533212010937, 5195.7142357170715, 5213.374395072616, 4995.025969935828, 4998.900241946766, 5041.294218809443, 5080.094964388354, 5084.0, 4801.927971080367, 4974.37820272466, 4979.800807967786, 5003.949960500348, 5009.09472505953, 5170.482951704799, 5213.973930130325, 5223.216517522402, 5250.501202385767, 5259.894802104013, 3701.833417496273, 3744.6332088786853, 3771.283456143324, 3775.716821238363, 3834.731568790158, 5478.80824171168, 5651.350094739158, 5656.0, 5664.886702266014, 5761.2222349983895, 5497.065498865282, 5504.366997795305, 5534.0, 5534.778608855761, 5562.833115006556, 5249.317588713443, 5536.809585939042, 5551.694656793915, 5570.270567422015, 5582.888342233214, 5355.598330125178, 5411.864703382447, 5428.185772134211, 5473.17902314656, 5485.122380419114, 5511.0, 5580.298009107261, 5649.971750141223, 5654.604177707521, 5662.433756624305, 5274.551663108526, 5453.672779633234, 5455.18172274162, 5475.315585551806, 5484.533814625642], "value": 4074.0773858791076, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.0669382945366, 713.0017974835226, 760.9840862448631, 804.9798755031123, 829.4940086547207, 14044.0, 15005.099694018367, 15152.318145683443, 15165.545033649008, 15166.696666066671, 13726.931365343184, 13991.440342386293, 14011.64970875726, 14020.0, 14028.859711402883, 646.644345609915, 757.4243574883074, 761.3034073822446, 766.1074847802304, 780.6526095887332, 785.0618510879501, 785.1481142959896, 785.3834739729314, 787.2560430393281, 787.8700014497601, 819.0417211862106, 819.5410570080744, 820.8768684697284, 820.9014918209823, 820.9876851847227, 682.556338380052, 789.8775689768066, 809.7854068671807, 809.9473534220316, 810.9148539403366, 587.8941790477712, 590.0706387439757, 590.583638534832, 590.6426611899782, 591.9852003699899, 13408.26254555999, 13487.595372138852, 13488.730225395535, 13496.730065398637, 13604.659883502893, 13131.212127272394, 14389.208593527352, 14485.78271325931, 14631.70736585273, 14721.043132196373, 12604.936975315157, 12767.680807979781, 12863.614091577268, 13011.284379359131, 13488.797668034988, 4336.392904993303, 4420.889477763081, 4443.844465443694, 4528.275475923836, 4542.772861356952, 73411.89084014163, 73429.63285183594, 74281.6285918567, 74567.0, 79062.0, 11041.083216021423, 11062.157185006352, 11124.221304508768, 11284.774304514029, 11308.943455282835, 20956.266530671353, 21077.683834742493, 21110.894445527672, 21120.0, 21120.78879211219, 8438.0, 8443.36674749384, 8477.74566762998, 8508.446950948168, 8686.34852386061, 4562.498125206224, 4830.830920917751, 4850.6362022847725, 4885.193942999436, 5044.8234311798915, 3207.7594180436095, 3299.2411745298236, 3315.61870384904, 3316.6020077590842, 3317.950230746541, 582.8746819433842, 607.6840043177523, 610.4841409009468, 613.6348872420903, 620.0884699491739, 602.8884656338591, 606.2785285510229, 683.1392445518683, 684.8596037812237, 709.5281637710865, 9044.41211321262, 9174.128457796498, 9459.432434053979, 9464.432134071978, 9514.524273786283, 646.1115965547373, 667.5360624366019, 712.2734810493267, 713.2867132867133, 769.9384049276044, 4347.956520434818, 4662.6269898408045, 4690.132325519789, 4723.551262630044, 4829.444613869379, 108477.45761271143, 109468.4526577362, 113344.0, 116364.41817791027, 116730.0, 93124.0, 97542.0, 97633.0, 98312.50843745879, 98489.50755246179, 53909.65225869306, 71125.0, 76844.23155768482, 79180.6040969803, 86889.5655521731, 9550.570224339783, 9619.134277915022, 9706.272029597667, 9785.412875227508, 10076.69769906904, 49221.54134813161, 55771.40466811837, 56841.71579142078, 58228.12657810051, 60598.394016059276, 44205.33691994687, 45138.0, 45284.773576131905, 77723.61138194273, 80460.19539804761, 11859.466324015613, 12667.176633518791, 13167.341632918507, 13257.07200495956, 13953.720925581634, 13364.933175334061, 14881.312386598187, 15261.465848695243, 15372.252563281962, 15771.427432296097, 14071.718565628425, 14235.64410889736, 14343.426262949783, 14572.0, 14764.261786910827, 13193.934030329787, 13507.662308442368, 13626.0, 13638.93180534091, 13986.16083035021, 13723.245221512912, 13922.443102275796, 14096.154230746188, 14138.858611414165, 14496.492622758153, 10875.728106797393, 11340.376279304717, 11609.88390116088, 11639.41802909868, 11680.883191167979, 11048.171387146156, 11426.143039271921, 11469.31184128955, 11480.425978701198, 11518.53925842957], "value": 7407.470691916545, "unit": "score"}], "name": "dromaeo_css", "value": 7074.016269131406, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 113.0, 112.0, 112.0, 112.0, 111.0, 111.0, 111.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 134.0, 195.0, 126.0, 136.0, 126.0, 157.0, 164.0, 125.0], "value": 144.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 160.0, 161.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 122.0, 76.0, 77.0, 75.0, 75.0, 98.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 117.0, 84.0, 85.0, 85.0, 115.0, 85.0, 84.0, 122.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 51.0, 52.0, 51.0, 53.0, 52.0, 51.0, 52.0, 55.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 60.0, 62.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 85.0, 79.0, 80.0, 80.0, 80.0, 82.0, 89.0, 81.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 129.0, 126.0, 132.0, 123.0, 131.0, 124.0, 133.0, 149.0, 121.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 158.0, 158.0, 157.0, 157.0, 157.0, 156.0, 158.0, 155.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1496.1, "alertThreshold": 2.0}]} 04:37:12 INFO - Return code: 0 04:37:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:37:12 INFO - # TBPL SUCCESS # 04:37:12 INFO - Running post-action listener: _resource_record_post_action 04:37:12 INFO - ##### 04:37:12 INFO - ##### Finished run-tests step (success) 04:37:12 INFO - ##### 04:37:12 INFO - Running post-run listener: _resource_record_post_run 04:37:12 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554266624; Read time: 28; Write time: 1719236 04:37:12 INFO - TinderboxPrint: CPU usage
13.4% 04:37:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 04:37:12 INFO - TinderboxPrint: I/O write bytes / time
554,266,624 / 1,719,236 04:37:12 INFO - TinderboxPrint: CPU idle
8,269.6 (86.6%) 04:37:12 INFO - TinderboxPrint: CPU user
1,217.8 (12.8%) 04:37:12 INFO - TinderboxPrint: Swap in / out
0 / 0 04:37:12 INFO - install - Wall time: 17s; CPU: 21.0%; Read bytes: 0; Write bytes: 258138112; Read time: 0; Write time: 1313120 04:37:12 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296128512; Read time: 28; Write time: 406116 04:37:12 INFO - Running post-run listener: _upload_blobber_files 04:37:12 INFO - Blob upload gear active. 04:37:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:37:12 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 04:37:12 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:37:12 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:37:13 INFO - (blobuploader) - INFO - Open directory for files ... 04:37:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:37:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:37:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:16 INFO - (blobuploader) - INFO - Done attempting. 04:37:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:37:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:37:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:17 INFO - (blobuploader) - INFO - Done attempting. 04:37:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:37:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:37:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:17 INFO - (blobuploader) - INFO - Done attempting. 04:37:17 INFO - (blobuploader) - INFO - Iteration through files over. 04:37:17 INFO - Return code: 0 04:37:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:37:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:37:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8680c21111210a91aa016f1db27238cdd11bbff6bef2ee12dcf6c5fa49a720d83265463fbe03e05c441858573023c9628c9fae20bf333f1d8b8fe63756dae001", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/43cb88984fad7486a951dab5e43c38bc8ccc09fa9372e5ce98f78fb315d25367f56e454add1cdc0e7e4865c4bb5ed8d9f28762e5773855cfb579f6276302d8cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3df4ad87c91b09124cd24365be826d8be3a33c71885dbbbb795803baaad12d57cfca3cd270ba101a120d5162b37207da27aa593bba0cd0ba6e9e007030591929"} 04:37:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:37:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:37:17 INFO - Contents: 04:37:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8680c21111210a91aa016f1db27238cdd11bbff6bef2ee12dcf6c5fa49a720d83265463fbe03e05c441858573023c9628c9fae20bf333f1d8b8fe63756dae001", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/43cb88984fad7486a951dab5e43c38bc8ccc09fa9372e5ce98f78fb315d25367f56e454add1cdc0e7e4865c4bb5ed8d9f28762e5773855cfb579f6276302d8cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3df4ad87c91b09124cd24365be826d8be3a33c71885dbbbb795803baaad12d57cfca3cd270ba101a120d5162b37207da27aa593bba0cd0ba6e9e007030591929"} 04:37:17 INFO - Running post-run listener: copy_logs_to_upload_dir 04:37:17 INFO - Copying logs to upload dir... 04:37:17 INFO - mkdir: /builds/slave/test/build/upload/logs 04:37:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.607891 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-28 04:37:17.488320) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 04:37:17.491963) ========= 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=df17445c3590ff7897617a0e00000225-1467112513.481295-677044372 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-Inbound/sha512/8680c21111210a91aa016f1db27238cdd11bbff6bef2ee12dcf6c5fa49a720d83265463fbe03e05c441858573023c9628c9fae20bf333f1d8b8fe63756dae001", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/43cb88984fad7486a951dab5e43c38bc8ccc09fa9372e5ce98f78fb315d25367f56e454add1cdc0e7e4865c4bb5ed8d9f28762e5773855cfb579f6276302d8cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3df4ad87c91b09124cd24365be826d8be3a33c71885dbbbb795803baaad12d57cfca3cd270ba101a120d5162b37207da27aa593bba0cd0ba6e9e007030591929"} build_url:https://queue.taskcluster.net/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011150 build_url: 'https://queue.taskcluster.net/v1/task/cWIi6u0dQBu3vAV3zC-7Og/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8680c21111210a91aa016f1db27238cdd11bbff6bef2ee12dcf6c5fa49a720d83265463fbe03e05c441858573023c9628c9fae20bf333f1d8b8fe63756dae001", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/43cb88984fad7486a951dab5e43c38bc8ccc09fa9372e5ce98f78fb315d25367f56e454add1cdc0e7e4865c4bb5ed8d9f28762e5773855cfb579f6276302d8cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3df4ad87c91b09124cd24365be826d8be3a33c71885dbbbb795803baaad12d57cfca3cd270ba101a120d5162b37207da27aa593bba0cd0ba6e9e007030591929"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 04:37:17.517123) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:37:17.517463) ========= 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=df17445c3590ff7897617a0e00000225-1467112513.481295-677044372 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004703 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:37:17.603161) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 04:37:17.603465) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 04:37:17.603847) ========= ========= Total master_lag: 0.17 =========