builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1466453104.74 results: success (0) buildid: 20160620103051 builduid: cf6630b4c3ab498094ab6e86cf4e3712 revision: c4be443b20d068b1a18b6929c6e2f76fef4de235 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 13:05:04.739805) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 13:05:04.740232) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 13:05:04.740578) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 13:05:04.814523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 13:05:04.814813) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-20 13:05:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-20 13:05:05 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107981 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 13:05:04.937061) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 13:05:04.937412) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019816 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 13:05:04.988560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 13:05:04.988920) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c4be443b20d068b1a18b6929c6e2f76fef4de235 --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 c4be443b20d068b1a18b6929c6e2f76fef4de235 --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=934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-20 13:05:05,256 truncating revision to first 12 chars 2016-06-20 13:05:05,256 Setting DEBUG logging. 2016-06-20 13:05:05,256 attempt 1/10 2016-06-20 13:05:05,256 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c4be443b20d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-20 13:05:05,569 unpacking tar archive at: mozilla-inbound-c4be443b20d0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.689724 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 13:05:05.692839) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 13:05:05.693283) ========= script_repo_revision: c4be443b20d068b1a18b6929c6e2f76fef4de235 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 13:05:05.693756) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 13:05:05.694173) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 13:05:05.704361) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-20 13:05:05.704815) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:05:06 INFO - MultiFileLogger online at 20160620 13:05:06 in /builds/slave/test 13:05:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 13:05:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:05:06 INFO - {'append_to_log': False, 13:05:06 INFO - 'base_work_dir': '/builds/slave/test', 13:05:06 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:05:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:05:06 INFO - 'branch': 'Mozilla-Inbound', 13:05:06 INFO - 'buildbot_json_path': 'buildprops.json', 13:05:06 INFO - 'config_files': ('talos/linux_config.py',), 13:05:06 INFO - 'default_actions': ('clobber', 13:05:06 INFO - 'read-buildbot-config', 13:05:06 INFO - 'download-and-extract', 13:05:06 INFO - 'populate-webroot', 13:05:06 INFO - 'create-virtualenv', 13:05:06 INFO - 'install', 13:05:06 INFO - 'run-tests'), 13:05:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:05:06 INFO - 'download_minidump_stackwalk': True, 13:05:06 INFO - 'download_symbols': 'ondemand', 13:05:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:05:06 INFO - 'tooltool.py': '/tools/tooltool.py', 13:05:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:05:06 INFO - '/tools/misc-python/virtualenv.py')}, 13:05:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:05:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:05:06 INFO - 'installer_path': 'installer.exe', 13:05:06 INFO - 'log_level': 'info', 13:05:06 INFO - 'log_name': 'talos', 13:05:06 INFO - 'log_to_console': True, 13:05:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:05:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:05:06 INFO - 'opt_config_files': (), 13:05:06 INFO - 'pip_index': False, 13:05:06 INFO - 'sps_profile': False, 13:05:06 INFO - 'sps_profile_interval': 0, 13:05:06 INFO - 'suite': 'dromaeojs-e10s', 13:05:06 INFO - 'system_bits': '32', 13:05:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:05:06 INFO - 'title': 'talos-linux64-ix-057', 13:05:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:05:06 INFO - 'use_talos_json': True, 13:05:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:05:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:05:06 INFO - 'work_dir': 'build'} 13:05:06 INFO - ##### 13:05:06 INFO - ##### Running clobber step. 13:05:06 INFO - ##### 13:05:06 INFO - Running pre-action listener: _resource_record_pre_action 13:05:06 INFO - Running main action method: clobber 13:05:06 INFO - rmtree: /builds/slave/test/build 13:05:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:05:07 INFO - Running post-action listener: _resource_record_post_action 13:05:07 INFO - ##### 13:05:07 INFO - ##### Finished clobber step (success) 13:05:07 INFO - ##### 13:05:07 INFO - ##### 13:05:07 INFO - ##### Running read-buildbot-config step. 13:05:07 INFO - ##### 13:05:07 INFO - Running pre-action listener: _resource_record_pre_action 13:05:07 INFO - Running main action method: read_buildbot_config 13:05:07 INFO - Using buildbot properties: 13:05:07 INFO - { 13:05:07 INFO - "project": "", 13:05:07 INFO - "product": "firefox", 13:05:07 INFO - "script_repo_revision": "production", 13:05:07 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 13:05:07 INFO - "repository": "", 13:05:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 13:05:07 INFO - "buildid": "20160620103051", 13:05:07 INFO - "pgo_build": "True", 13:05:07 INFO - "basedir": "/builds/slave/test", 13:05:07 INFO - "buildnumber": 889, 13:05:07 INFO - "slavename": "talos-linux64-ix-057", 13:05:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:05:07 INFO - "platform": "ubuntu64_hw", 13:05:07 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:05:07 INFO - "branch": "mozilla-inbound", 13:05:07 INFO - "repo_path": "integration/mozilla-inbound", 13:05:07 INFO - "revision": "c4be443b20d068b1a18b6929c6e2f76fef4de235", 13:05:07 INFO - "stage_platform": "linux64-pgo", 13:05:07 INFO - "builduid": "cf6630b4c3ab498094ab6e86cf4e3712", 13:05:07 INFO - "slavebuilddir": "test" 13:05:07 INFO - } 13:05:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:05:07 INFO - Running post-action listener: _resource_record_post_action 13:05:07 INFO - ##### 13:05:07 INFO - ##### Finished read-buildbot-config step (success) 13:05:07 INFO - ##### 13:05:07 INFO - ##### 13:05:07 INFO - ##### Running download-and-extract step. 13:05:07 INFO - ##### 13:05:07 INFO - Running pre-action listener: _resource_record_pre_action 13:05:07 INFO - Running main action method: download_and_extract 13:05:07 INFO - mkdir: /builds/slave/test/build/tests 13:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:07 INFO - https://queue.taskcluster.net/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:05:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:05:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:05:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/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 13:05:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/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 13:05:08 INFO - Downloaded 1361 bytes. 13:05:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:05:08 INFO - Using the following test package requirements: 13:05:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:05:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:05:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:05:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:05:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:05:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:05:08 INFO - u'jsshell-linux-x86_64.zip'], 13:05:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:05:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:05:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:05:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:05:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:05:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:05:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:05:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:05:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:05:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:05:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:05:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:05: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')]} 13:05:08 INFO - https://queue.taskcluster.net/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:05:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:05:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:05:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/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 13:05:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/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 13:05:09 INFO - Downloaded 24178385 bytes. 13:05:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:05:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:05:10 INFO - Return code: 0 13:05:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:10 INFO - https://queue.taskcluster.net/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:05:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:05:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:05:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/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 13:05:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/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 13:05:19 INFO - Downloaded 24178385 bytes. 13:05:19 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'] 13:05:19 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 13:05:20 INFO - Return code: 0 13:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:05:20 INFO - https://queue.taskcluster.net/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:05:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:05:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:05:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/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 13:05:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/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 13:05:21 INFO - Downloaded 14405384 bytes. 13:05:21 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'] 13:05:21 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 13:05:21 INFO - Return code: 0 13:05:21 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')]} 13:05:21 INFO - https://queue.taskcluster.net/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:05:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:05:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:05:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/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 13:05:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/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 13:05:23 INFO - Downloaded 59182918 bytes. 13:05:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:05:23 INFO - mkdir: /builds/slave/test/properties 13:05:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:05:23 INFO - Writing to file /builds/slave/test/properties/build_url 13:05:23 INFO - Contents: 13:05:23 INFO - build_url:https://queue.taskcluster.net/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:05:23 INFO - Running post-action listener: _resource_record_post_action 13:05:23 INFO - Running post-action listener: set_extra_try_arguments 13:05:23 INFO - ##### 13:05:23 INFO - ##### Finished download-and-extract step (success) 13:05:23 INFO - ##### 13:05:23 INFO - ##### 13:05:23 INFO - ##### Running populate-webroot step. 13:05:23 INFO - ##### 13:05:23 INFO - Running pre-action listener: _resource_record_pre_action 13:05:23 INFO - Running main action method: populate_webroot 13:05:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:05:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:05:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:05:23 INFO - '--tppagecycles', 13:05:23 INFO - '7'], 13:05:23 INFO - 'tests': ['tsvgm']}}, 13:05:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:05:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:05:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:05:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:05:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:05:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:05:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:23 INFO - 'talos_options': ['--disable-e10s'], 13:05:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:05:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:05:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:23 INFO - 'talos_options': ['--disable-e10s'], 13:05:23 INFO - 'tests': ['damp', 'tps']}, 13:05:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:23 INFO - 'tests': ['damp', 'tps']}, 13:05:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:05:23 INFO - 'tests': ['dromaeo_dom']}, 13:05:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:05:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:05:23 INFO - 'tests': ['basic_compositor_video']}, 13:05:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:05:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:05:23 INFO - 'tests': ['a11yr', 13:05:23 INFO - 'ts_paint', 13:05:23 INFO - 'tpaint', 13:05:23 INFO - 'sessionrestore', 13:05:23 INFO - 'sessionrestore_no_auto_restore', 13:05:23 INFO - 'tabpaint']}, 13:05:23 INFO - 'other-e10s': {'tests': ['a11yr', 13:05:23 INFO - 'ts_paint', 13:05:23 INFO - 'tpaint', 13:05:23 INFO - 'sessionrestore', 13:05:23 INFO - 'sessionrestore_no_auto_restore', 13:05:23 INFO - 'tabpaint']}, 13:05:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:05:23 INFO - 'ts_paint', 13:05:23 INFO - 'tpaint', 13:05:23 INFO - 'sessionrestore', 13:05:23 INFO - 'sessionrestore_no_auto_restore', 13:05:23 INFO - 'tabpaint']}, 13:05:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:05:23 INFO - 'ts_paint', 13:05:23 INFO - 'tpaint', 13:05:23 INFO - 'sessionrestore', 13:05:23 INFO - 'sessionrestore_no_auto_restore', 13:05:23 INFO - 'tabpaint']}, 13:05:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:05:23 INFO - 'tests': ['a11yr', 13:05:23 INFO - 'ts_paint', 13:05:23 INFO - 'tpaint', 13:05:23 INFO - 'sessionrestore', 13:05:23 INFO - 'sessionrestore_no_auto_restore', 13:05:23 INFO - 'tabpaint']}, 13:05:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:05:23 INFO - 'tests': ['a11yr', 13:05:23 INFO - 'ts_paint', 13:05:23 INFO - 'tpaint', 13:05:23 INFO - 'sessionrestore', 13:05:23 INFO - 'sessionrestore_no_auto_restore', 13:05:23 INFO - 'tabpaint']}, 13:05:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:05:23 INFO - 'tests': ['tsvgx', 13:05:23 INFO - 'tsvgr_opacity', 13:05:23 INFO - 'tart', 13:05:23 INFO - 'tscrollx', 13:05:23 INFO - 'cart']}, 13:05:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:05:23 INFO - 'tsvgr_opacity', 13:05:23 INFO - 'tart', 13:05:23 INFO - 'tscrollx', 13:05:23 INFO - 'cart']}, 13:05:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:23 INFO - 'talos_options': ['--disable-e10s'], 13:05:23 INFO - 'tests': ['tp5o']}, 13:05:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:23 INFO - 'tests': ['tp5o']}, 13:05:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:23 INFO - 'talos_options': ['--disable-e10s', 13:05:23 INFO - '--xperf_path', 13:05:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:05:23 INFO - 'tests': ['tp5n']}, 13:05:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:05:23 INFO - 'talos_options': ['--xperf_path', 13:05:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:05:23 INFO - 'tests': ['tp5n']}}, 13:05:23 INFO - 'talos.zip': {'path': '', 13:05:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:05:23 INFO - Running post-action listener: _resource_record_post_action 13:05:23 INFO - ##### 13:05:23 INFO - ##### Finished populate-webroot step (success) 13:05:23 INFO - ##### 13:05:23 INFO - ##### 13:05:23 INFO - ##### Running create-virtualenv step. 13:05:23 INFO - ##### 13:05:23 INFO - Running pre-action listener: _resource_record_pre_action 13:05:23 INFO - Running main action method: create_virtualenv 13:05:23 INFO - Creating virtualenv /builds/slave/test/build/venv 13:05:23 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 13:05:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:05:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:05:23 INFO - Using real prefix '/usr' 13:05:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:05:24 INFO - Installing distribute.............................................................................................................................................................................................done. 13:05:26 INFO - Installing pip.................done. 13:05:26 INFO - Return code: 0 13:05:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:05:26 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')]} 13:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:26 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')]} 13:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:26 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 0x7fa4504c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28352e0>, '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 0x27a1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a15d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', '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 13:05:26 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 13:05:26 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 13:05:26 INFO - Using env: {'DISPLAY': ':0', 13:05:26 INFO - 'HOME': '/home/cltbld', 13:05:26 INFO - 'LANG': 'en_US.UTF-8', 13:05:26 INFO - 'LANGUAGE': 'en_US:en', 13:05:26 INFO - 'LOGNAME': 'cltbld', 13:05:26 INFO - 'MAIL': '/var/mail/cltbld', 13:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:26 INFO - 'MOZ_NO_REMOTE': '1', 13:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:26 INFO - 'NO_EM_RESTART': '1', 13:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:26 INFO - 'PWD': '/builds/slave/test', 13:05:26 INFO - 'SHELL': '/bin/bash', 13:05:26 INFO - 'SHLVL': '1', 13:05:26 INFO - 'TERM': 'linux', 13:05:26 INFO - 'TMOUT': '86400', 13:05:26 INFO - 'USER': 'cltbld', 13:05:26 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', 13:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:26 INFO - '_': '/tools/buildbot/bin/python'} 13:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:26 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 13:05:26 INFO - Cleaning up... 13:05:26 INFO - Return code: 0 13:05:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:05:26 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')]} 13:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:26 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')]} 13:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:26 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 0x7fa4504c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28352e0>, '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 0x27a1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a15d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', '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 13:05:26 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 13:05:26 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 13:05:26 INFO - Using env: {'DISPLAY': ':0', 13:05:26 INFO - 'HOME': '/home/cltbld', 13:05:26 INFO - 'LANG': 'en_US.UTF-8', 13:05:26 INFO - 'LANGUAGE': 'en_US:en', 13:05:26 INFO - 'LOGNAME': 'cltbld', 13:05:26 INFO - 'MAIL': '/var/mail/cltbld', 13:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:26 INFO - 'MOZ_NO_REMOTE': '1', 13:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:26 INFO - 'NO_EM_RESTART': '1', 13:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:26 INFO - 'PWD': '/builds/slave/test', 13:05:26 INFO - 'SHELL': '/bin/bash', 13:05:26 INFO - 'SHLVL': '1', 13:05:26 INFO - 'TERM': 'linux', 13:05:26 INFO - 'TMOUT': '86400', 13:05:26 INFO - 'USER': 'cltbld', 13:05:26 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', 13:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:26 INFO - '_': '/tools/buildbot/bin/python'} 13:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:26 INFO - Downloading/unpacking psutil>=3.1.1 13:05:26 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 13:05:26 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 13:05:26 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 13:05:26 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 13:05:26 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 13:05:26 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 13:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:05:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:05:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:05:28 INFO - Installing collected packages: psutil 13:05:28 INFO - Running setup.py install for psutil 13:05:29 INFO - building 'psutil._psutil_linux' extension 13:05:29 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 13:05:29 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 13:05:29 INFO - building 'psutil._psutil_posix' extension 13:05:29 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 13:05:29 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 13:05:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:05:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:05:29 INFO - Successfully installed psutil 13:05:29 INFO - Cleaning up... 13:05:29 INFO - Return code: 0 13:05:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:29 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 0x7fa4504c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28352e0>, '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 0x27a1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a15d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', '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 13:05:29 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 13:05:29 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 13:05:29 INFO - Using env: {'DISPLAY': ':0', 13:05:29 INFO - 'HOME': '/home/cltbld', 13:05:29 INFO - 'LANG': 'en_US.UTF-8', 13:05:29 INFO - 'LANGUAGE': 'en_US:en', 13:05:29 INFO - 'LOGNAME': 'cltbld', 13:05:29 INFO - 'MAIL': '/var/mail/cltbld', 13:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:29 INFO - 'MOZ_NO_REMOTE': '1', 13:05:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:29 INFO - 'NO_EM_RESTART': '1', 13:05:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:29 INFO - 'PWD': '/builds/slave/test', 13:05:29 INFO - 'SHELL': '/bin/bash', 13:05:29 INFO - 'SHLVL': '1', 13:05:29 INFO - 'TERM': 'linux', 13:05:29 INFO - 'TMOUT': '86400', 13:05:29 INFO - 'USER': 'cltbld', 13:05:29 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', 13:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:29 INFO - '_': '/tools/buildbot/bin/python'} 13:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:05:29 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 13:05:29 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 13:05:29 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 13:05:29 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 13:05:29 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 13:05:29 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 13:05:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:05:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:05:31 INFO - Installing collected packages: mozsystemmonitor 13:05:31 INFO - Running setup.py install for mozsystemmonitor 13:05:31 INFO - Successfully installed mozsystemmonitor 13:05:31 INFO - Cleaning up... 13:05:32 INFO - Return code: 0 13:05:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:32 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 0x7fa4504c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28352e0>, '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 0x27a1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a15d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', '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 13:05:32 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 13:05:32 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 13:05:32 INFO - Using env: {'DISPLAY': ':0', 13:05:32 INFO - 'HOME': '/home/cltbld', 13:05:32 INFO - 'LANG': 'en_US.UTF-8', 13:05:32 INFO - 'LANGUAGE': 'en_US:en', 13:05:32 INFO - 'LOGNAME': 'cltbld', 13:05:32 INFO - 'MAIL': '/var/mail/cltbld', 13:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:32 INFO - 'MOZ_NO_REMOTE': '1', 13:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:32 INFO - 'NO_EM_RESTART': '1', 13:05:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:32 INFO - 'PWD': '/builds/slave/test', 13:05:32 INFO - 'SHELL': '/bin/bash', 13:05:32 INFO - 'SHLVL': '1', 13:05:32 INFO - 'TERM': 'linux', 13:05:32 INFO - 'TMOUT': '86400', 13:05:32 INFO - 'USER': 'cltbld', 13:05:32 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', 13:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:32 INFO - '_': '/tools/buildbot/bin/python'} 13:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:32 INFO - Downloading/unpacking jsonschema==2.5.1 13:05:32 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 13:05:32 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 13:05:32 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 13:05:32 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 13:05:32 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 13:05:32 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 13:05:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:05:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:05:34 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 13:05:34 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 13:05:34 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 13:05:34 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 13:05:34 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 13:05:34 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 13:05:34 INFO - Downloading functools32-3.2.3-2.tar.gz 13:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:05:34 INFO - warning: no files found matching '*.txt' 13:05:34 INFO - no previously-included directories found matching 'build' 13:05:34 INFO - no previously-included directories found matching 'dist' 13:05:34 INFO - no previously-included directories found matching '.git*' 13:05:34 INFO - Installing collected packages: jsonschema, functools32 13:05:34 INFO - Running setup.py install for functools32 13:05:34 INFO - warning: no files found matching '*.txt' 13:05:34 INFO - no previously-included directories found matching 'build' 13:05:34 INFO - no previously-included directories found matching 'dist' 13:05:34 INFO - no previously-included directories found matching '.git*' 13:05:34 INFO - Successfully installed jsonschema functools32 13:05:34 INFO - Cleaning up... 13:05:34 INFO - Return code: 0 13:05:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:05: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')]} 13:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05: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')]} 13:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:34 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 0x7fa4504c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28352e0>, '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 0x27a1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a15d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', '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 13:05:34 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 13:05:34 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 13:05:34 INFO - Using env: {'DISPLAY': ':0', 13:05:34 INFO - 'HOME': '/home/cltbld', 13:05:34 INFO - 'LANG': 'en_US.UTF-8', 13:05:34 INFO - 'LANGUAGE': 'en_US:en', 13:05:34 INFO - 'LOGNAME': 'cltbld', 13:05:34 INFO - 'MAIL': '/var/mail/cltbld', 13:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:34 INFO - 'MOZ_NO_REMOTE': '1', 13:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:34 INFO - 'NO_EM_RESTART': '1', 13:05:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:34 INFO - 'PWD': '/builds/slave/test', 13:05:34 INFO - 'SHELL': '/bin/bash', 13:05:34 INFO - 'SHLVL': '1', 13:05:34 INFO - 'TERM': 'linux', 13:05:34 INFO - 'TMOUT': '86400', 13:05:34 INFO - 'USER': 'cltbld', 13:05:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', 13:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:34 INFO - '_': '/tools/buildbot/bin/python'} 13:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:34 INFO - Downloading/unpacking blobuploader==1.2.4 13:05:34 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 13:05:34 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 13:05:34 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 13:05:34 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 13:05:34 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 13:05:34 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 13:05:36 INFO - Downloading blobuploader-1.2.4.tar.gz 13:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:05:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:05:37 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 13:05:37 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 13:05:37 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 13:05:37 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 13:05:37 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 13:05:37 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 13:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:05:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:05:37 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 13:05:37 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 13:05:37 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 13:05:37 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 13:05:37 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 13:05:37 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 13:05:37 INFO - Downloading docopt-0.6.1.tar.gz 13:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:05:37 INFO - Installing collected packages: blobuploader, requests, docopt 13:05:37 INFO - Running setup.py install for blobuploader 13:05:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:05:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:05:37 INFO - Running setup.py install for requests 13:05:38 INFO - Running setup.py install for docopt 13:05:38 INFO - Successfully installed blobuploader requests docopt 13:05:38 INFO - Cleaning up... 13:05:38 INFO - Return code: 0 13:05:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:38 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 0x7fa4504c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28352e0>, '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 0x27a1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a15d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', '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 13:05:38 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 13:05:38 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 13:05:38 INFO - Using env: {'DISPLAY': ':0', 13:05:38 INFO - 'HOME': '/home/cltbld', 13:05:38 INFO - 'LANG': 'en_US.UTF-8', 13:05:38 INFO - 'LANGUAGE': 'en_US:en', 13:05:38 INFO - 'LOGNAME': 'cltbld', 13:05:38 INFO - 'MAIL': '/var/mail/cltbld', 13:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:38 INFO - 'MOZ_NO_REMOTE': '1', 13:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:38 INFO - 'NO_EM_RESTART': '1', 13:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:38 INFO - 'PWD': '/builds/slave/test', 13:05:38 INFO - 'SHELL': '/bin/bash', 13:05:38 INFO - 'SHLVL': '1', 13:05:38 INFO - 'TERM': 'linux', 13:05:38 INFO - 'TMOUT': '86400', 13:05:38 INFO - 'USER': 'cltbld', 13:05:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', 13:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:38 INFO - '_': '/tools/buildbot/bin/python'} 13:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:05:38 INFO - Running setup.py (path:/tmp/pip-5_QEpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:05:38 INFO - Running setup.py (path:/tmp/pip-K4pAeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:05:38 INFO - Running setup.py (path:/tmp/pip-oDGjnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:05:38 INFO - Running setup.py (path:/tmp/pip-c2VvvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:05:38 INFO - Running setup.py (path:/tmp/pip-7LNfpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:05:38 INFO - Running setup.py (path:/tmp/pip-5WMFqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:05:39 INFO - Running setup.py (path:/tmp/pip-5L7CPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:05:39 INFO - Running setup.py (path:/tmp/pip-PlA_V7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:05:39 INFO - Running setup.py (path:/tmp/pip-h2SfDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:05:39 INFO - Running setup.py (path:/tmp/pip-11wXFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:05:39 INFO - Running setup.py (path:/tmp/pip-yzTLqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:05:39 INFO - Running setup.py (path:/tmp/pip-7eI59F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:05:39 INFO - Running setup.py (path:/tmp/pip-HNgncn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:05:39 INFO - Running setup.py (path:/tmp/pip-db76_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:05:39 INFO - Running setup.py (path:/tmp/pip-6gQJRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:05:39 INFO - Running setup.py (path:/tmp/pip-TVnj0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:05:39 INFO - Running setup.py (path:/tmp/pip-SmzhDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:05:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:05:39 INFO - Running setup.py install for manifestparser 13:05:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:05:39 INFO - Running setup.py install for mozcrash 13:05:40 INFO - Running setup.py install for mozdebug 13:05:40 INFO - Running setup.py install for mozdevice 13:05:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:05:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:05:40 INFO - Running setup.py install for mozfile 13:05:40 INFO - Running setup.py install for mozhttpd 13:05:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:05:40 INFO - Running setup.py install for mozinfo 13:05:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:05:40 INFO - Running setup.py install for mozInstall 13:05:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:05:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:05:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:05:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:05:40 INFO - Running setup.py install for mozleak 13:05:40 INFO - Running setup.py install for mozlog 13:05:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:05:40 INFO - Running setup.py install for moznetwork 13:05:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:05:40 INFO - Running setup.py install for mozprocess 13:05:41 INFO - Running setup.py install for mozprofile 13:05:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:05:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:05:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:05:41 INFO - Running setup.py install for mozrunner 13:05:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:05:41 INFO - Running setup.py install for mozscreenshot 13:05:41 INFO - Running setup.py install for moztest 13:05:41 INFO - Running setup.py install for mozversion 13:05:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:05:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:05:41 INFO - Cleaning up... 13:05:41 INFO - Return code: 0 13:05:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:05:41 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')]} 13:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:41 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')]} 13:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:41 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 0x7fa4504c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28352e0>, '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 0x27a1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a15d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', '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 13:05:41 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 13:05:41 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 13:05:41 INFO - Using env: {'DISPLAY': ':0', 13:05:41 INFO - 'HOME': '/home/cltbld', 13:05:41 INFO - 'LANG': 'en_US.UTF-8', 13:05:41 INFO - 'LANGUAGE': 'en_US:en', 13:05:41 INFO - 'LOGNAME': 'cltbld', 13:05:41 INFO - 'MAIL': '/var/mail/cltbld', 13:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:41 INFO - 'MOZ_NO_REMOTE': '1', 13:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:41 INFO - 'NO_EM_RESTART': '1', 13:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:41 INFO - 'PWD': '/builds/slave/test', 13:05:41 INFO - 'SHELL': '/bin/bash', 13:05:41 INFO - 'SHLVL': '1', 13:05:41 INFO - 'TERM': 'linux', 13:05:41 INFO - 'TMOUT': '86400', 13:05:41 INFO - 'USER': 'cltbld', 13:05:41 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', 13:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:41 INFO - '_': '/tools/buildbot/bin/python'} 13:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:05:41 INFO - Running setup.py (path:/tmp/pip-UwFdiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:05:41 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)) 13:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:05:41 INFO - Running setup.py (path:/tmp/pip-lH2tE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:05:41 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)) 13:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:05:41 INFO - Running setup.py (path:/tmp/pip-JAP39s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:05:42 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)) 13:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:05:42 INFO - Running setup.py (path:/tmp/pip-lbdao_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:05:42 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)) 13:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:05:42 INFO - Running setup.py (path:/tmp/pip-hrb59S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:05:42 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)) 13:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:05:42 INFO - Running setup.py (path:/tmp/pip-8ElYnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:05:42 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)) 13:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:05:42 INFO - Running setup.py (path:/tmp/pip-uuXBWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:05:42 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)) 13:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:05:42 INFO - Running setup.py (path:/tmp/pip-jEqt3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:05:42 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)) 13:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:05:42 INFO - Running setup.py (path:/tmp/pip-dzMcWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:05:42 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)) 13:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:05:42 INFO - Running setup.py (path:/tmp/pip-JknuUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:05:42 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)) 13:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:05:42 INFO - Running setup.py (path:/tmp/pip-i4sga6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:05:42 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)) 13:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:05:42 INFO - Running setup.py (path:/tmp/pip-nX7aUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:05:42 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)) 13:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:05:42 INFO - Running setup.py (path:/tmp/pip-KEvMWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:05:42 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)) 13:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:05:42 INFO - Running setup.py (path:/tmp/pip-VwURSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:05:42 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)) 13:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:05:42 INFO - Running setup.py (path:/tmp/pip-7H4v_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:05:42 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)) 13:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:05:42 INFO - Running setup.py (path:/tmp/pip-D09O1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:05:43 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)) 13:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:05:43 INFO - Running setup.py (path:/tmp/pip-RVksMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:05:43 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)) 13:05:43 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)) 13:05:43 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)) 13:05:43 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)) 13:05:43 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)) 13:05:43 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)) 13:05:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:05:43 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 13:05:43 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 13:05:43 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 13:05:43 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 13:05:43 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 13:05:43 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 13:05:44 INFO - Downloading blessings-1.6.tar.gz 13:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:05:45 INFO - Installing collected packages: blessings 13:05:45 INFO - Running setup.py install for blessings 13:05:45 INFO - Successfully installed blessings 13:05:45 INFO - Cleaning up... 13:05:45 INFO - Return code: 0 13:05:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:05:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:05:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:05:45 INFO - Reading from file tmpfile_stdout 13:05:45 INFO - Current package versions: 13:05:45 INFO - argparse == 1.2.1 13:05:45 INFO - blessings == 1.6 13:05:45 INFO - blobuploader == 1.2.4 13:05:45 INFO - docopt == 0.6.1 13:05:45 INFO - functools32 == 3.2.3-2 13:05:45 INFO - jsonschema == 2.5.1 13:05:45 INFO - manifestparser == 1.1 13:05:45 INFO - mozInstall == 1.12 13:05:45 INFO - mozcrash == 0.17 13:05:45 INFO - mozdebug == 0.1 13:05:45 INFO - mozdevice == 0.48 13:05:45 INFO - mozfile == 1.2 13:05:45 INFO - mozhttpd == 0.7 13:05:45 INFO - mozinfo == 0.9 13:05:45 INFO - mozleak == 0.1 13:05:45 INFO - mozlog == 3.2 13:05:45 INFO - moznetwork == 0.27 13:05:45 INFO - mozprocess == 0.22 13:05:45 INFO - mozprofile == 0.28 13:05:45 INFO - mozrunner == 6.11 13:05:45 INFO - mozscreenshot == 0.1 13:05:45 INFO - mozsystemmonitor == 0.3 13:05:45 INFO - moztest == 0.7 13:05:45 INFO - mozversion == 1.4 13:05:45 INFO - psutil == 3.1.1 13:05:45 INFO - requests == 1.2.3 13:05:45 INFO - wsgiref == 0.1.2 13:05:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:05:45 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')]} 13:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:45 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')]} 13:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:45 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 0x7fa4504c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28352e0>, '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 0x27a1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a15d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', '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 13:05:45 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 13:05:45 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 13:05:45 INFO - Using env: {'DISPLAY': ':0', 13:05:45 INFO - 'HOME': '/home/cltbld', 13:05:45 INFO - 'LANG': 'en_US.UTF-8', 13:05:45 INFO - 'LANGUAGE': 'en_US:en', 13:05:45 INFO - 'LOGNAME': 'cltbld', 13:05:45 INFO - 'MAIL': '/var/mail/cltbld', 13:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:45 INFO - 'MOZ_NO_REMOTE': '1', 13:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:45 INFO - 'NO_EM_RESTART': '1', 13:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:45 INFO - 'PWD': '/builds/slave/test', 13:05:45 INFO - 'SHELL': '/bin/bash', 13:05:45 INFO - 'SHLVL': '1', 13:05:45 INFO - 'TERM': 'linux', 13:05:45 INFO - 'TMOUT': '86400', 13:05:45 INFO - 'USER': 'cltbld', 13:05:45 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', 13:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:45 INFO - '_': '/tools/buildbot/bin/python'} 13:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:45 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)) 13:05:45 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)) 13:05:45 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)) 13:05:45 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)) 13:05:45 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)) 13:05:45 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)) 13:05:45 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)) 13:05:45 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)) 13:05:45 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)) 13:05:45 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)) 13:05:45 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)) 13:05:45 INFO - Cleaning up... 13:05:45 INFO - Return code: 0 13:05:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:05:45 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')]} 13:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:45 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')]} 13:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:45 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 0x7fa4504c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28352e0>, '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 0x27a1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a15d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', '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 13:05:45 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 13:05:45 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 13:05:45 INFO - Using env: {'DISPLAY': ':0', 13:05:45 INFO - 'HOME': '/home/cltbld', 13:05:45 INFO - 'LANG': 'en_US.UTF-8', 13:05:45 INFO - 'LANGUAGE': 'en_US:en', 13:05:45 INFO - 'LOGNAME': 'cltbld', 13:05:45 INFO - 'MAIL': '/var/mail/cltbld', 13:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:45 INFO - 'MOZ_NO_REMOTE': '1', 13:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:45 INFO - 'NO_EM_RESTART': '1', 13:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:45 INFO - 'PWD': '/builds/slave/test', 13:05:45 INFO - 'SHELL': '/bin/bash', 13:05:45 INFO - 'SHLVL': '1', 13:05:45 INFO - 'TERM': 'linux', 13:05:45 INFO - 'TMOUT': '86400', 13:05:45 INFO - 'USER': 'cltbld', 13:05:45 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', 13:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:45 INFO - '_': '/tools/buildbot/bin/python'} 13:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:05:45 INFO - Cleaning up... 13:05:45 INFO - Return code: 0 13:05:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:05:45 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')]} 13:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:45 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')]} 13:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:45 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 0x7fa4504c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28352e0>, '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 0x27a1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a15d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', '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 13:05:45 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 13:05:45 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 13:05:45 INFO - Using env: {'DISPLAY': ':0', 13:05:45 INFO - 'HOME': '/home/cltbld', 13:05:45 INFO - 'LANG': 'en_US.UTF-8', 13:05:45 INFO - 'LANGUAGE': 'en_US:en', 13:05:45 INFO - 'LOGNAME': 'cltbld', 13:05:45 INFO - 'MAIL': '/var/mail/cltbld', 13:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:45 INFO - 'MOZ_NO_REMOTE': '1', 13:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:45 INFO - 'NO_EM_RESTART': '1', 13:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:45 INFO - 'PWD': '/builds/slave/test', 13:05:45 INFO - 'SHELL': '/bin/bash', 13:05:45 INFO - 'SHLVL': '1', 13:05:45 INFO - 'TERM': 'linux', 13:05:45 INFO - 'TMOUT': '86400', 13:05:45 INFO - 'USER': 'cltbld', 13:05:45 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', 13:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:45 INFO - '_': '/tools/buildbot/bin/python'} 13:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:46 INFO - Downloading/unpacking flake8 13:05:46 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 13:05:46 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 13:05:46 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 13:05:46 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 13:05:46 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 13:05:46 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 13:05:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:05:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:05:47 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 13:05:47 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 13:05:47 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 13:05:47 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 13:05:47 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 13:05:47 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 13:05:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:05:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:05:48 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 13:05:48 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 13:05:48 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 13:05:48 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 13:05:48 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 13:05:48 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 13:05:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:05:48 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 13:05:48 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 13:05:48 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 13:05:48 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 13:05:48 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 13:05:48 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 13:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:05:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:05:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:05:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:05:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:05:48 INFO - no previously-included directories found matching 'docs/_build' 13:05:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:05:48 INFO - Running setup.py install for pep8 13:05:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:05:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:05:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:05:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:05:48 INFO - no previously-included directories found matching 'docs/_build' 13:05:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:05:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:05:48 INFO - Cleaning up... 13:05:48 INFO - Return code: 0 13:05:48 INFO - Running post-action listener: _resource_record_post_action 13:05:48 INFO - Running post-action listener: _start_resource_monitoring 13:05:48 INFO - Starting resource monitoring. 13:05:48 INFO - ##### 13:05:48 INFO - ##### Finished create-virtualenv step (success) 13:05:48 INFO - ##### 13:05:48 INFO - ##### 13:05:48 INFO - ##### Running install step. 13:05:48 INFO - ##### 13:05:48 INFO - Running pre-action listener: _resource_record_pre_action 13:05:48 INFO - Running main action method: install 13:05:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:05:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:05:49 INFO - Reading from file tmpfile_stdout 13:05:49 INFO - Detecting whether we're running mozinstall >=1.0... 13:05:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:05:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:05:49 INFO - Reading from file tmpfile_stdout 13:05:49 INFO - Output received: 13:05:49 INFO - Usage: mozinstall [options] installer 13:05:49 INFO - Options: 13:05:49 INFO - -h, --help show this help message and exit 13:05:49 INFO - -d DEST, --destination=DEST 13:05:49 INFO - Directory to install application into. [default: 13:05:49 INFO - "/builds/slave/test"] 13:05:49 INFO - --app=APP Application being installed. [default: firefox] 13:05:49 INFO - mkdir: /builds/slave/test/build/application 13:05:49 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'] 13:05:49 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 13:06:06 INFO - Reading from file tmpfile_stdout 13:06:06 INFO - Output received: 13:06:06 INFO - /builds/slave/test/build/application/firefox/firefox 13:06:06 INFO - Running post-action listener: _resource_record_post_action 13:06:06 INFO - ##### 13:06:06 INFO - ##### Finished install step (success) 13:06:06 INFO - ##### 13:06:06 INFO - ##### 13:06:06 INFO - ##### Running run-tests step. 13:06:06 INFO - ##### 13:06:06 INFO - Running pre-action listener: _resource_record_pre_action 13:06:06 INFO - Running main action method: run_tests 13:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:06:06 INFO - Python 2.7.3 13:06:06 INFO - Return code: 0 13:06:06 INFO - grabbing minidump binary from tooltool 13:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:06:06 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 0x28352e0>, '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 0x27a1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a15d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:06:06 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 13:06:06 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 13:06:06 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 13:06:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:06:06 INFO - Return code: 0 13:06:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:06:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:06:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:06:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:06:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:06:07 INFO - Return code: 0 13:06:07 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:06:07 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:06:07 INFO - Using env: {'DISPLAY': ':0', 13:06:07 INFO - 'HOME': '/home/cltbld', 13:06:07 INFO - 'LANG': 'en_US.UTF-8', 13:06:07 INFO - 'LANGUAGE': 'en_US:en', 13:06:07 INFO - 'LOGNAME': 'cltbld', 13:06:07 INFO - 'MAIL': '/var/mail/cltbld', 13:06:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:06:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:07 INFO - 'MOZ_NO_REMOTE': '1', 13:06:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:07 INFO - 'NO_EM_RESTART': '1', 13:06:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:07 INFO - 'PWD': '/builds/slave/test', 13:06:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:06:07 INFO - 'SHELL': '/bin/bash', 13:06:07 INFO - 'SHLVL': '1', 13:06:07 INFO - 'TERM': 'linux', 13:06:07 INFO - 'TMOUT': '86400', 13:06:07 INFO - 'USER': 'cltbld', 13:06:07 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356', 13:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:07 INFO - '_': '/tools/buildbot/bin/python'} 13:06:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:06:07 INFO - mozversion application_buildid: 20160620103051 13:06:07 INFO - mozversion application_changeset: c4be443b20d068b1a18b6929c6e2f76fef4de235 13:06:07 INFO - mozversion application_display_name: Nightly 13:06:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:06:07 INFO - mozversion application_name: Firefox 13:06:07 INFO - mozversion application_remotingname: firefox 13:06:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:06:07 INFO - mozversion application_vendor: Mozilla 13:06:07 INFO - mozversion application_version: 50.0a1 13:06:07 INFO - mozversion platform_buildid: 20160620103051 13:06:07 INFO - mozversion platform_changeset: c4be443b20d068b1a18b6929c6e2f76fef4de235 13:06:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:06:07 INFO - mozversion platform_version: 50.0a1 13:06:07 INFO - using testdate: 1466453167 13:06:07 INFO - actual date: 1466453167 13:06:07 INFO - starting webserver on 'localhost:57197' 13:06:07 INFO - SUITE-START | Running 2 tests 13:06:07 INFO - TEST-START | dromaeo_css 13:06:07 INFO - operating with platform_type : linux_ 13:06:07 INFO - Initialising browser for dromaeo_css test... 13:06:07 INFO - TEST-INFO | started process 22904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCzWSff/profile http://localhost:57197/getInfo.html) 13:06:12 INFO - PROCESS | 22904 | __metrics Screen width/height:1600/1200 13:06:12 INFO - PROCESS | 22904 | colorDepth:24 13:06:12 INFO - PROCESS | 22904 | Browser inner width/height: 1024/697 13:06:12 INFO - PROCESS | 22904 | __metrics 13:06:12 ERROR - PROCESS | 22904 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 13:06:13 INFO - TEST-INFO | 22904: exit 0 13:06:13 INFO - Browser initialized. 13:06:13 INFO - Running cycle 1/1 for dromaeo_css test... 13:06:13 INFO - TEST-INFO | started process 23024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCzWSff/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:06:25 INFO - PROCESS | 23024 | RSS: Main: 184852480 13:06:25 INFO - PROCESS | 23024 | 13:07:15 INFO - PROCESS | 23024 | 1466453235399 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] 13:09:22 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:57197/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57197/tests/dromaeo/cssquery-ext.html) 13:09:23 INFO - PROCESS | 23024 | RSS: Main: 188657664 13:09:23 INFO - PROCESS | 23024 | 13:12:25 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:57197/tests/dromaeo/cssquery-ext.html (next: http://localhost:57197/tests/dromaeo/cssquery-jquery.html) 13:12:26 INFO - PROCESS | 23024 | RSS: Main: 188030976 13:12:26 INFO - PROCESS | 23024 | 13:15:28 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:57197/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57197/tests/dromaeo/cssquery-mootools.html) 13:15:28 INFO - PROCESS | 23024 | RSS: Main: 189374464 13:15:28 INFO - PROCESS | 23024 | 13:18:30 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:57197/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57197/tests/dromaeo/cssquery-prototype.html) 13:18:31 INFO - PROCESS | 23024 | RSS: Main: 186802176 13:18:31 INFO - PROCESS | 23024 | 13:21:33 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:57197/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57197/tests/dromaeo/cssquery-yui.html) 13:21:33 INFO - PROCESS | 23024 | RSS: Main: 188698624 13:21:33 INFO - PROCESS | 23024 | 13:24:36 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:57197/tests/dromaeo/cssquery-yui.html (next: http://localhost:57197/tests/dromaeo/cssquery-dojo.html) 13:24:36 INFO - PROCESS | 23024 | RSS: Main: 190005248 13:24:36 INFO - PROCESS | 23024 | 13:24:36 INFO - PROCESS | 23024 | __start_tp_report 13:24:36 INFO - PROCESS | 23024 | _x_x_mozilla_page_load 13:24:36 INFO - PROCESS | 23024 | _x_x_mozilla_page_load_details 13:24:36 INFO - PROCESS | 23024 | |i|pagename|runs| 13:24:36 INFO - PROCESS | 23024 | |0;dojo.html;2807.7192280771924;2889.78326625503;2900.8839646414144;2904.7095290470957;2913.664928533219;4692.483826779056;4755.048990201961;4755.571998520132;4802.303665968432;4840.298156767267;4609.262517997121;4756.8097276109;4810.4708482067035;4850.9029819403595;4860.951390486094;4351.782410879451;4381.671374646914;4460.3309503574565;4493.73037617744;4514.616257618107;4187.68592355573;4485.170243504946;4491.438570178728;4562.156001139783;4588.403507544014;4271.466066741657;4335.349697545362;4373.781310934441;4399.692021558492;4447.777611119431;4340;4393.934090988638;4427.180971520279;4434.5343738907595;4442.444694413199;4335.0679603885;4352.760598167131;4423.358613001097;4459.554044595547;4460.018795864937;4784.30627559002;4805.063012712522;4818.229083346683;4830.879228019293;4851.611871050308;5069.61977851659;5097.362829646294;5103.54068133866;5106.9489305106845;5121;4876.609871210295;5074.873128171788;5074.949250507485;5165.819196328111;5200.401953775288;4849.442314133849;4865.6594038417325;4868.488808675109;4879.682820616684;4910.754462276872;5217.139172036647;5251.422343542207;5261.76322065508;5274.446183150791;5282.603804714662;4801.327814106028;4966.329545511382;5012.7994880205115;5029.949700503022;5095.770690318945;5086.77109530072;5096.719680417538;5096.9490305097215;5110.182370820651;5170.793168273302;4887.584555312838;5021.673591216632;5092.007058623532;5111.846644600668;5126.410462796752;5104.617153713486;5117.360329958755;5126.333576635014;5130.05094057593;5155.252488389163;4045.4134150548007;4057.8376864925663;4075.0627355708352;4078.0824314529586;4101.610347017028;3560.2701446203464;3592.4431713084514;3638.6543278388513;3662.1943172502006;3671.30245253401;4931.926021109686;4938;4959.603231741524;4963.851084467472;4970.3290055842;5094.388673359221;5109.6678715883345;5110.259012443249;5112.3865136183895;5155.948440515547;4750.239961606196;4838.540338667821;4848.466668666444;4898.436679781871;4908.631852611068;4364.781760912006;4397.846075387346;4421.29259318514;4432.556744325541;4472.731636101779;5070.2141168119;5188.325517682677;5259.921101183485;5265.789368425297;5272.525472707474;5029.622778291643;5074.822381216787;5118.027574760784;5137.614678899172;5147.202183661539;5319.2287118368395;5335.599830012842;5354.089804733127;5360.731963401892;5370.4629537045985;4863.124637565272;4994.700317980933;5043.319151914591;5043.344365232496;5048.141815891234;5110.105731496898;5161.483851614808;5180.222966555047;5184.766685499086;5207.401148867929;5022.623303252344;5044.470330615232;5054.69671819692;5070;5107.157319042316;4766.2374020157995;4952.182889823139;4985.451600324034;5019.62352823547;5046.6719663221775;4668.5798278155125;4875.6099512038245;4959.950400496094;4962.206047032458;4993.925091123709;4995.8751031223055;5058.418281897481;5068.974655126701;5072.695638261716;5088.847334579968;4703.74129422885;4891.388576427947;4901.117798796251;4918.213085906238;4941.950580494293 13:24:36 INFO - PROCESS | 23024 | |1;ext.html;584.2930054633892;590.3211306996953;601.6630686815383;621.875624875025;628.7076509423115;40564.78305650828;41571;41812.58187418125;41966.37050444242;44686.32970505445;42077.57922420775;42808.571914280845;42811.78594107025;42840.78579607105;42863.57136428635;8764.956175219131;8873.822523549525;8882.333824963122;8901.599428025755;8934.955325223398;8497.107803680618;8532.8720069199;8627.956860215721;8630.395872288942;8649.264812490914;8838.86741698875;8843.115688431137;8892.688755893545;8909.376343655947;8914.286857051453;8576.528290943996;8615.61229744663;8621.568921553897;8632.223099921037;8633.697820576312;8750.387472876837;8764.1674040966;8784.692535761218;8814.382993190478;8856.424332418372;41840;42164.57835421637;42185.578144218474;42242.36636450456;42261.577384226075;3337.6161741399565;3393.7963722176746;3490.703290220334;3848.2495913296916;3868.2650296443867;31767.20581985446;31825.681743182504;31948.361032779216;32042.19894502656;32557.02328930136;4303;4318.632916202127;4336.349547567858;4456.286994080931;4466.0844526871915;233303;234096;235883;235980;237984.81007595026;33696;34822.825885870916;55936;56564.15153772697;56667;29250.707492925223;29402.264943376587;29453.705462945523;29455.410891782045;29495.705042949296;13322.400491977884;13534.390952407166;13552.728945421037;13601.863981360259;13626.863731362559;11738.237014594024;11926.940365298291;11975.46110425033;11976.700582485333;11984.161108722306;8027.438079334391;8216.548089854996;8253.298469630028;8269;8272.83454330922;3209.8234597097385;3255.9837200813845;3277.9346712318593;3279.6392396836327;3287.9342413151603;918.3800934369274;998.1814911772277;998.3959704378747;1071.089573862211;1099.0487852225672;30334;30608.54087188694;30670.233244168627;31115.222119446742;31149.688503114678;1080.6163811846682;1099.6096385783092;1108.7948729485072;1135.5968631135827;1153.6020073074776;15614.45349412765;15806.945097137299;16299.429519966745;16512.83487165137;16521.173941302888;546832;551268;551498;551983;555906;57207;57307;57632.71183644055;57646.42353576411;57683.42316576865;1282.2755143344168;1311.6196303072193;1322.4379638653727;1328.335832083958;1330.8536061033278;30067.59963826963;30194;30310;30984.69015309818;31013.534796977612;49302.50697492979;49919.75040124921;50556;50585;50805;481380;481722;483836;488223;496920;24448.388790280384;24787.628185577592;24867.62698559487;27539.72460275452;28025.859870700515;46492;47383.76308118437;47639;47721;48556.5144348552;40305.1938961225;40563;40695.796521017204;41024.589754102075;41301.34794608182;39796.80101599474;40262.597374025885;41105.38341924814;41184.38223426591;41229.793851030554;32520;40023.79988100041;41738.79130604328;41809.1638167241;44096.33855492106;29423.705762942096;30949.226269343446;31046.689533105284;31085.378292433572;31569;27940.30149246285;28504.57243141313;28719.55883749821;28785.99249026274;28998.85500572568 13:24:36 INFO - PROCESS | 23024 | |2;jquery.html;378.37001392681185;387.9747816391936;388.94943657324535;399.3570351733709;414.5170875929542;13265.867341326584;17346.306147754076;17451.563710907234;18502.167402466886;18596.256149754012;15316.387344506235;16166.919165404186;17034.14829258538;18338.449846504594;18359.724604130915;5612.915806262909;5657.094864821629;5695.174199741035;5758.654480731169;5824.242848429698;5667.4615911488345;5707.686077265748;5724.084146536555;5735.9388513125205;5777.537796976232;5186.559142472895;5456.045192091388;5483.75323110461;5675.404082571333;5685.976524225638;5517.944820551783;5608.551315894739;5609.0184217761725;5616.943830561703;5657.688827114507;5412.675239485643;5433.565314774848;5447.918281225785;5458.808941687022;5460.26286451328;13532.932335338359;13537.729245415136;13537.796933046013;13549.390277437538;15795.131267780267;2212.3031245157886;2285.371522831218;2348.495073559176;2797;2919.7372236498604;9860.950695246549;10162.780466344013;10380.32527885685;11630.709232269177;14639.707205855822;1803.7023891057959;1874.428299368692;1915.396650055228;1933.1494142577362;1986.9403917882487;82895;82968;85252;85511.57244213739;85765;10109.595616175271;10155.441450720282;10198.745031374276;10219.18246540275;10483;11978.820317695241;12673.30296833683;13863.306834658226;13880.305984700724;13897.444102235999;7464.925350746532;7633.465657404039;7809.101953275333;7835.529868207926;7846.450748447553;7576.962115189499;7702.653380597886;7818.804529886798;7890.408219383455;7895.960520197477;3759.5300587426573;3845.0964023454467;3854.4989151410136;3873.0511024798543;3918.0792513759243;1895.1282410091512;1913.550315675815;1916.8849869007904;1948.4836518322657;1962.254343349518;858.2233079063458;900.2348004196381;942.2085448223526;951.5147274889856;1023.8873723890366;17256.827431725775;18009.18958646864;18623.534411639546;18679;18960.715589266172;930.3627015494408;964.5225613321311;976.6776963601994;994.5474808961905;1034.632705389591;10146.239032072477;10334.896651033543;10415.323004004715;10472.895271047191;10502.369857808557;430563;432271;436603;469942;479886;90256;90819;90980.54509727542;91345.54327228322;92310;1002.6941782756184;1008.4000019988242;1031.200819364983;1047.6385646951942;1050.09167070485;16203.108829014045;16491.17544122765;16625.00249985005;16705.582360441087;16825.66348672995;30059.69940300569;37082.8145859269;37968.24063518769;38799;39652.405213921236;54591.454085460224;55963.44036559582;57426.42573574211;58084.41915580959;58128;8227.506349619041;8301.29438997692;8444.66221351139;8445.071042185478;8448.197421244971;9099.727008189764;12714.745705086032;12752.553660621834;12843.100982931104;12900.612981610566;10935.453227338443;11003.669889903316;11059.447027648746;11077;11228.887711122785;11089.778204436028;11099.778004440028;11115;11282;11315;11047.944760276147;11051.392173430539;11226.943865280622;11438.94280528592;11531.596394126165;8173.836523269382;8194.83610327802;8361.95819020901;8504.702335418231;8560.443571167854;10223.7444063899;10395.896041039492;11033.337999720043;11033.503492343025;11080 13:24:36 INFO - PROCESS | 23024 | |3;mootools.html;1428.7285415771005;1450.753371926773;1461.8026566413535;1519.4226194046262;1528.4192007037332;7381.778546643609;8317.334613230942;8619.482831030142;8868.955655221731;8870.866936995943;8753;8796.560171991407;8845.601947912342;8854.291656667467;8885.111488851111;2338.707661542303;2353.470469144437;2369.727481339642;2377.643353496972;2379.3813608461837;2286.1884031168943;2291.9083236670513;2349.8590084594894;2356.0340260493203;2362.29131260622;2345.155743932183;2374.548835721216;2378.7383387827413;2384.4396566806786;2385.272491889973;2204.9889750551306;2216.1689366487567;2233.9218127365625;2237.65316375962;2292.64464008079;2311.734150572689;2333.265021518216;2335.112657190257;2336.0538981712434;2336.883155842201;8996.325275604357;9024.593893274818;9035.412698174598;9056.230220431271;9091.81816363669;5130.4356520782685;5162.406323272797;5269.86825329366;5281.313429254211;5288.444713305086;3285.0965984354257;3316.5522654441584;3444.328355970587;3481.1645205150835;3504.7196224301993;1101.058594901364;1108.2740804772886;2127.351157896841;2187.5187458759046;2193.5941850757663;12365;12427.130100892851;12559;12586.118971671987;12644.49422023118;4475.977620111944;4479.574440428154;4530.97734511332;4544.613707834871;4556.8177272908715;9384.765380865532;9418.481983490974;9425.90574094264;9456.101670341306;9467.384619999679;5129.410117836496;5132.538071573502;5154.690718556899;5161.303224064778;5166.457521960216;4020.638142567183;4478;4616.60758835496;4622.768861556909;4626;3805.752626079296;3836.271108489378;3860.092878173627;3926.293267211929;3934.5081864766903;1154.9422528873522;1165.6561314412268;1168.071383250301;1174.365842445087;1187.821826725998;778.3306356533377;796.3111908199365;870.7213691618621;938.7418459923575;939.534930209537;5960.314563825129;5960.850978725566;6080.209572755602;6125.540584456184;6256.343083976117;411.6315897271925;411.88055463915725;412.90503184267186;419.06339331593864;425.41080603364566;4045.8179381927885;4287.249731297073;4318.222719910384;4364.236258654722;4395.384646149541;10874.565017399216;11342.886571134348;11387.202895797214;11428;11440.59957901486;11041.83437248442;11259.718507037389;11285.322880627189;11295.887041129483;11333.886661133283;7840.803979900548;7876.960615197002;7891.092524359772;8016.679332826739;8031.879521807177;5863.589548731547;5942.405759424023;5981.611195272293;5999.310079340931;6057.18228039209;9819.06718861707;10079.546420410952;10159.644412445825;10239.641612543524;10291.639792607222;10270.127039201752;10300.381977081399;10502.317349372266;10540.789184216426;10705.678829635124;7685.769426917202;7822;7972.681092756457;7984.520928744294;8184.099749027483;8710.608022639124;8723.52020638871;8741.606627701896;8749.387542871938;8805.251553618014;7407;7494.288042635941;7603.695852165852;7632.771016869503;7907.723229686933;7627.542347458948;7670.041244844395;7733.7679869604;7827.843443130992;7873.37013038944;7164.391026762783;7222.783316500513;7315.48791584584;7317.5609463432365;7320.780376588711;5034.723090229926;5077.31456253401;5190.169572868323;5216.113260745607;5264.131418315935;5047.444781074152;5177.249298851721;5238.3975842777045;5246.606504512253;5352.812651557177 13:24:36 INFO - PROCESS | 23024 | |4;prototype.html;313.8838629707009;316.59475870885274;318.74818893074456;328.15009126362713;334.15125581024193;4857.222844344901;4907.26391041344;4931.914978704684;4938.358013458245;4955.256711493278;4789.353437285965;4848.587870031051;4850.320955066293;4867.3672422585105;4893.804247830082;3697.131174174067;3833.5974722654137;3911.3741801311794;3923.234969181011;3923.9607603924023;3886.300465916134;3911.4549752847606;3911.5306163260448;3926.82329295181;3944.664703500206;3916.3929590913312;3918.1771827916027;3921.901952451183;3943.684505239574;3958.7228893977435;3823.1589050408866;3851.170693920393;3887.455756194135;3926.371780515118;3951.74313669612;3466.8959931202103;3483.6690514401093;3487.232808782064;3494.947575786365;3500.5449291592186;4708.246680531133;4719.787609557578;4739.3601863748645;4766.261229509431;4778.163821331288;4341.6526677865695;4379.233634114017;4390.363397307405;4394.802233899451;4402.669799765031;5054.721990290533;5064.341635587387;5077.578278082143;5083.74581270935;5113.821016264413;3817.4655548223272;3843.8078096095364;3845;3846.903632464734;3847.903802404934;5279.76241069149;5294.729264976417;5329.307190065267;5342.519173274385;5343.091674415358;3713.8885833425043;3857.2092720992127;3863.55569109556;3867.381219005002;3874.5544262410185;3889.6499315061214;3898.7270891037924;3909;3912.139329347539;3914.393269043303;4407.6914615976575;4420.823167073346;4431.512533621299;4433.6009759121835;4438.977805111019;4964.354633897642;5063.265826455144;5063.443021267658;5092.465291144451;5103.515166059218;1328.6744747536916;1348.6021623621054;1348.865113488663;1351.3445978700322;1354.4288625194727;874.8556488179506;904.2901322461836;913.9268858491305;914.2503147419053;922.2022950148207;4765.9523404766205;4935.580475659609;4959.70241785494;4964.975175124101;4968.931679688884;5022.171341728647;5095.719735414587;5187.740612969336;5190.844274671766;5201.7399130044105;4824.469308376076;4830.975845120752;4953.628477864175;4960.330355401975;4975.154223781966;2706.2693072870607;2725.9045933392235;2726.1685186018453;2753.063958254203;2758.3242105683835;5327.573794096463;5337.759800808973;5355.839324820262;5397.703126328011;5413.729313534308;5118.155504341742;5213.210932151281;5226;5239.633225674166;5262.2632831403635;5375.220593014069;5378.058839703036;5379.892402151935;5395.298611180521;5414.700471886719;5179.223116532399;5192.45479224676;5193.76628051731;5198.844034678966;5212.765425555935;4914.901701966012;5107.897842043212;5119.411267704261;5131.589472842238;5151.613628977917;5328.3605967284175;5330.62685612019;5332.360116786011;5353.581300955172;5434.945650543444;3788.5453745550712;3793.165503589206;3795.2788970095594;3813.3517302058162;3815.3513902637173;4940.7776650051555;5172.431032586337;5179.300794392709;5184.844454666366;5230.1631738923115;4927.482614325444;4965.1311020571975;5010.073136469765;5025.7989680412375;5071.137906555969;5035.748212589429;5059.16523773588;5065.670731402594;5080.679023453855;5080.898382032265;4815.494373090775;4852.8301509447;4966;4968.826091086795;5004.824831130893;5056.7724452399;5071.2139618359215;5092.490750924878;5097.8215762448135;5194.194899790538;5063.949360506348;5070.619703522177;5082.440931497458;5083.339165908556;5100.081985242692 13:24:36 INFO - PROCESS | 23024 | |5;yui.html;717.8564287142566;736.819479227589;737.9115804188818;766.2261116272565;799.3343832644933;13328;13351.666208344772;13374.197548147094;13848.238346890917;15215.391384344626;11466.885331146686;14260.928695356535;14526.34631441585;14531.709365812678;14601.123932564054;750.3322043381395;751.2262369759129;752.3868047541264;756.9924300757004;757.3259798779063;751.0686748431932;755.2485277149244;756.0775853458772;756.7843164698062;761.3832795435687;781.5740421470284;784.7410354582973;785.4187900953282;792.3423558446476;793.0760663826635;792.2157064506126;794.6106407860165;796.8804679298123;797.38202892758;799.2287442617902;570.9286339207599;579.3164066401645;580.1384943359109;580.2717589425287;580.3731969472959;14455.20496372699;14507;14509.56471305852;14522.128672279592;14568.708625827425;13978.301084945711;14425.711485770331;14647.267636618126;14666.413343466249;14849.554513364616;10188.847167292497;10289.897101028968;10349.79300413995;10477.47612619366;10528.99974502421;3822.770633761955;3838.865639702625;3900.590438003997;3918.4710064141545;3959;72476.27523724748;73087.26912730858;73886;73955;75085.62457187734;10347.068763811292;10691.70128422393;10930.781384372269;11004.614838480615;11017.173711971474;17643.294268229383;17912.373066942593;18024.729629055575;18035.819641803413;18229.99735014587;7967.601619918981;7983.081945576217;8030.759077227693;8123.79690507742;8160;4483.3723278741;4556.88607784808;4634.582887540138;4662.696924699883;4738.597219236334;3316.469364901604;3404.863805447754;3418.2479854431986;3432.4508078707786;3438.8108654023767;583.5739909865737;597.4115496236204;606.2058703098954;606.4541912278984;608.7777961044276;698.7659134190002;723.3020135569201;749.5053264845176;751.7819832248696;759.6847308366965;9816.65641702537;10083.24375671813;10153;10201.846972295421;10364.948175259075;625.2965413909352;710.9715611375591;715.1132595581441;736.8673638745078;747.7868807389976;5018.573421259161;5088.262201980692;5131.486851314913;5133.851082611799;5215.191645294985;66235.66882165558;66326.33673663298;66927.66536167385;67293;96257.51871240599;99267.50366248268;99595;100276.49861750644;101200;102325;84393.57803211067;87519.56240218885;89608.5519572411;90816.54591726999;91889.5405522968;9133.862992055258;9271.629134834531;9605.47169905634;9648.421094734338;9715.70852874415;46547.76726116483;49239.50760492349;49903.25145122754;49976.250356245415;50399.49600503948;72027.63986180036;73731.26268737244;74994.62502687452;75491;75932.24067759252;11688.88311116912;11795.882041179479;11807.881921181022;11876.406179691154;11929.985951194245;12653.620391388273;12861.099723019674;13209.735805284034;13484;13619.659508512366;11489.080873530265;11964;12014.879851201376;12255.264684118982;12426.068044896489;11266.549338026387;11339;11487.138464615355;12005.519779208735;12380.442880070239;12048.75902481963;12194.634160975185;12234.327112008925;12377.071719621244;12550.309732964775;9513.809723805623;9518.619255229713;10092.192624590161;10156.961269619924;10716.19628527848;10741.24811263204;11073.05879000294;11168.944155279172;11224.270422422516;11346.659600212008 13:24:36 INFO - PROCESS | 23024 | __end_tp_report 13:24:36 INFO - PROCESS | 23024 | __start_cc_report 13:24:36 INFO - PROCESS | 23024 | _x_x_mozilla_cycle_collect,352 13:24:36 INFO - PROCESS | 23024 | __end_cc_report 13:24:36 INFO - PROCESS | 23024 | __startTimestamp1466454276607__endTimestamp 13:24:36 INFO - PROCESS | 23024 | 13:24:36 INFO - PROCESS | 23024 | ------- Summary: start ------- 13:24:36 INFO - PROCESS | 23024 | Number of tests: 6 13:24:36 INFO - PROCESS | 23024 | 13:24:36 INFO - PROCESS | 23024 | [#0] dojo.html Cycles:165 Average:4775.89 Median:4938.00 stddev:503.03 (10.2%) stddev-sans-first:480.30 13:24:36 INFO - PROCESS | 23024 | Values: 2807.7 2889.8 2900.9 2904.7 2913.7 4692.5 4755.0 4755.6 4802.3 4840.3 4609.3 4756.8 4810.5 4850.9 4861.0 4351.8 4381.7 4460.3 4493.7 4514.6 4187.7 4485.2 4491.4 4562.2 4588.4 4271.5 4335.3 4373.8 4399.7 4447.8 4340.0 4393.9 4427.2 4434.5 4442.4 4335.1 4352.8 4423.4 4459.6 4460.0 4784.3 4805.1 4818.2 4830.9 4851.6 5069.6 5097.4 5103.5 5106.9 5121.0 4876.6 5074.9 5074.9 5165.8 5200.4 4849.4 4865.7 4868.5 4879.7 4910.8 5217.1 5251.4 5261.8 5274.4 5282.6 4801.3 4966.3 5012.8 5029.9 5095.8 5086.8 5096.7 5096.9 5110.2 5170.8 4887.6 5021.7 5092.0 5111.8 5126.4 5104.6 5117.4 5126.3 5130.1 5155.3 4045.4 4057.8 4075.1 4078.1 4101.6 3560.3 3592.4 3638.7 3662.2 3671.3 4931.9 4938.0 4959.6 4963.9 4970.3 5094.4 5109.7 5110.3 5112.4 5155.9 4750.2 4838.5 4848.5 4898.4 4908.6 4364.8 4397.8 4421.3 4432.6 4472.7 5070.2 5188.3 5259.9 5265.8 5272.5 5029.6 5074.8 5118.0 5137.6 5147.2 5319.2 5335.6 5354.1 5360.7 5370.5 4863.1 4994.7 5043.3 5043.3 5048.1 5110.1 5161.5 5180.2 5184.8 5207.4 5022.6 5044.5 5054.7 5070.0 5107.2 4766.2 4952.2 4985.5 5019.6 5046.7 4668.6 4875.6 4960.0 4962.2 4993.9 4995.9 5058.4 5069.0 5072.7 5088.8 4703.7 4891.4 4901.1 4918.2 4942.0 13:24:36 INFO - PROCESS | 23024 | 13:24:36 INFO - PROCESS | 23024 | [#1] ext.html Cycles:180 Average:56710.02 Median:41265.57 stddev:119183.90 (288.8%) stddev-sans-first:119443.75 13:24:36 INFO - PROCESS | 23024 | Values: 584.3 590.3 601.7 621.9 628.7 40564.8 41571.0 41812.6 41966.4 44686.3 42077.6 42808.6 42811.8 42840.8 42863.6 8765.0 8873.8 8882.3 8901.6 8935.0 8497.1 8532.9 8628.0 8630.4 8649.3 8838.9 8843.1 8892.7 8909.4 8914.3 8576.5 8615.6 8621.6 8632.2 8633.7 8750.4 8764.2 8784.7 8814.4 8856.4 41840.0 42164.6 42185.6 42242.4 42261.6 3337.6 3393.8 3490.7 3848.2 3868.3 31767.2 31825.7 31948.4 32042.2 32557.0 4303.0 4318.6 4336.3 4456.3 4466.1 233303.0 234096.0 235883.0 235980.0 237984.8 33696.0 34822.8 55936.0 56564.2 56667.0 29250.7 29402.3 29453.7 29455.4 29495.7 13322.4 13534.4 13552.7 13601.9 13626.9 11738.2 11926.9 11975.5 11976.7 11984.2 8027.4 8216.5 8253.3 8269.0 8272.8 3209.8 3256.0 3277.9 3279.6 3287.9 918.4 998.2 998.4 1071.1 1099.0 30334.0 30608.5 30670.2 31115.2 31149.7 1080.6 1099.6 1108.8 1135.6 1153.6 15614.5 15806.9 16299.4 16512.8 16521.2 546832.0 551268.0 551498.0 551983.0 555906.0 57207.0 57307.0 57632.7 57646.4 57683.4 1282.3 1311.6 1322.4 1328.3 1330.9 30067.6 30194.0 30310.0 30984.7 31013.5 49302.5 49919.8 50556.0 50585.0 50805.0 481380.0 481722.0 483836.0 488223.0 496920.0 24448.4 24787.6 24867.6 27539.7 28025.9 46492.0 47383.8 47639.0 47721.0 48556.5 40305.2 40563.0 40695.8 41024.6 41301.3 39796.8 40262.6 41105.4 41184.4 41229.8 32520.0 40023.8 41738.8 41809.2 44096.3 29423.7 30949.2 31046.7 31085.4 31569.0 27940.3 28504.6 28719.6 28786.0 28998.9 13:24:36 INFO - PROCESS | 23024 | 13:24:36 INFO - PROCESS | 23024 | [#2] jquery.html Cycles:180 Average:27144.87 Median:33571.26 stddev:74614.52 (222.3%) stddev-sans-first:74796.77 13:24:36 INFO - PROCESS | 23024 | Values: 378.4 388.0 388.9 399.4 414.5 13265.9 17346.3 17451.6 18502.2 18596.3 15316.4 16166.9 17034.1 18338.4 18359.7 5612.9 5657.1 5695.2 5758.7 5824.2 5667.5 5707.7 5724.1 5735.9 5777.5 5186.6 5456.0 5483.8 5675.4 5686.0 5517.9 5608.6 5609.0 5616.9 5657.7 5412.7 5433.6 5447.9 5458.8 5460.3 13532.9 13537.7 13537.8 13549.4 15795.1 2212.3 2285.4 2348.5 2797.0 2919.7 9861.0 10162.8 10380.3 11630.7 14639.7 1803.7 1874.4 1915.4 1933.1 1986.9 82895.0 82968.0 85252.0 85511.6 85765.0 10109.6 10155.4 10198.7 10219.2 10483.0 11978.8 12673.3 13863.3 13880.3 13897.4 7464.9 7633.5 7809.1 7835.5 7846.5 7577.0 7702.7 7818.8 7890.4 7896.0 3759.5 3845.1 3854.5 3873.1 3918.1 1895.1 1913.6 1916.9 1948.5 1962.3 858.2 900.2 942.2 951.5 1023.9 17256.8 18009.2 18623.5 18679.0 18960.7 930.4 964.5 976.7 994.5 1034.6 10146.2 10334.9 10415.3 10472.9 10502.4 430563.0 432271.0 436603.0 469942.0 479886.0 90256.0 90819.0 90980.5 91345.5 92310.0 1002.7 1008.4 1031.2 1047.6 1050.1 16203.1 16491.2 16625.0 16705.6 16825.7 30059.7 37082.8 37968.2 38799.0 39652.4 54591.5 55963.4 57426.4 58084.4 58128.0 8227.5 8301.3 8444.7 8445.1 8448.2 9099.7 12714.7 12752.6 12843.1 12900.6 10935.5 11003.7 11059.4 11077.0 11228.9 11089.8 11099.8 11115.0 11282.0 11315.0 11047.9 11051.4 11226.9 11438.9 11531.6 8173.8 8194.8 8362.0 8504.7 8560.4 10223.7 10395.9 11033.3 11033.5 11080.0 13:24:36 INFO - PROCESS | 23024 | 13:24:36 INFO - PROCESS | 23024 | [#3] mootools.html Cycles:180 Average:5811.82 Median:4586.71 stddev:3342.14 (72.9%) stddev-sans-first:3335.29 13:24:36 INFO - PROCESS | 23024 | Values: 1428.7 1450.8 1461.8 1519.4 1528.4 7381.8 8317.3 8619.5 8869.0 8870.9 8753.0 8796.6 8845.6 8854.3 8885.1 2338.7 2353.5 2369.7 2377.6 2379.4 2286.2 2291.9 2349.9 2356.0 2362.3 2345.2 2374.5 2378.7 2384.4 2385.3 2205.0 2216.2 2233.9 2237.7 2292.6 2311.7 2333.3 2335.1 2336.1 2336.9 8996.3 9024.6 9035.4 9056.2 9091.8 5130.4 5162.4 5269.9 5281.3 5288.4 3285.1 3316.6 3444.3 3481.2 3504.7 1101.1 1108.3 2127.4 2187.5 2193.6 12365.0 12427.1 12559.0 12586.1 12644.5 4476.0 4479.6 4531.0 4544.6 4556.8 9384.8 9418.5 9425.9 9456.1 9467.4 5129.4 5132.5 5154.7 5161.3 5166.5 4020.6 4478.0 4616.6 4622.8 4626.0 3805.8 3836.3 3860.1 3926.3 3934.5 1154.9 1165.7 1168.1 1174.4 1187.8 778.3 796.3 870.7 938.7 939.5 5960.3 5960.9 6080.2 6125.5 6256.3 411.6 411.9 412.9 419.1 425.4 4045.8 4287.2 4318.2 4364.2 4395.4 10874.6 11342.9 11387.2 11428.0 11440.6 11041.8 11259.7 11285.3 11295.9 11333.9 7840.8 7877.0 7891.1 8016.7 8031.9 5863.6 5942.4 5981.6 5999.3 6057.2 9819.1 10079.5 10159.6 10239.6 10291.6 10270.1 10300.4 10502.3 10540.8 10705.7 7685.8 7822.0 7972.7 7984.5 8184.1 8710.6 8723.5 8741.6 8749.4 8805.3 7407.0 7494.3 7603.7 7632.8 7907.7 7627.5 7670.0 7733.8 7827.8 7873.4 7164.4 7222.8 7315.5 7317.6 7320.8 5034.7 5077.3 5190.2 5216.1 5264.1 5047.4 5177.2 5238.4 5246.6 5352.8 13:24:36 INFO - PROCESS | 23024 | 13:24:36 INFO - PROCESS | 23024 | [#4] prototype.html Cycles:180 Average:4317.34 Median:4936.97 stddev:1232.79 (25.0%) stddev-sans-first:1199.07 13:24:36 INFO - PROCESS | 23024 | Values: 313.9 316.6 318.7 328.2 334.2 4857.2 4907.3 4931.9 4938.4 4955.3 4789.4 4848.6 4850.3 4867.4 4893.8 3697.1 3833.6 3911.4 3923.2 3924.0 3886.3 3911.5 3911.5 3926.8 3944.7 3916.4 3918.2 3921.9 3943.7 3958.7 3823.2 3851.2 3887.5 3926.4 3951.7 3466.9 3483.7 3487.2 3494.9 3500.5 4708.2 4719.8 4739.4 4766.3 4778.2 4341.7 4379.2 4390.4 4394.8 4402.7 5054.7 5064.3 5077.6 5083.7 5113.8 3817.5 3843.8 3845.0 3846.9 3847.9 5279.8 5294.7 5329.3 5342.5 5343.1 3713.9 3857.2 3863.6 3867.4 3874.6 3889.6 3898.7 3909.0 3912.1 3914.4 4407.7 4420.8 4431.5 4433.6 4439.0 4964.4 5063.3 5063.4 5092.5 5103.5 1328.7 1348.6 1348.9 1351.3 1354.4 874.9 904.3 913.9 914.3 922.2 4766.0 4935.6 4959.7 4965.0 4968.9 5022.2 5095.7 5187.7 5190.8 5201.7 4824.5 4831.0 4953.6 4960.3 4975.2 2706.3 2725.9 2726.2 2753.1 2758.3 5327.6 5337.8 5355.8 5397.7 5413.7 5118.2 5213.2 5226.0 5239.6 5262.3 5375.2 5378.1 5379.9 5395.3 5414.7 5179.2 5192.5 5193.8 5198.8 5212.8 4914.9 5107.9 5119.4 5131.6 5151.6 5328.4 5330.6 5332.4 5353.6 5434.9 3788.5 3793.2 3795.3 3813.4 3815.4 4940.8 5172.4 5179.3 5184.8 5230.2 4927.5 4965.1 5010.1 5025.8 5071.1 5035.7 5059.2 5065.7 5080.7 5080.9 4815.5 4852.8 4966.0 4968.8 5004.8 5056.8 5071.2 5092.5 5097.8 5194.2 5063.9 5070.6 5082.4 5083.3 5100.1 13:24:36 INFO - PROCESS | 23024 | 13:24:36 INFO - PROCESS | 23024 | [#5] yui.html Cycles:180 Average:19123.31 Median:26989.05 stddev:27111.25 (100.5%) stddev-sans-first:27152.08 13:24:36 INFO - PROCESS | 23024 | Values: 717.9 736.8 737.9 766.2 799.3 13328.0 13351.7 13374.2 13848.2 15215.4 11466.9 14260.9 14526.3 14531.7 14601.1 750.3 751.2 752.4 757.0 757.3 751.1 755.2 756.1 756.8 761.4 781.6 784.7 785.4 792.3 793.1 792.2 794.6 796.9 797.4 799.2 570.9 579.3 580.1 580.3 580.4 14455.2 14507.0 14509.6 14522.1 14568.7 13978.3 14425.7 14647.3 14666.4 14849.6 10188.8 10289.9 10349.8 10477.5 10529.0 3822.8 3838.9 3900.6 3918.5 3959.0 72476.3 73087.3 73886.0 73955.0 75085.6 10347.1 10691.7 10930.8 11004.6 11017.2 17643.3 17912.4 18024.7 18035.8 18230.0 7967.6 7983.1 8030.8 8123.8 8160.0 4483.4 4556.9 4634.6 4662.7 4738.6 3316.5 3404.9 3418.2 3432.5 3438.8 583.6 597.4 606.2 606.5 608.8 698.8 723.3 749.5 751.8 759.7 9816.7 10083.2 10153.0 10201.8 10364.9 625.3 711.0 715.1 736.9 747.8 5018.6 5088.3 5131.5 5133.9 5215.2 66235.7 66326.3 66927.7 67293.0 96257.5 99267.5 99595.0 100276.5 101200.0 102325.0 84393.6 87519.6 89608.6 90816.5 91889.5 9133.9 9271.6 9605.5 9648.4 9715.7 46547.8 49239.5 49903.3 49976.3 50399.5 72027.6 73731.3 74994.6 75491.0 75932.2 11688.9 11795.9 11807.9 11876.4 11930.0 12653.6 12861.1 13209.7 13484.0 13619.7 11489.1 11964.0 12014.9 12255.3 12426.1 11266.5 11339.0 11487.1 12005.5 12380.4 12048.8 12194.6 12234.3 12377.1 12550.3 9513.8 9518.6 10092.2 10157.0 10716.2 10741.2 11073.1 11168.9 11224.3 11346.7 13:24:36 INFO - PROCESS | 23024 | -------- Summary: end -------- 13:24:36 INFO - PROCESS | 23024 | 13:24:37 INFO - TEST-INFO | 23024: exit 0 13:24:37 INFO - TEST-OK | dromaeo_css | took 1110126ms 13:24:37 INFO - TEST-START | kraken 13:24:37 INFO - operating with platform_type : linux_ 13:24:37 INFO - Initialising browser for kraken test... 13:24:37 INFO - TEST-INFO | started process 23264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeHXRH1/profile http://localhost:57197/getInfo.html) 13:24:42 INFO - PROCESS | 23264 | __metrics Screen width/height:1600/1200 13:24:42 INFO - PROCESS | 23264 | colorDepth:24 13:24:42 INFO - PROCESS | 23264 | Browser inner width/height: 1024/697 13:24:42 INFO - PROCESS | 23264 | __metrics 13:24:42 ERROR - PROCESS | 23264 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 13:24:43 INFO - TEST-INFO | 23264: exit 0 13:24:43 INFO - Browser initialized. 13:24:43 INFO - Running cycle 1/1 for kraken test... 13:24:43 INFO - TEST-INFO | started process 23384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeHXRH1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:24:55 INFO - PROCESS | 23384 | RSS: Main: 185167872 13:24:55 INFO - PROCESS | 23384 | 13:24:58 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:57197/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57197/tests/kraken/driver.html?testName=audio-beat-detection) 13:24:59 INFO - PROCESS | 23384 | RSS: Main: 191606784 13:24:59 INFO - PROCESS | 23384 | 13:25:02 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:57197/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57197/tests/kraken/driver.html?testName=audio-dft) 13:25:02 INFO - PROCESS | 23384 | RSS: Main: 190504960 13:25:02 INFO - PROCESS | 23384 | 13:25:05 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:57197/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57197/tests/kraken/driver.html?testName=audio-fft) 13:25:06 INFO - PROCESS | 23384 | RSS: Main: 185307136 13:25:06 INFO - PROCESS | 23384 | 13:25:08 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:57197/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57197/tests/kraken/driver.html?testName=audio-oscillator) 13:25:08 INFO - PROCESS | 23384 | RSS: Main: 186220544 13:25:08 INFO - PROCESS | 23384 | 13:25:11 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:57197/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57197/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:25:11 INFO - PROCESS | 23384 | RSS: Main: 186400768 13:25:11 INFO - PROCESS | 23384 | 13:25:14 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:57197/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57197/tests/kraken/driver.html?testName=imaging-darkroom) 13:25:15 INFO - PROCESS | 23384 | RSS: Main: 187346944 13:25:15 INFO - PROCESS | 23384 | 13:25:19 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:57197/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57197/tests/kraken/driver.html?testName=imaging-desaturate) 13:25:19 INFO - PROCESS | 23384 | RSS: Main: 184147968 13:25:19 INFO - PROCESS | 23384 | 13:25:22 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:57197/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57197/tests/kraken/driver.html?testName=json-parse-financial) 13:25:23 INFO - PROCESS | 23384 | RSS: Main: 185622528 13:25:23 INFO - PROCESS | 23384 | 13:25:24 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:57197/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57197/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:25:25 INFO - PROCESS | 23384 | RSS: Main: 185929728 13:25:25 INFO - PROCESS | 23384 | 13:25:27 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:57197/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57197/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:25:27 INFO - PROCESS | 23384 | RSS: Main: 186064896 13:25:27 INFO - PROCESS | 23384 | 13:25:30 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:57197/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57197/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:25:30 INFO - PROCESS | 23384 | RSS: Main: 186474496 13:25:30 INFO - PROCESS | 23384 | 13:25:33 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:57197/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57197/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:25:34 INFO - PROCESS | 23384 | RSS: Main: 186429440 13:25:34 INFO - PROCESS | 23384 | 13:25:36 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:57197/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57197/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:25:37 INFO - PROCESS | 23384 | RSS: Main: 186728448 13:25:37 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | Cycle 1(1): loaded http://localhost:57197/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57197/tests/kraken/driver.html?testName=ai-astar) 13:25:39 INFO - PROCESS | 23384 | RSS: Main: 187932672 13:25:39 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | __start_tp_report 13:25:39 INFO - PROCESS | 23384 | _x_x_mozilla_page_load 13:25:39 INFO - PROCESS | 23384 | _x_x_mozilla_page_load_details 13:25:39 INFO - PROCESS | 23384 | |i|pagename|runs| 13:25:39 INFO - PROCESS | 23384 | |0;ai-astar;113;108;113;110;111;112;112;112;111;111 13:25:39 INFO - PROCESS | 23384 | |1;audio-beat-detection;158;127;164;181;128;164;162;141;190;129 13:25:39 INFO - PROCESS | 23384 | |2;audio-dft;162;164;164;165;171;164;163;164;164;163 13:25:39 INFO - PROCESS | 23384 | |3;audio-fft;75;77;75;158;75;75;79;74;187;76 13:25:39 INFO - PROCESS | 23384 | |4;audio-oscillator;86;87;145;87;86;86;142;85;85;149 13:25:39 INFO - PROCESS | 23384 | |5;imaging-gaussian-blur;118;118;118;117;119;118;117;118;118;118 13:25:39 INFO - PROCESS | 23384 | |6;imaging-darkroom;148;148;148;147;147;148;147;149;146;147 13:25:39 INFO - PROCESS | 23384 | |7;imaging-desaturate;96;98;97;96;97;98;97;96;97;97 13:25:39 INFO - PROCESS | 23384 | |8;json-parse-financial;62;62;63;62;64;62;68;61;64;64 13:25:39 INFO - PROCESS | 23384 | |9;json-stringify-tinderbox;60;60;60;63;67;60;59;62;60;60 13:25:39 INFO - PROCESS | 23384 | |10;stanford-crypto-aes;80;83;82;83;87;83;82;82;113;83 13:25:39 INFO - PROCESS | 23384 | |11;stanford-crypto-ccm;125;127;138;124;145;138;137;135;127;133 13:25:39 INFO - PROCESS | 23384 | |12;stanford-crypto-pbkdf2;163;167;169;164;161;163;163;162;164;167 13:25:39 INFO - PROCESS | 23384 | |13;stanford-crypto-sha256-iterative;64;65;64;63;64;64;66;65;63;64 13:25:39 INFO - PROCESS | 23384 | __end_tp_report 13:25:39 INFO - PROCESS | 23384 | __start_cc_report 13:25:39 INFO - PROCESS | 23384 | _x_x_mozilla_cycle_collect,895 13:25:39 INFO - PROCESS | 23384 | __end_cc_report 13:25:39 INFO - PROCESS | 23384 | __startTimestamp1466454339426__endTimestamp 13:25:39 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | ------- Summary: start ------- 13:25:39 INFO - PROCESS | 23384 | Number of tests: 14 13:25:39 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:1.49 (1.3%) stddev-sans-first:1.45 13:25:39 INFO - PROCESS | 23384 | Values: 113.0 108.0 113.0 110.0 111.0 112.0 112.0 112.0 111.0 111.0 13:25:39 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | [#1] audio-beat-detection Cycles:10 Average:154.40 Median:163.00 stddev:22.37 (13.7%) stddev-sans-first:23.69 13:25:39 INFO - PROCESS | 23384 | Values: 158.0 127.0 164.0 181.0 128.0 164.0 162.0 141.0 190.0 129.0 13:25:39 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:2.46 (1.5%) stddev-sans-first:2.45 13:25:39 INFO - PROCESS | 23384 | Values: 162.0 164.0 164.0 165.0 171.0 164.0 163.0 164.0 164.0 163.0 13:25:39 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | [#3] audio-fft Cycles:10 Average:95.10 Median:75.00 stddev:41.39 (55.2%) stddev-sans-first:43.25 13:25:39 INFO - PROCESS | 23384 | Values: 75.0 77.0 75.0 158.0 75.0 75.0 79.0 74.0 187.0 76.0 13:25:39 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:86.00 stddev:28.72 (33.4%) stddev-sans-first:29.73 13:25:39 INFO - PROCESS | 23384 | Values: 86.0 87.0 145.0 87.0 86.0 86.0 142.0 85.0 85.0 149.0 13:25:39 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 13:25:39 INFO - PROCESS | 23384 | Values: 118.0 118.0 118.0 117.0 119.0 118.0 117.0 118.0 118.0 118.0 13:25:39 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 13:25:39 INFO - PROCESS | 23384 | Values: 148.0 148.0 148.0 147.0 147.0 148.0 147.0 149.0 146.0 147.0 13:25:39 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 13:25:39 INFO - PROCESS | 23384 | Values: 96.0 98.0 97.0 96.0 97.0 98.0 97.0 96.0 97.0 97.0 13:25:39 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.50 stddev:1.99 (3.1%) stddev-sans-first:2.06 13:25:39 INFO - PROCESS | 23384 | Values: 62.0 62.0 63.0 62.0 64.0 62.0 68.0 61.0 64.0 64.0 13:25:39 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:60.00 stddev:2.38 (4.0%) stddev-sans-first:2.49 13:25:39 INFO - PROCESS | 23384 | Values: 60.0 60.0 60.0 63.0 67.0 60.0 59.0 62.0 60.0 60.0 13:25:39 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:83.00 stddev:9.72 (11.7%) stddev-sans-first:10.08 13:25:39 INFO - PROCESS | 23384 | Values: 80.0 83.0 82.0 83.0 87.0 83.0 82.0 82.0 113.0 83.0 13:25:39 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:136.00 stddev:6.92 (5.1%) stddev-sans-first:6.72 13:25:39 INFO - PROCESS | 23384 | Values: 125.0 127.0 138.0 124.0 145.0 138.0 137.0 135.0 127.0 133.0 13:25:39 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:164.00 stddev:2.54 (1.5%) stddev-sans-first:2.65 13:25:39 INFO - PROCESS | 23384 | Values: 163.0 167.0 169.0 164.0 161.0 163.0 163.0 162.0 164.0 167.0 13:25:39 INFO - PROCESS | 23384 | 13:25:39 INFO - PROCESS | 23384 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 13:25:39 INFO - PROCESS | 23384 | Values: 64.0 65.0 64.0 63.0 64.0 64.0 66.0 65.0 63.0 64.0 13:25:39 INFO - PROCESS | 23384 | -------- Summary: end -------- 13:25:39 INFO - PROCESS | 23384 | 13:25:40 INFO - TEST-INFO | 23384: exit 0 13:25:40 INFO - TEST-OK | kraken | took 63056ms 13:25:40 INFO - SUITE-END | took 1173s 13:25:40 INFO - Completed test suite (00:19:33) 13:25:40 INFO - javascript benchmark 13:25:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6770.590596963111, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2807.7192280771924, 2889.78326625503, 2900.8839646414144, 2904.7095290470957, 2913.664928533219, 4692.483826779056, 4755.048990201961, 4755.571998520132, 4802.303665968432, 4840.298156767267, 4609.262517997121, 4756.8097276109, 4810.4708482067035, 4850.9029819403595, 4860.951390486094, 4351.782410879451, 4381.671374646914, 4460.3309503574565, 4493.73037617744, 4514.616257618107, 4187.68592355573, 4485.170243504946, 4491.438570178728, 4562.156001139783, 4588.403507544014, 4271.466066741657, 4335.349697545362, 4373.781310934441, 4399.692021558492, 4447.777611119431, 4340.0, 4393.934090988638, 4427.180971520279, 4434.5343738907595, 4442.444694413199, 4335.0679603885, 4352.760598167131, 4423.358613001097, 4459.554044595547, 4460.018795864937, 4784.30627559002, 4805.063012712522, 4818.229083346683, 4830.879228019293, 4851.611871050308, 5069.61977851659, 5097.362829646294, 5103.54068133866, 5106.9489305106845, 5121.0, 4876.609871210295, 5074.873128171788, 5074.949250507485, 5165.819196328111, 5200.401953775288, 4849.442314133849, 4865.6594038417325, 4868.488808675109, 4879.682820616684, 4910.754462276872, 5217.139172036647, 5251.422343542207, 5261.76322065508, 5274.446183150791, 5282.603804714662, 4801.327814106028, 4966.329545511382, 5012.7994880205115, 5029.949700503022, 5095.770690318945, 5086.77109530072, 5096.719680417538, 5096.9490305097215, 5110.182370820651, 5170.793168273302, 4887.584555312838, 5021.673591216632, 5092.007058623532, 5111.846644600668, 5126.410462796752, 5104.617153713486, 5117.360329958755, 5126.333576635014, 5130.05094057593, 5155.252488389163, 4045.4134150548007, 4057.8376864925663, 4075.0627355708352, 4078.0824314529586, 4101.610347017028, 3560.2701446203464, 3592.4431713084514, 3638.6543278388513, 3662.1943172502006, 3671.30245253401, 4931.926021109686, 4938.0, 4959.603231741524, 4963.851084467472, 4970.3290055842, 5094.388673359221, 5109.6678715883345, 5110.259012443249, 5112.3865136183895, 5155.948440515547, 4750.239961606196, 4838.540338667821, 4848.466668666444, 4898.436679781871, 4908.631852611068, 4364.781760912006, 4397.846075387346, 4421.29259318514, 4432.556744325541, 4472.731636101779, 5070.2141168119, 5188.325517682677, 5259.921101183485, 5265.789368425297, 5272.525472707474, 5029.622778291643, 5074.822381216787, 5118.027574760784, 5137.614678899172, 5147.202183661539, 5319.2287118368395, 5335.599830012842, 5354.089804733127, 5360.731963401892, 5370.4629537045985, 4863.124637565272, 4994.700317980933, 5043.319151914591, 5043.344365232496, 5048.141815891234, 5110.105731496898, 5161.483851614808, 5180.222966555047, 5184.766685499086, 5207.401148867929, 5022.623303252344, 5044.470330615232, 5054.69671819692, 5070.0, 5107.157319042316, 4766.2374020157995, 4952.182889823139, 4985.451600324034, 5019.62352823547, 5046.6719663221775, 4668.5798278155125, 4875.6099512038245, 4959.950400496094, 4962.206047032458, 4993.925091123709, 4995.8751031223055, 5058.418281897481, 5068.974655126701, 5072.695638261716, 5088.847334579968, 4703.74129422885, 4891.388576427947, 4901.117798796251, 4918.213085906238, 4941.950580494293], "value": 4744.952295324444, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.2930054633892, 590.3211306996953, 601.6630686815383, 621.875624875025, 628.7076509423115, 40564.78305650828, 41571.0, 41812.58187418125, 41966.37050444242, 44686.32970505445, 42077.57922420775, 42808.571914280845, 42811.78594107025, 42840.78579607105, 42863.57136428635, 8764.956175219131, 8873.822523549525, 8882.333824963122, 8901.599428025755, 8934.955325223398, 8497.107803680618, 8532.8720069199, 8627.956860215721, 8630.395872288942, 8649.264812490914, 8838.86741698875, 8843.115688431137, 8892.688755893545, 8909.376343655947, 8914.286857051453, 8576.528290943996, 8615.61229744663, 8621.568921553897, 8632.223099921037, 8633.697820576312, 8750.387472876837, 8764.1674040966, 8784.692535761218, 8814.382993190478, 8856.424332418372, 41840.0, 42164.57835421637, 42185.578144218474, 42242.36636450456, 42261.577384226075, 3337.6161741399565, 3393.7963722176746, 3490.703290220334, 3848.2495913296916, 3868.2650296443867, 31767.20581985446, 31825.681743182504, 31948.361032779216, 32042.19894502656, 32557.02328930136, 4303.0, 4318.632916202127, 4336.349547567858, 4456.286994080931, 4466.0844526871915, 233303.0, 234096.0, 235883.0, 235980.0, 237984.81007595026, 33696.0, 34822.825885870916, 55936.0, 56564.15153772697, 56667.0, 29250.707492925223, 29402.264943376587, 29453.705462945523, 29455.410891782045, 29495.705042949296, 13322.400491977884, 13534.390952407166, 13552.728945421037, 13601.863981360259, 13626.863731362559, 11738.237014594024, 11926.940365298291, 11975.46110425033, 11976.700582485333, 11984.161108722306, 8027.438079334391, 8216.548089854996, 8253.298469630028, 8269.0, 8272.83454330922, 3209.8234597097385, 3255.9837200813845, 3277.9346712318593, 3279.6392396836327, 3287.9342413151603, 918.3800934369274, 998.1814911772277, 998.3959704378747, 1071.089573862211, 1099.0487852225672, 30334.0, 30608.54087188694, 30670.233244168627, 31115.222119446742, 31149.688503114678, 1080.6163811846682, 1099.6096385783092, 1108.7948729485072, 1135.5968631135827, 1153.6020073074776, 15614.45349412765, 15806.945097137299, 16299.429519966745, 16512.83487165137, 16521.173941302888, 546832.0, 551268.0, 551498.0, 551983.0, 555906.0, 57207.0, 57307.0, 57632.71183644055, 57646.42353576411, 57683.42316576865, 1282.2755143344168, 1311.6196303072193, 1322.4379638653727, 1328.335832083958, 1330.8536061033278, 30067.59963826963, 30194.0, 30310.0, 30984.69015309818, 31013.534796977612, 49302.50697492979, 49919.75040124921, 50556.0, 50585.0, 50805.0, 481380.0, 481722.0, 483836.0, 488223.0, 496920.0, 24448.388790280384, 24787.628185577592, 24867.62698559487, 27539.72460275452, 28025.859870700515, 46492.0, 47383.76308118437, 47639.0, 47721.0, 48556.5144348552, 40305.1938961225, 40563.0, 40695.796521017204, 41024.589754102075, 41301.34794608182, 39796.80101599474, 40262.597374025885, 41105.38341924814, 41184.38223426591, 41229.793851030554, 32520.0, 40023.79988100041, 41738.79130604328, 41809.1638167241, 44096.33855492106, 29423.705762942096, 30949.226269343446, 31046.689533105284, 31085.378292433572, 31569.0, 27940.30149246285, 28504.57243141313, 28719.55883749821, 28785.99249026274, 28998.85500572568], "value": 18161.999621632036, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.37001392681185, 387.9747816391936, 388.94943657324535, 399.3570351733709, 414.5170875929542, 13265.867341326584, 17346.306147754076, 17451.563710907234, 18502.167402466886, 18596.256149754012, 15316.387344506235, 16166.919165404186, 17034.14829258538, 18338.449846504594, 18359.724604130915, 5612.915806262909, 5657.094864821629, 5695.174199741035, 5758.654480731169, 5824.242848429698, 5667.4615911488345, 5707.686077265748, 5724.084146536555, 5735.9388513125205, 5777.537796976232, 5186.559142472895, 5456.045192091388, 5483.75323110461, 5675.404082571333, 5685.976524225638, 5517.944820551783, 5608.551315894739, 5609.0184217761725, 5616.943830561703, 5657.688827114507, 5412.675239485643, 5433.565314774848, 5447.918281225785, 5458.808941687022, 5460.26286451328, 13532.932335338359, 13537.729245415136, 13537.796933046013, 13549.390277437538, 15795.131267780267, 2212.3031245157886, 2285.371522831218, 2348.495073559176, 2797.0, 2919.7372236498604, 9860.950695246549, 10162.780466344013, 10380.32527885685, 11630.709232269177, 14639.707205855822, 1803.7023891057959, 1874.428299368692, 1915.396650055228, 1933.1494142577362, 1986.9403917882487, 82895.0, 82968.0, 85252.0, 85511.57244213739, 85765.0, 10109.595616175271, 10155.441450720282, 10198.745031374276, 10219.18246540275, 10483.0, 11978.820317695241, 12673.30296833683, 13863.306834658226, 13880.305984700724, 13897.444102235999, 7464.925350746532, 7633.465657404039, 7809.101953275333, 7835.529868207926, 7846.450748447553, 7576.962115189499, 7702.653380597886, 7818.804529886798, 7890.408219383455, 7895.960520197477, 3759.5300587426573, 3845.0964023454467, 3854.4989151410136, 3873.0511024798543, 3918.0792513759243, 1895.1282410091512, 1913.550315675815, 1916.8849869007904, 1948.4836518322657, 1962.254343349518, 858.2233079063458, 900.2348004196381, 942.2085448223526, 951.5147274889856, 1023.8873723890366, 17256.827431725775, 18009.18958646864, 18623.534411639546, 18679.0, 18960.715589266172, 930.3627015494408, 964.5225613321311, 976.6776963601994, 994.5474808961905, 1034.632705389591, 10146.239032072477, 10334.896651033543, 10415.323004004715, 10472.895271047191, 10502.369857808557, 430563.0, 432271.0, 436603.0, 469942.0, 479886.0, 90256.0, 90819.0, 90980.54509727542, 91345.54327228322, 92310.0, 1002.6941782756184, 1008.4000019988242, 1031.200819364983, 1047.6385646951942, 1050.09167070485, 16203.108829014045, 16491.17544122765, 16625.00249985005, 16705.582360441087, 16825.66348672995, 30059.69940300569, 37082.8145859269, 37968.24063518769, 38799.0, 39652.405213921236, 54591.454085460224, 55963.44036559582, 57426.42573574211, 58084.41915580959, 58128.0, 8227.506349619041, 8301.29438997692, 8444.66221351139, 8445.071042185478, 8448.197421244971, 9099.727008189764, 12714.745705086032, 12752.553660621834, 12843.100982931104, 12900.612981610566, 10935.453227338443, 11003.669889903316, 11059.447027648746, 11077.0, 11228.887711122785, 11089.778204436028, 11099.778004440028, 11115.0, 11282.0, 11315.0, 11047.944760276147, 11051.392173430539, 11226.943865280622, 11438.94280528592, 11531.596394126165, 8173.836523269382, 8194.83610327802, 8361.95819020901, 8504.702335418231, 8560.443571167854, 10223.7444063899, 10395.896041039492, 11033.337999720043, 11033.503492343025, 11080.0], "value": 8739.201162629068, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.7285415771005, 1450.753371926773, 1461.8026566413535, 1519.4226194046262, 1528.4192007037332, 7381.778546643609, 8317.334613230942, 8619.482831030142, 8868.955655221731, 8870.866936995943, 8753.0, 8796.560171991407, 8845.601947912342, 8854.291656667467, 8885.111488851111, 2338.707661542303, 2353.470469144437, 2369.727481339642, 2377.643353496972, 2379.3813608461837, 2286.1884031168943, 2291.9083236670513, 2349.8590084594894, 2356.0340260493203, 2362.29131260622, 2345.155743932183, 2374.548835721216, 2378.7383387827413, 2384.4396566806786, 2385.272491889973, 2204.9889750551306, 2216.1689366487567, 2233.9218127365625, 2237.65316375962, 2292.64464008079, 2311.734150572689, 2333.265021518216, 2335.112657190257, 2336.0538981712434, 2336.883155842201, 8996.325275604357, 9024.593893274818, 9035.412698174598, 9056.230220431271, 9091.81816363669, 5130.4356520782685, 5162.406323272797, 5269.86825329366, 5281.313429254211, 5288.444713305086, 3285.0965984354257, 3316.5522654441584, 3444.328355970587, 3481.1645205150835, 3504.7196224301993, 1101.058594901364, 1108.2740804772886, 2127.351157896841, 2187.5187458759046, 2193.5941850757663, 12365.0, 12427.130100892851, 12559.0, 12586.118971671987, 12644.49422023118, 4475.977620111944, 4479.574440428154, 4530.97734511332, 4544.613707834871, 4556.8177272908715, 9384.765380865532, 9418.481983490974, 9425.90574094264, 9456.101670341306, 9467.384619999679, 5129.410117836496, 5132.538071573502, 5154.690718556899, 5161.303224064778, 5166.457521960216, 4020.638142567183, 4478.0, 4616.60758835496, 4622.768861556909, 4626.0, 3805.752626079296, 3836.271108489378, 3860.092878173627, 3926.293267211929, 3934.5081864766903, 1154.9422528873522, 1165.6561314412268, 1168.071383250301, 1174.365842445087, 1187.821826725998, 778.3306356533377, 796.3111908199365, 870.7213691618621, 938.7418459923575, 939.534930209537, 5960.314563825129, 5960.850978725566, 6080.209572755602, 6125.540584456184, 6256.343083976117, 411.6315897271925, 411.88055463915725, 412.90503184267186, 419.06339331593864, 425.41080603364566, 4045.8179381927885, 4287.249731297073, 4318.222719910384, 4364.236258654722, 4395.384646149541, 10874.565017399216, 11342.886571134348, 11387.202895797214, 11428.0, 11440.59957901486, 11041.83437248442, 11259.718507037389, 11285.322880627189, 11295.887041129483, 11333.886661133283, 7840.803979900548, 7876.960615197002, 7891.092524359772, 8016.679332826739, 8031.879521807177, 5863.589548731547, 5942.405759424023, 5981.611195272293, 5999.310079340931, 6057.18228039209, 9819.06718861707, 10079.546420410952, 10159.644412445825, 10239.641612543524, 10291.639792607222, 10270.127039201752, 10300.381977081399, 10502.317349372266, 10540.789184216426, 10705.678829635124, 7685.769426917202, 7822.0, 7972.681092756457, 7984.520928744294, 8184.099749027483, 8710.608022639124, 8723.52020638871, 8741.606627701896, 8749.387542871938, 8805.251553618014, 7407.0, 7494.288042635941, 7603.695852165852, 7632.771016869503, 7907.723229686933, 7627.542347458948, 7670.041244844395, 7733.7679869604, 7827.843443130992, 7873.37013038944, 7164.391026762783, 7222.783316500513, 7315.48791584584, 7317.5609463432365, 7320.780376588711, 5034.723090229926, 5077.31456253401, 5190.169572868323, 5216.113260745607, 5264.131418315935, 5047.444781074152, 5177.249298851721, 5238.3975842777045, 5246.606504512253, 5352.812651557177], "value": 4566.979571706997, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.8838629707009, 316.59475870885274, 318.74818893074456, 328.15009126362713, 334.15125581024193, 4857.222844344901, 4907.26391041344, 4931.914978704684, 4938.358013458245, 4955.256711493278, 4789.353437285965, 4848.587870031051, 4850.320955066293, 4867.3672422585105, 4893.804247830082, 3697.131174174067, 3833.5974722654137, 3911.3741801311794, 3923.234969181011, 3923.9607603924023, 3886.300465916134, 3911.4549752847606, 3911.5306163260448, 3926.82329295181, 3944.664703500206, 3916.3929590913312, 3918.1771827916027, 3921.901952451183, 3943.684505239574, 3958.7228893977435, 3823.1589050408866, 3851.170693920393, 3887.455756194135, 3926.371780515118, 3951.74313669612, 3466.8959931202103, 3483.6690514401093, 3487.232808782064, 3494.947575786365, 3500.5449291592186, 4708.246680531133, 4719.787609557578, 4739.3601863748645, 4766.261229509431, 4778.163821331288, 4341.6526677865695, 4379.233634114017, 4390.363397307405, 4394.802233899451, 4402.669799765031, 5054.721990290533, 5064.341635587387, 5077.578278082143, 5083.74581270935, 5113.821016264413, 3817.4655548223272, 3843.8078096095364, 3845.0, 3846.903632464734, 3847.903802404934, 5279.76241069149, 5294.729264976417, 5329.307190065267, 5342.519173274385, 5343.091674415358, 3713.8885833425043, 3857.2092720992127, 3863.55569109556, 3867.381219005002, 3874.5544262410185, 3889.6499315061214, 3898.7270891037924, 3909.0, 3912.139329347539, 3914.393269043303, 4407.6914615976575, 4420.823167073346, 4431.512533621299, 4433.6009759121835, 4438.977805111019, 4964.354633897642, 5063.265826455144, 5063.443021267658, 5092.465291144451, 5103.515166059218, 1328.6744747536916, 1348.6021623621054, 1348.865113488663, 1351.3445978700322, 1354.4288625194727, 874.8556488179506, 904.2901322461836, 913.9268858491305, 914.2503147419053, 922.2022950148207, 4765.9523404766205, 4935.580475659609, 4959.70241785494, 4964.975175124101, 4968.931679688884, 5022.171341728647, 5095.719735414587, 5187.740612969336, 5190.844274671766, 5201.7399130044105, 4824.469308376076, 4830.975845120752, 4953.628477864175, 4960.330355401975, 4975.154223781966, 2706.2693072870607, 2725.9045933392235, 2726.1685186018453, 2753.063958254203, 2758.3242105683835, 5327.573794096463, 5337.759800808973, 5355.839324820262, 5397.703126328011, 5413.729313534308, 5118.155504341742, 5213.210932151281, 5226.0, 5239.633225674166, 5262.2632831403635, 5375.220593014069, 5378.058839703036, 5379.892402151935, 5395.298611180521, 5414.700471886719, 5179.223116532399, 5192.45479224676, 5193.76628051731, 5198.844034678966, 5212.765425555935, 4914.901701966012, 5107.897842043212, 5119.411267704261, 5131.589472842238, 5151.613628977917, 5328.3605967284175, 5330.62685612019, 5332.360116786011, 5353.581300955172, 5434.945650543444, 3788.5453745550712, 3793.165503589206, 3795.2788970095594, 3813.3517302058162, 3815.3513902637173, 4940.7776650051555, 5172.431032586337, 5179.300794392709, 5184.844454666366, 5230.1631738923115, 4927.482614325444, 4965.1311020571975, 5010.073136469765, 5025.7989680412375, 5071.137906555969, 5035.748212589429, 5059.16523773588, 5065.670731402594, 5080.679023453855, 5080.898382032265, 4815.494373090775, 4852.8301509447, 4966.0, 4968.826091086795, 5004.824831130893, 5056.7724452399, 5071.2139618359215, 5092.490750924878, 5097.8215762448135, 5194.194899790538, 5063.949360506348, 5070.619703522177, 5082.440931497458, 5083.339165908556, 5100.081985242692], "value": 3929.958003350827, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.8564287142566, 736.819479227589, 737.9115804188818, 766.2261116272565, 799.3343832644933, 13328.0, 13351.666208344772, 13374.197548147094, 13848.238346890917, 15215.391384344626, 11466.885331146686, 14260.928695356535, 14526.34631441585, 14531.709365812678, 14601.123932564054, 750.3322043381395, 751.2262369759129, 752.3868047541264, 756.9924300757004, 757.3259798779063, 751.0686748431932, 755.2485277149244, 756.0775853458772, 756.7843164698062, 761.3832795435687, 781.5740421470284, 784.7410354582973, 785.4187900953282, 792.3423558446476, 793.0760663826635, 792.2157064506126, 794.6106407860165, 796.8804679298123, 797.38202892758, 799.2287442617902, 570.9286339207599, 579.3164066401645, 580.1384943359109, 580.2717589425287, 580.3731969472959, 14455.20496372699, 14507.0, 14509.56471305852, 14522.128672279592, 14568.708625827425, 13978.301084945711, 14425.711485770331, 14647.267636618126, 14666.413343466249, 14849.554513364616, 10188.847167292497, 10289.897101028968, 10349.79300413995, 10477.47612619366, 10528.99974502421, 3822.770633761955, 3838.865639702625, 3900.590438003997, 3918.4710064141545, 3959.0, 72476.27523724748, 73087.26912730858, 73886.0, 73955.0, 75085.62457187734, 10347.068763811292, 10691.70128422393, 10930.781384372269, 11004.614838480615, 11017.173711971474, 17643.294268229383, 17912.373066942593, 18024.729629055575, 18035.819641803413, 18229.99735014587, 7967.601619918981, 7983.081945576217, 8030.759077227693, 8123.79690507742, 8160.0, 4483.3723278741, 4556.88607784808, 4634.582887540138, 4662.696924699883, 4738.597219236334, 3316.469364901604, 3404.863805447754, 3418.2479854431986, 3432.4508078707786, 3438.8108654023767, 583.5739909865737, 597.4115496236204, 606.2058703098954, 606.4541912278984, 608.7777961044276, 698.7659134190002, 723.3020135569201, 749.5053264845176, 751.7819832248696, 759.6847308366965, 9816.65641702537, 10083.24375671813, 10153.0, 10201.846972295421, 10364.948175259075, 625.2965413909352, 710.9715611375591, 715.1132595581441, 736.8673638745078, 747.7868807389976, 5018.573421259161, 5088.262201980692, 5131.486851314913, 5133.851082611799, 5215.191645294985, 66235.66882165558, 66326.33673663298, 66927.66536167385, 67293.0, 96257.51871240599, 99267.50366248268, 99595.0, 100276.49861750644, 101200.0, 102325.0, 84393.57803211067, 87519.56240218885, 89608.5519572411, 90816.54591726999, 91889.5405522968, 9133.862992055258, 9271.629134834531, 9605.47169905634, 9648.421094734338, 9715.70852874415, 46547.76726116483, 49239.50760492349, 49903.25145122754, 49976.250356245415, 50399.49600503948, 72027.63986180036, 73731.26268737244, 74994.62502687452, 75491.0, 75932.24067759252, 11688.88311116912, 11795.882041179479, 11807.881921181022, 11876.406179691154, 11929.985951194245, 12653.620391388273, 12861.099723019674, 13209.735805284034, 13484.0, 13619.659508512366, 11489.080873530265, 11964.0, 12014.879851201376, 12255.264684118982, 12426.068044896489, 11266.549338026387, 11339.0, 11487.138464615355, 12005.519779208735, 12380.442880070239, 12048.75902481963, 12194.634160975185, 12234.327112008925, 12377.071719621244, 12550.309732964775, 9513.809723805623, 9518.619255229713, 10092.192624590161, 10156.961269619924, 10716.19628527848, 10741.24811263204, 11073.05879000294, 11168.944155279172, 11224.270422422516, 11346.659600212008], "value": 7125.712376253124, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1562.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 113.0, 110.0, 111.0, 112.0, 112.0, 112.0, 111.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 127.0, 164.0, 181.0, 128.0, 164.0, 162.0, 141.0, 190.0, 129.0], "value": 154.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 165.0, 171.0, 164.0, 163.0, 164.0, 164.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 158.0, 75.0, 75.0, 79.0, 74.0, 187.0, 76.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 145.0, 87.0, 86.0, 86.0, 142.0, 85.0, 85.0, 149.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 119.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 149.0, 146.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 97.0, 96.0, 97.0, 98.0, 97.0, 96.0, 97.0, 97.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 64.0, 62.0, 68.0, 61.0, 64.0, 64.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 63.0, 67.0, 60.0, 59.0, 62.0, 60.0, 60.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 82.0, 83.0, 87.0, 83.0, 82.0, 82.0, 113.0, 83.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 127.0, 138.0, 124.0, 145.0, 138.0, 137.0, 135.0, 127.0, 133.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 169.0, 164.0, 161.0, 163.0, 163.0, 162.0, 164.0, 167.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 63.0, 64.0, 64.0, 66.0, 65.0, 63.0, 64.0], "value": 64.2, "unit": "score"}]}]} 13:25:40 INFO - Return code: 0 13:25:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:25:40 ERROR - # TBPL SUCCESS # 13:25:40 INFO - Running post-action listener: _resource_record_post_action 13:25:40 INFO - ##### 13:25:40 INFO - ##### Finished run-tests step (success) 13:25:40 INFO - ##### 13:25:40 INFO - Running post-run listener: _resource_record_post_run 13:25:40 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 296501248; Read time: 0; Write time: 204928 13:25:40 INFO - TinderboxPrint: CPU usage
13.3% 13:25:40 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:25:40 INFO - TinderboxPrint: I/O write bytes / time
296,501,248 / 204,928 13:25:40 INFO - TinderboxPrint: CPU idle
8,230.5 (86.6%) 13:25:40 INFO - TinderboxPrint: CPU user
1,213.8 (12.8%) 13:25:40 INFO - TinderboxPrint: Swap in / out
0 / 0 13:25:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5328896; Read time: 0; Write time: 452 13:25:40 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 287461376; Read time: 0; Write time: 201028 13:25:41 INFO - Running post-run listener: _upload_blobber_files 13:25:41 INFO - Blob upload gear active. 13:25:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:25:41 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 13:25:41 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'] 13:25:41 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 13:25:41 INFO - (blobuploader) - INFO - Open directory for files ... 13:25:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:25:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:25:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:25:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:25:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:25:45 INFO - (blobuploader) - INFO - Done attempting. 13:25:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:25:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:25:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:25:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:25:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:25:45 INFO - (blobuploader) - INFO - Done attempting. 13:25:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:25:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:25:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:25:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:25:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:25:46 INFO - (blobuploader) - INFO - Done attempting. 13:25:46 INFO - (blobuploader) - INFO - Iteration through files over. 13:25:46 INFO - Return code: 0 13:25:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:25:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:25:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/280740c2775288210f7a141c0723ebdbb3511fcd1eab5fe2011cf6093881fa2d8bac47d347dcec758f2de108de66770aa029b015538f575c4593b5c7178fa07c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/abd631236c7c7774162a42d44050a69330115e9c11e1fd9d88d90e3879eaa63ebadbe4c699ef958e22a9ee1447bf06f71bd6d41949a003df996646cbb3e270d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/834762c74e0f5b72cbab5a5b9e5af870d79050f1bc34f464e637f21abf2f1df03a6bbf74ab350de90357dcf5c663b14ba01362006b28d988b7ce3917848db4ce"} 13:25:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:25:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:25:46 INFO - Contents: 13:25:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/280740c2775288210f7a141c0723ebdbb3511fcd1eab5fe2011cf6093881fa2d8bac47d347dcec758f2de108de66770aa029b015538f575c4593b5c7178fa07c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/abd631236c7c7774162a42d44050a69330115e9c11e1fd9d88d90e3879eaa63ebadbe4c699ef958e22a9ee1447bf06f71bd6d41949a003df996646cbb3e270d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/834762c74e0f5b72cbab5a5b9e5af870d79050f1bc34f464e637f21abf2f1df03a6bbf74ab350de90357dcf5c663b14ba01362006b28d988b7ce3917848db4ce"} 13:25:46 INFO - Running post-run listener: copy_logs_to_upload_dir 13:25:46 INFO - Copying logs to upload dir... 13:25:46 INFO - mkdir: /builds/slave/test/build/upload/logs 13:25:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.929415 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-20 13:25:46.652143) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 13:25:46.655777) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/280740c2775288210f7a141c0723ebdbb3511fcd1eab5fe2011cf6093881fa2d8bac47d347dcec758f2de108de66770aa029b015538f575c4593b5c7178fa07c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/abd631236c7c7774162a42d44050a69330115e9c11e1fd9d88d90e3879eaa63ebadbe4c699ef958e22a9ee1447bf06f71bd6d41949a003df996646cbb3e270d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/834762c74e0f5b72cbab5a5b9e5af870d79050f1bc34f464e637f21abf2f1df03a6bbf74ab350de90357dcf5c663b14ba01362006b28d988b7ce3917848db4ce"} build_url:https://queue.taskcluster.net/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/XQ3oa_4uQwyu7NnOWlNN2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/280740c2775288210f7a141c0723ebdbb3511fcd1eab5fe2011cf6093881fa2d8bac47d347dcec758f2de108de66770aa029b015538f575c4593b5c7178fa07c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/abd631236c7c7774162a42d44050a69330115e9c11e1fd9d88d90e3879eaa63ebadbe4c699ef958e22a9ee1447bf06f71bd6d41949a003df996646cbb3e270d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/834762c74e0f5b72cbab5a5b9e5af870d79050f1bc34f464e637f21abf2f1df03a6bbf74ab350de90357dcf5c663b14ba01362006b28d988b7ce3917848db4ce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 13:25:46.683491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 13:25:46.684197) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1466446844.392317-450819356 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 13:25:46.770557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 13:25:46.771340) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 13:25:46.771671) ========= ========= Total master_lag: 0.18 =========