builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1466172560.7 results: success (0) buildid: 20160617043005 builduid: 3ead635ae98c4bff919bdbca8de23207 revision: f97c058ecdeb29f13c3e1e01794cbfebd24ca815 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 07:09:20.702954) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 07:09:20.703407) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 07:09:20.703682) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 07:09:20.721440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 07:09:20.721741) ========= 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=cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 07:09:21-- 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% 23.9M=0s 2016-06-17 07:09:21 (23.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147796 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 07:09:20.882880) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 07:09:20.883191) ========= 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=cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020134 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 07:09:20.936034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 07:09:20.939437) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f97c058ecdeb29f13c3e1e01794cbfebd24ca815 --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 f97c058ecdeb29f13c3e1e01794cbfebd24ca815 --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=cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 07:09:21,690 truncating revision to first 12 chars 2016-06-17 07:09:21,690 Setting DEBUG logging. 2016-06-17 07:09:21,690 attempt 1/10 2016-06-17 07:09:21,690 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f97c058ecdeb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 07:09:21,987 unpacking tar archive at: mozilla-inbound-f97c058ecdeb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622546 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 07:09:21.575056) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 07:09:21.575389) ========= script_repo_revision: f97c058ecdeb29f13c3e1e01794cbfebd24ca815 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 07:09:21.575778) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 07:09:21.576041) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 07:09:21.586290) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-17 07:09:21.586556) ========= /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=cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:09:22 INFO - MultiFileLogger online at 20160617 07:09:22 in /builds/slave/test 07:09:22 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 07:09:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:09:22 INFO - {'append_to_log': False, 07:09:22 INFO - 'base_work_dir': '/builds/slave/test', 07:09:22 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:09:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:09:22 INFO - 'branch': 'Mozilla-Inbound', 07:09:22 INFO - 'buildbot_json_path': 'buildprops.json', 07:09:22 INFO - 'config_files': ('talos/linux_config.py',), 07:09:22 INFO - 'default_actions': ('clobber', 07:09:22 INFO - 'read-buildbot-config', 07:09:22 INFO - 'download-and-extract', 07:09:22 INFO - 'populate-webroot', 07:09:22 INFO - 'create-virtualenv', 07:09:22 INFO - 'install', 07:09:22 INFO - 'run-tests'), 07:09:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:09:22 INFO - 'download_minidump_stackwalk': True, 07:09:22 INFO - 'download_symbols': 'ondemand', 07:09:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:09:22 INFO - 'tooltool.py': '/tools/tooltool.py', 07:09:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:09:22 INFO - '/tools/misc-python/virtualenv.py')}, 07:09:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:09:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:09:22 INFO - 'installer_path': 'installer.exe', 07:09:22 INFO - 'log_level': 'info', 07:09:22 INFO - 'log_name': 'talos', 07:09:22 INFO - 'log_to_console': True, 07:09:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:09:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:09:22 INFO - 'opt_config_files': (), 07:09:22 INFO - 'pip_index': False, 07:09:22 INFO - 'sps_profile': False, 07:09:22 INFO - 'sps_profile_interval': 0, 07:09:22 INFO - 'suite': 'dromaeojs-e10s', 07:09:22 INFO - 'system_bits': '32', 07:09:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:09:22 INFO - 'title': 'talos-linux64-ix-054', 07:09:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:09:22 INFO - 'use_talos_json': True, 07:09:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:09:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:09:22 INFO - 'work_dir': 'build'} 07:09:22 INFO - ##### 07:09:22 INFO - ##### Running clobber step. 07:09:22 INFO - ##### 07:09:22 INFO - Running pre-action listener: _resource_record_pre_action 07:09:22 INFO - Running main action method: clobber 07:09:22 INFO - rmtree: /builds/slave/test/build 07:09:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:09:22 INFO - Running post-action listener: _resource_record_post_action 07:09:22 INFO - ##### 07:09:22 INFO - ##### Finished clobber step (success) 07:09:22 INFO - ##### 07:09:22 INFO - ##### 07:09:22 INFO - ##### Running read-buildbot-config step. 07:09:22 INFO - ##### 07:09:22 INFO - Running pre-action listener: _resource_record_pre_action 07:09:22 INFO - Running main action method: read_buildbot_config 07:09:22 INFO - Using buildbot properties: 07:09:22 INFO - { 07:09:22 INFO - "project": "", 07:09:22 INFO - "product": "firefox", 07:09:22 INFO - "script_repo_revision": "production", 07:09:22 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:09:22 INFO - "repository": "", 07:09:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:09:22 INFO - "buildid": "20160617043005", 07:09:22 INFO - "pgo_build": "True", 07:09:22 INFO - "basedir": "/builds/slave/test", 07:09:22 INFO - "buildnumber": 878, 07:09:22 INFO - "slavename": "talos-linux64-ix-054", 07:09:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:09:22 INFO - "platform": "ubuntu64_hw", 07:09:22 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:09:22 INFO - "branch": "mozilla-inbound", 07:09:22 INFO - "repo_path": "integration/mozilla-inbound", 07:09:22 INFO - "revision": "f97c058ecdeb29f13c3e1e01794cbfebd24ca815", 07:09:22 INFO - "stage_platform": "linux64-pgo", 07:09:22 INFO - "builduid": "3ead635ae98c4bff919bdbca8de23207", 07:09:22 INFO - "slavebuilddir": "test" 07:09:22 INFO - } 07:09:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:09:22 INFO - Running post-action listener: _resource_record_post_action 07:09:22 INFO - ##### 07:09:22 INFO - ##### Finished read-buildbot-config step (success) 07:09:22 INFO - ##### 07:09:22 INFO - ##### 07:09:22 INFO - ##### Running download-and-extract step. 07:09:22 INFO - ##### 07:09:22 INFO - Running pre-action listener: _resource_record_pre_action 07:09:22 INFO - Running main action method: download_and_extract 07:09:22 INFO - mkdir: /builds/slave/test/build/tests 07:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:22 INFO - https://queue.taskcluster.net/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:09:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/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 07:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/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 07:09:23 INFO - Downloaded 1361 bytes. 07:09:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:23 INFO - Using the following test package requirements: 07:09:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:09:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:09:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:09:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:23 INFO - u'jsshell-linux-x86_64.zip'], 07:09:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:09:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:09:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:09:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:09:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:09:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:09:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:09:23 INFO - https://queue.taskcluster.net/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:09:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/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 07:09:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/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 07:09:24 INFO - Downloaded 24220991 bytes. 07:09:24 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'] 07:09:24 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 07:09:25 INFO - Return code: 0 07:09:25 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 07:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:25 INFO - https://queue.taskcluster.net/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:09:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/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 07:09:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/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 07:09:27 INFO - Downloaded 24220991 bytes. 07:09:27 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'] 07:09:27 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 07:09:28 INFO - Return code: 0 07:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:28 INFO - https://queue.taskcluster.net/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:09:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/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 07:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/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 07:09:29 INFO - Downloaded 14405384 bytes. 07:09:29 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'] 07:09:29 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 07:09:29 INFO - Return code: 0 07:09: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')]} 07:09:29 INFO - https://queue.taskcluster.net/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:09:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/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 07:09:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/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 07:09:31 INFO - Downloaded 59436058 bytes. 07:09:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:31 INFO - mkdir: /builds/slave/test/properties 07:09:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:09:31 INFO - Writing to file /builds/slave/test/properties/build_url 07:09:31 INFO - Contents: 07:09:31 INFO - build_url:https://queue.taskcluster.net/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:31 INFO - Running post-action listener: _resource_record_post_action 07:09:31 INFO - Running post-action listener: set_extra_try_arguments 07:09:31 INFO - ##### 07:09:31 INFO - ##### Finished download-and-extract step (success) 07:09:31 INFO - ##### 07:09:31 INFO - ##### 07:09:31 INFO - ##### Running populate-webroot step. 07:09:31 INFO - ##### 07:09:31 INFO - Running pre-action listener: _resource_record_pre_action 07:09:31 INFO - Running main action method: populate_webroot 07:09:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:09:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:09:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:09:31 INFO - '--tppagecycles', 07:09:31 INFO - '7'], 07:09:31 INFO - 'tests': ['tsvgm']}}, 07:09:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:09:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:09:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:09:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:09:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:09:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:09:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:31 INFO - 'talos_options': ['--disable-e10s'], 07:09:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:31 INFO - 'talos_options': ['--disable-e10s'], 07:09:31 INFO - 'tests': ['damp', 'tps']}, 07:09:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:31 INFO - 'tests': ['damp', 'tps']}, 07:09:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:09:31 INFO - 'tests': ['dromaeo_dom']}, 07:09:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:09:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:09:31 INFO - 'tests': ['basic_compositor_video']}, 07:09:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:09:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:09:31 INFO - 'tests': ['a11yr', 07:09:31 INFO - 'ts_paint', 07:09:31 INFO - 'tpaint', 07:09:31 INFO - 'sessionrestore', 07:09:31 INFO - 'sessionrestore_no_auto_restore', 07:09:31 INFO - 'tabpaint']}, 07:09:31 INFO - 'other-e10s': {'tests': ['a11yr', 07:09:31 INFO - 'ts_paint', 07:09:31 INFO - 'tpaint', 07:09:31 INFO - 'sessionrestore', 07:09:31 INFO - 'sessionrestore_no_auto_restore', 07:09:31 INFO - 'tabpaint']}, 07:09:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:09:31 INFO - 'ts_paint', 07:09:31 INFO - 'tpaint', 07:09:31 INFO - 'sessionrestore', 07:09:31 INFO - 'sessionrestore_no_auto_restore', 07:09:31 INFO - 'tabpaint']}, 07:09:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:09:31 INFO - 'ts_paint', 07:09:31 INFO - 'tpaint', 07:09:31 INFO - 'sessionrestore', 07:09:31 INFO - 'sessionrestore_no_auto_restore', 07:09:31 INFO - 'tabpaint']}, 07:09:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:09:31 INFO - 'tests': ['a11yr', 07:09:31 INFO - 'ts_paint', 07:09:31 INFO - 'tpaint', 07:09:31 INFO - 'sessionrestore', 07:09:31 INFO - 'sessionrestore_no_auto_restore', 07:09:31 INFO - 'tabpaint']}, 07:09:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:09:31 INFO - 'tests': ['a11yr', 07:09:31 INFO - 'ts_paint', 07:09:31 INFO - 'tpaint', 07:09:31 INFO - 'sessionrestore', 07:09:31 INFO - 'sessionrestore_no_auto_restore', 07:09:31 INFO - 'tabpaint']}, 07:09:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:09:31 INFO - 'tests': ['tsvgx', 07:09:31 INFO - 'tsvgr_opacity', 07:09:31 INFO - 'tart', 07:09:31 INFO - 'tscrollx', 07:09:31 INFO - 'cart']}, 07:09:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:09:31 INFO - 'tsvgr_opacity', 07:09:31 INFO - 'tart', 07:09:31 INFO - 'tscrollx', 07:09:31 INFO - 'cart']}, 07:09:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:31 INFO - 'talos_options': ['--disable-e10s'], 07:09:31 INFO - 'tests': ['tp5o']}, 07:09:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:31 INFO - 'tests': ['tp5o']}, 07:09:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:31 INFO - 'talos_options': ['--disable-e10s', 07:09:31 INFO - '--xperf_path', 07:09:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:31 INFO - 'tests': ['tp5n']}, 07:09:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:31 INFO - 'talos_options': ['--xperf_path', 07:09:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:31 INFO - 'tests': ['tp5n']}}, 07:09:31 INFO - 'talos.zip': {'path': '', 07:09:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:09:31 INFO - Running post-action listener: _resource_record_post_action 07:09:31 INFO - ##### 07:09:31 INFO - ##### Finished populate-webroot step (success) 07:09:31 INFO - ##### 07:09:31 INFO - ##### 07:09:31 INFO - ##### Running create-virtualenv step. 07:09:31 INFO - ##### 07:09:31 INFO - Running pre-action listener: _resource_record_pre_action 07:09:31 INFO - Running main action method: create_virtualenv 07:09:31 INFO - Creating virtualenv /builds/slave/test/build/venv 07:09:31 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 07:09:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:09:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:09:31 INFO - Using real prefix '/usr' 07:09:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:09:32 INFO - Installing distribute.............................................................................................................................................................................................done. 07:09:34 INFO - Installing pip.................done. 07:09:34 INFO - Return code: 0 07:09:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3c5fc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', '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 07:09: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', 'pip>=1.5'] in /builds/slave/test/build 07:09: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 pip>=1.5 07:09:34 INFO - Using env: {'DISPLAY': ':0', 07:09:34 INFO - 'HOME': '/home/cltbld', 07:09:34 INFO - 'LANG': 'en_US.UTF-8', 07:09:34 INFO - 'LANGUAGE': 'en_US:en', 07:09:34 INFO - 'LOGNAME': 'cltbld', 07:09:34 INFO - 'MAIL': '/var/mail/cltbld', 07:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:34 INFO - 'MOZ_NO_REMOTE': '1', 07:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:34 INFO - 'NO_EM_RESTART': '1', 07:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:34 INFO - 'PWD': '/builds/slave/test', 07:09:34 INFO - 'SHELL': '/bin/bash', 07:09:34 INFO - 'SHLVL': '1', 07:09:34 INFO - 'TERM': 'linux', 07:09:34 INFO - 'TMOUT': '86400', 07:09:34 INFO - 'USER': 'cltbld', 07:09:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', 07:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:34 INFO - '_': '/tools/buildbot/bin/python'} 07:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:34 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 07:09:34 INFO - Cleaning up... 07:09:34 INFO - Return code: 0 07:09:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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', '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 0x7fb3c5fc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', '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 07:09: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:09: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 psutil>=3.1.1 07:09:34 INFO - Using env: {'DISPLAY': ':0', 07:09:34 INFO - 'HOME': '/home/cltbld', 07:09:34 INFO - 'LANG': 'en_US.UTF-8', 07:09:34 INFO - 'LANGUAGE': 'en_US:en', 07:09:34 INFO - 'LOGNAME': 'cltbld', 07:09:34 INFO - 'MAIL': '/var/mail/cltbld', 07:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:34 INFO - 'MOZ_NO_REMOTE': '1', 07:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:34 INFO - 'NO_EM_RESTART': '1', 07:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:34 INFO - 'PWD': '/builds/slave/test', 07:09:34 INFO - 'SHELL': '/bin/bash', 07:09:34 INFO - 'SHLVL': '1', 07:09:34 INFO - 'TERM': 'linux', 07:09:34 INFO - 'TMOUT': '86400', 07:09:34 INFO - 'USER': 'cltbld', 07:09:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', 07:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:34 INFO - '_': '/tools/buildbot/bin/python'} 07:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:34 INFO - Downloading/unpacking psutil>=3.1.1 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:09:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:36 INFO - Installing collected packages: psutil 07:09:36 INFO - Running setup.py install for psutil 07:09:36 INFO - building 'psutil._psutil_linux' extension 07:09:36 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 07:09:37 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 07:09:37 INFO - building 'psutil._psutil_posix' extension 07:09:37 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 07:09:37 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 07:09:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:37 INFO - Successfully installed psutil 07:09:37 INFO - Cleaning up... 07:09:37 INFO - Return code: 0 07:09:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:09:37 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')]} 07:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:37 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')]} 07:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:37 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 0x7fb3c5fc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', '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 07:09:37 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 07:09:37 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 07:09:37 INFO - Using env: {'DISPLAY': ':0', 07:09:37 INFO - 'HOME': '/home/cltbld', 07:09:37 INFO - 'LANG': 'en_US.UTF-8', 07:09:37 INFO - 'LANGUAGE': 'en_US:en', 07:09:37 INFO - 'LOGNAME': 'cltbld', 07:09:37 INFO - 'MAIL': '/var/mail/cltbld', 07:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:37 INFO - 'MOZ_NO_REMOTE': '1', 07:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:37 INFO - 'NO_EM_RESTART': '1', 07:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:37 INFO - 'PWD': '/builds/slave/test', 07:09:37 INFO - 'SHELL': '/bin/bash', 07:09:37 INFO - 'SHLVL': '1', 07:09:37 INFO - 'TERM': 'linux', 07:09:37 INFO - 'TMOUT': '86400', 07:09:37 INFO - 'USER': 'cltbld', 07:09:37 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', 07:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:37 INFO - '_': '/tools/buildbot/bin/python'} 07:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:09:39 INFO - Installing collected packages: mozsystemmonitor 07:09:39 INFO - Running setup.py install for mozsystemmonitor 07:09:39 INFO - Successfully installed mozsystemmonitor 07:09:39 INFO - Cleaning up... 07:09:39 INFO - Return code: 0 07:09:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb3c5fc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', '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 07:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:09:39 INFO - Using env: {'DISPLAY': ':0', 07:09:39 INFO - 'HOME': '/home/cltbld', 07:09:39 INFO - 'LANG': 'en_US.UTF-8', 07:09:39 INFO - 'LANGUAGE': 'en_US:en', 07:09:39 INFO - 'LOGNAME': 'cltbld', 07:09:39 INFO - 'MAIL': '/var/mail/cltbld', 07:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:39 INFO - 'MOZ_NO_REMOTE': '1', 07:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:39 INFO - 'NO_EM_RESTART': '1', 07:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:39 INFO - 'PWD': '/builds/slave/test', 07:09:39 INFO - 'SHELL': '/bin/bash', 07:09:39 INFO - 'SHLVL': '1', 07:09:39 INFO - 'TERM': 'linux', 07:09:39 INFO - 'TMOUT': '86400', 07:09:39 INFO - 'USER': 'cltbld', 07:09:39 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', 07:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:39 INFO - '_': '/tools/buildbot/bin/python'} 07:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:39 INFO - Downloading/unpacking jsonschema==2.5.1 07:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:09:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:42 INFO - Downloading functools32-3.2.3-2.tar.gz 07:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:09:42 INFO - warning: no files found matching '*.txt' 07:09:42 INFO - no previously-included directories found matching 'build' 07:09:42 INFO - no previously-included directories found matching 'dist' 07:09:42 INFO - no previously-included directories found matching '.git*' 07:09:42 INFO - Installing collected packages: jsonschema, functools32 07:09:42 INFO - Running setup.py install for functools32 07:09:42 INFO - warning: no files found matching '*.txt' 07:09:42 INFO - no previously-included directories found matching 'build' 07:09:42 INFO - no previously-included directories found matching 'dist' 07:09:42 INFO - no previously-included directories found matching '.git*' 07:09:42 INFO - Successfully installed jsonschema functools32 07:09:42 INFO - Cleaning up... 07:09:42 INFO - Return code: 0 07:09:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:09:42 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')]} 07:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:42 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')]} 07:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:42 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 0x7fb3c5fc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', '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 07:09:42 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 07:09:42 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 07:09:42 INFO - Using env: {'DISPLAY': ':0', 07:09:42 INFO - 'HOME': '/home/cltbld', 07:09:42 INFO - 'LANG': 'en_US.UTF-8', 07:09:42 INFO - 'LANGUAGE': 'en_US:en', 07:09:42 INFO - 'LOGNAME': 'cltbld', 07:09:42 INFO - 'MAIL': '/var/mail/cltbld', 07:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:42 INFO - 'MOZ_NO_REMOTE': '1', 07:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:42 INFO - 'NO_EM_RESTART': '1', 07:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:42 INFO - 'PWD': '/builds/slave/test', 07:09:42 INFO - 'SHELL': '/bin/bash', 07:09:42 INFO - 'SHLVL': '1', 07:09:42 INFO - 'TERM': 'linux', 07:09:42 INFO - 'TMOUT': '86400', 07:09:42 INFO - 'USER': 'cltbld', 07:09:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', 07:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:42 INFO - '_': '/tools/buildbot/bin/python'} 07:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:42 INFO - Downloading/unpacking blobuploader==1.2.4 07:09:42 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 07:09:42 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 07:09:42 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 07:09:42 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 07:09:42 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 07:09:42 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 07:09:44 INFO - Downloading blobuploader-1.2.4.tar.gz 07:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:09:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:09:44 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 07:09:44 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 07:09:44 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 07:09:44 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 07:09:44 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 07:09:44 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 07:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:09:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:09:44 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 07:09:44 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 07:09:44 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 07:09:44 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 07:09:44 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 07:09:44 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 07:09:45 INFO - Downloading docopt-0.6.1.tar.gz 07:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:09:45 INFO - Installing collected packages: blobuploader, requests, docopt 07:09:45 INFO - Running setup.py install for blobuploader 07:09:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:09:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:09:45 INFO - Running setup.py install for requests 07:09:45 INFO - Running setup.py install for docopt 07:09:45 INFO - Successfully installed blobuploader requests docopt 07:09:45 INFO - Cleaning up... 07:09:45 INFO - Return code: 0 07:09:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:45 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 0x7fb3c5fc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', '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 07:09:45 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 07:09:45 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 07:09:45 INFO - Using env: {'DISPLAY': ':0', 07:09:45 INFO - 'HOME': '/home/cltbld', 07:09:45 INFO - 'LANG': 'en_US.UTF-8', 07:09:45 INFO - 'LANGUAGE': 'en_US:en', 07:09:45 INFO - 'LOGNAME': 'cltbld', 07:09:45 INFO - 'MAIL': '/var/mail/cltbld', 07:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:45 INFO - 'MOZ_NO_REMOTE': '1', 07:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:45 INFO - 'NO_EM_RESTART': '1', 07:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:45 INFO - 'PWD': '/builds/slave/test', 07:09:45 INFO - 'SHELL': '/bin/bash', 07:09:45 INFO - 'SHLVL': '1', 07:09:45 INFO - 'TERM': 'linux', 07:09:45 INFO - 'TMOUT': '86400', 07:09:45 INFO - 'USER': 'cltbld', 07:09:45 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', 07:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:45 INFO - '_': '/tools/buildbot/bin/python'} 07:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:45 INFO - Running setup.py (path:/tmp/pip-vDlZ8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:46 INFO - Running setup.py (path:/tmp/pip-rsG4dL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:46 INFO - Running setup.py (path:/tmp/pip-3RNoBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:46 INFO - Running setup.py (path:/tmp/pip-GwHsaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:46 INFO - Running setup.py (path:/tmp/pip-DvX46z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:46 INFO - Running setup.py (path:/tmp/pip-xcUvH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:46 INFO - Running setup.py (path:/tmp/pip-QgFhFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:46 INFO - Running setup.py (path:/tmp/pip-I1XY82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:46 INFO - Running setup.py (path:/tmp/pip-DyBuxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:46 INFO - Running setup.py (path:/tmp/pip-Sy8XuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:46 INFO - Running setup.py (path:/tmp/pip-Upk_hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:46 INFO - Running setup.py (path:/tmp/pip-By9VvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:46 INFO - Running setup.py (path:/tmp/pip-IY0O7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:46 INFO - Running setup.py (path:/tmp/pip-xiyMhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:46 INFO - Running setup.py (path:/tmp/pip-5G4j1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:47 INFO - Running setup.py (path:/tmp/pip-h5HD2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:47 INFO - Running setup.py (path:/tmp/pip-wz4e9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:09:47 INFO - Running setup.py install for manifestparser 07:09:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:09:47 INFO - Running setup.py install for mozcrash 07:09:47 INFO - Running setup.py install for mozdebug 07:09:47 INFO - Running setup.py install for mozdevice 07:09:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:09:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:09:47 INFO - Running setup.py install for mozfile 07:09:47 INFO - Running setup.py install for mozhttpd 07:09:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:09:47 INFO - Running setup.py install for mozinfo 07:09:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:09:47 INFO - Running setup.py install for mozInstall 07:09:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:09:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:09:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:09:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:09:48 INFO - Running setup.py install for mozleak 07:09:48 INFO - Running setup.py install for mozlog 07:09:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:09:48 INFO - Running setup.py install for moznetwork 07:09:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:09:48 INFO - Running setup.py install for mozprocess 07:09:48 INFO - Running setup.py install for mozprofile 07:09:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:09:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:09:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:09:48 INFO - Running setup.py install for mozrunner 07:09:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:09:48 INFO - Running setup.py install for mozscreenshot 07:09:48 INFO - Running setup.py install for moztest 07:09:48 INFO - Running setup.py install for mozversion 07:09:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:09:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:09:48 INFO - Cleaning up... 07:09:48 INFO - Return code: 0 07:09:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:49 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')]} 07:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:49 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 0x7fb3c5fc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', '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 07:09:49 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 07:09:49 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 07:09:49 INFO - Using env: {'DISPLAY': ':0', 07:09:49 INFO - 'HOME': '/home/cltbld', 07:09:49 INFO - 'LANG': 'en_US.UTF-8', 07:09:49 INFO - 'LANGUAGE': 'en_US:en', 07:09:49 INFO - 'LOGNAME': 'cltbld', 07:09:49 INFO - 'MAIL': '/var/mail/cltbld', 07:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:49 INFO - 'MOZ_NO_REMOTE': '1', 07:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:49 INFO - 'NO_EM_RESTART': '1', 07:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:49 INFO - 'PWD': '/builds/slave/test', 07:09:49 INFO - 'SHELL': '/bin/bash', 07:09:49 INFO - 'SHLVL': '1', 07:09:49 INFO - 'TERM': 'linux', 07:09:49 INFO - 'TMOUT': '86400', 07:09:49 INFO - 'USER': 'cltbld', 07:09:49 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', 07:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:49 INFO - '_': '/tools/buildbot/bin/python'} 07:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:49 INFO - Running setup.py (path:/tmp/pip-Fa0Fiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:49 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)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:49 INFO - Running setup.py (path:/tmp/pip-3xkJr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:49 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)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:49 INFO - Running setup.py (path:/tmp/pip-N2x3Pf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:49 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)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:49 INFO - Running setup.py (path:/tmp/pip-OGtE8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:49 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)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:49 INFO - Running setup.py (path:/tmp/pip-mm_eWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:49 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)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:49 INFO - Running setup.py (path:/tmp/pip-7QPJ53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:49 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)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:49 INFO - Running setup.py (path:/tmp/pip-5ShYjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:49 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)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:49 INFO - Running setup.py (path:/tmp/pip-1vJQ0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:49 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)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:49 INFO - Running setup.py (path:/tmp/pip-MkjTGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:49 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)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:49 INFO - Running setup.py (path:/tmp/pip-bP0SV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:49 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)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:49 INFO - Running setup.py (path:/tmp/pip-sjEQTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:50 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)) 07:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:50 INFO - Running setup.py (path:/tmp/pip-7sXfxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:50 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)) 07:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:50 INFO - Running setup.py (path:/tmp/pip-EmLdXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:50 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)) 07:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:50 INFO - Running setup.py (path:/tmp/pip-LsmECO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:50 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)) 07:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:50 INFO - Running setup.py (path:/tmp/pip-EUxfMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:50 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)) 07:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:50 INFO - Running setup.py (path:/tmp/pip-gipjwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:50 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)) 07:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:50 INFO - Running setup.py (path:/tmp/pip-pb2K0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:50 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)) 07:09:50 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)) 07:09:50 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)) 07:09:50 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)) 07:09:50 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)) 07:09:50 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)) 07:09:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:09:50 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 07:09:50 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 07:09:50 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 07:09:50 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 07:09:50 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 07:09:50 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 07:09:52 INFO - Downloading blessings-1.6.tar.gz 07:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:09:52 INFO - Installing collected packages: blessings 07:09:52 INFO - Running setup.py install for blessings 07:09:52 INFO - Successfully installed blessings 07:09:52 INFO - Cleaning up... 07:09:52 INFO - Return code: 0 07:09:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:09:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:52 INFO - Reading from file tmpfile_stdout 07:09:52 INFO - Current package versions: 07:09:52 INFO - argparse == 1.2.1 07:09:52 INFO - blessings == 1.6 07:09:52 INFO - blobuploader == 1.2.4 07:09:52 INFO - docopt == 0.6.1 07:09:52 INFO - functools32 == 3.2.3-2 07:09:52 INFO - jsonschema == 2.5.1 07:09:52 INFO - manifestparser == 1.1 07:09:52 INFO - mozInstall == 1.12 07:09:52 INFO - mozcrash == 0.17 07:09:52 INFO - mozdebug == 0.1 07:09:52 INFO - mozdevice == 0.48 07:09:52 INFO - mozfile == 1.2 07:09:52 INFO - mozhttpd == 0.7 07:09:52 INFO - mozinfo == 0.9 07:09:52 INFO - mozleak == 0.1 07:09:52 INFO - mozlog == 3.2 07:09:52 INFO - moznetwork == 0.27 07:09:52 INFO - mozprocess == 0.22 07:09:52 INFO - mozprofile == 0.28 07:09:52 INFO - mozrunner == 6.11 07:09:52 INFO - mozscreenshot == 0.1 07:09:52 INFO - mozsystemmonitor == 0.3 07:09:52 INFO - moztest == 0.7 07:09:52 INFO - mozversion == 1.4 07:09:52 INFO - psutil == 3.1.1 07:09:52 INFO - requests == 1.2.3 07:09:52 INFO - wsgiref == 0.1.2 07:09:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:52 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 0x7fb3c5fc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', '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 07:09:52 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 07:09:52 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 07:09:52 INFO - Using env: {'DISPLAY': ':0', 07:09:52 INFO - 'HOME': '/home/cltbld', 07:09:52 INFO - 'LANG': 'en_US.UTF-8', 07:09:52 INFO - 'LANGUAGE': 'en_US:en', 07:09:52 INFO - 'LOGNAME': 'cltbld', 07:09:52 INFO - 'MAIL': '/var/mail/cltbld', 07:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:52 INFO - 'MOZ_NO_REMOTE': '1', 07:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:52 INFO - 'NO_EM_RESTART': '1', 07:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:52 INFO - 'PWD': '/builds/slave/test', 07:09:52 INFO - 'SHELL': '/bin/bash', 07:09:52 INFO - 'SHLVL': '1', 07:09:52 INFO - 'TERM': 'linux', 07:09:52 INFO - 'TMOUT': '86400', 07:09:52 INFO - 'USER': 'cltbld', 07:09:52 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', 07:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:52 INFO - '_': '/tools/buildbot/bin/python'} 07:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:53 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)) 07:09:53 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)) 07:09:53 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)) 07:09:53 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)) 07:09:53 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)) 07:09:53 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)) 07:09:53 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)) 07:09:53 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)) 07:09:53 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)) 07:09:53 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)) 07:09:53 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)) 07:09:53 INFO - Cleaning up... 07:09:53 INFO - Return code: 0 07:09:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3c5fc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', '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 07:09:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:09:53 INFO - Using env: {'DISPLAY': ':0', 07:09:53 INFO - 'HOME': '/home/cltbld', 07:09:53 INFO - 'LANG': 'en_US.UTF-8', 07:09:53 INFO - 'LANGUAGE': 'en_US:en', 07:09:53 INFO - 'LOGNAME': 'cltbld', 07:09:53 INFO - 'MAIL': '/var/mail/cltbld', 07:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:53 INFO - 'MOZ_NO_REMOTE': '1', 07:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:53 INFO - 'NO_EM_RESTART': '1', 07:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:53 INFO - 'PWD': '/builds/slave/test', 07:09:53 INFO - 'SHELL': '/bin/bash', 07:09:53 INFO - 'SHLVL': '1', 07:09:53 INFO - 'TERM': 'linux', 07:09:53 INFO - 'TMOUT': '86400', 07:09:53 INFO - 'USER': 'cltbld', 07:09:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', 07:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:53 INFO - '_': '/tools/buildbot/bin/python'} 07:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:09:53 INFO - Cleaning up... 07:09:53 INFO - Return code: 0 07:09:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3c5fc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', '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 07:09:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:09:53 INFO - Using env: {'DISPLAY': ':0', 07:09:53 INFO - 'HOME': '/home/cltbld', 07:09:53 INFO - 'LANG': 'en_US.UTF-8', 07:09:53 INFO - 'LANGUAGE': 'en_US:en', 07:09:53 INFO - 'LOGNAME': 'cltbld', 07:09:53 INFO - 'MAIL': '/var/mail/cltbld', 07:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:53 INFO - 'MOZ_NO_REMOTE': '1', 07:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:53 INFO - 'NO_EM_RESTART': '1', 07:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:53 INFO - 'PWD': '/builds/slave/test', 07:09:53 INFO - 'SHELL': '/bin/bash', 07:09:53 INFO - 'SHLVL': '1', 07:09:53 INFO - 'TERM': 'linux', 07:09:53 INFO - 'TMOUT': '86400', 07:09:53 INFO - 'USER': 'cltbld', 07:09:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', 07:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:53 INFO - '_': '/tools/buildbot/bin/python'} 07:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:53 INFO - Downloading/unpacking flake8 07:09:53 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 07:09:53 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 07:09:53 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 07:09:53 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 07:09:53 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 07:09:53 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 07:09:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:09:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:09:55 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 07:09:55 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 07:09:55 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 07:09:55 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 07:09:55 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 07:09:55 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 07:09:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:09:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:09:55 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 07:09:55 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 07:09:55 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 07:09:55 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 07:09:55 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 07:09:55 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 07:09:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:09:55 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 07:09:55 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 07:09:55 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 07:09:55 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 07:09:55 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 07:09:55 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 07:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:09:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:09:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:09:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:09:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:09:56 INFO - no previously-included directories found matching 'docs/_build' 07:09:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:09:56 INFO - Running setup.py install for pep8 07:09:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:09:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:09:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:09:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:09:56 INFO - no previously-included directories found matching 'docs/_build' 07:09:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:09:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:09:56 INFO - Cleaning up... 07:09:56 INFO - Return code: 0 07:09:56 INFO - Running post-action listener: _resource_record_post_action 07:09:56 INFO - Running post-action listener: _start_resource_monitoring 07:09:56 INFO - Starting resource monitoring. 07:09:56 INFO - ##### 07:09:56 INFO - ##### Finished create-virtualenv step (success) 07:09:56 INFO - ##### 07:09:56 INFO - ##### 07:09:56 INFO - ##### Running install step. 07:09:56 INFO - ##### 07:09:56 INFO - Running pre-action listener: _resource_record_pre_action 07:09:56 INFO - Running main action method: install 07:09:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:56 INFO - Reading from file tmpfile_stdout 07:09:56 INFO - Detecting whether we're running mozinstall >=1.0... 07:09:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:09:56 INFO - Reading from file tmpfile_stdout 07:09:56 INFO - Output received: 07:09:56 INFO - Usage: mozinstall [options] installer 07:09:56 INFO - Options: 07:09:56 INFO - -h, --help show this help message and exit 07:09:56 INFO - -d DEST, --destination=DEST 07:09:56 INFO - Directory to install application into. [default: 07:09:56 INFO - "/builds/slave/test"] 07:09:56 INFO - --app=APP Application being installed. [default: firefox] 07:09:56 INFO - mkdir: /builds/slave/test/build/application 07:09:56 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'] 07:09:56 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 07:10:13 INFO - Reading from file tmpfile_stdout 07:10:13 INFO - Output received: 07:10:13 INFO - /builds/slave/test/build/application/firefox/firefox 07:10:13 INFO - Running post-action listener: _resource_record_post_action 07:10:13 INFO - ##### 07:10:13 INFO - ##### Finished install step (success) 07:10:13 INFO - ##### 07:10:13 INFO - ##### 07:10:13 INFO - ##### Running run-tests step. 07:10:13 INFO - ##### 07:10:13 INFO - Running pre-action listener: _resource_record_pre_action 07:10:13 INFO - Running main action method: run_tests 07:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:10:13 INFO - Python 2.7.3 07:10:13 INFO - Return code: 0 07:10:13 INFO - grabbing minidump binary from tooltool 07:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:13 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 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:10:13 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 07:10:13 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 07:10:13 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 07:10:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:10:13 INFO - Return code: 0 07:10:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:10:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:10:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:10:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:10:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:10:14 INFO - Return code: 0 07:10:14 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/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 07:10:14 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/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 07:10:14 INFO - Using env: {'DISPLAY': ':0', 07:10:14 INFO - 'HOME': '/home/cltbld', 07:10:14 INFO - 'LANG': 'en_US.UTF-8', 07:10:14 INFO - 'LANGUAGE': 'en_US:en', 07:10:14 INFO - 'LOGNAME': 'cltbld', 07:10:14 INFO - 'MAIL': '/var/mail/cltbld', 07:10:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:10:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:14 INFO - 'MOZ_NO_REMOTE': '1', 07:10:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:14 INFO - 'NO_EM_RESTART': '1', 07:10:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:14 INFO - 'PWD': '/builds/slave/test', 07:10:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:10:14 INFO - 'SHELL': '/bin/bash', 07:10:14 INFO - 'SHLVL': '1', 07:10:14 INFO - 'TERM': 'linux', 07:10:14 INFO - 'TMOUT': '86400', 07:10:14 INFO - 'USER': 'cltbld', 07:10:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342', 07:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:14 INFO - '_': '/tools/buildbot/bin/python'} 07:10:14 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/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 07:10:14 INFO - mozversion application_buildid: 20160617043005 07:10:14 INFO - mozversion application_changeset: f97c058ecdeb29f13c3e1e01794cbfebd24ca815 07:10:14 INFO - mozversion application_display_name: Nightly 07:10:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:10:14 INFO - mozversion application_name: Firefox 07:10:14 INFO - mozversion application_remotingname: firefox 07:10:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:10:14 INFO - mozversion application_vendor: Mozilla 07:10:14 INFO - mozversion application_version: 50.0a1 07:10:14 INFO - mozversion platform_buildid: 20160617043005 07:10:14 INFO - mozversion platform_changeset: f97c058ecdeb29f13c3e1e01794cbfebd24ca815 07:10:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:10:14 INFO - mozversion platform_version: 50.0a1 07:10:14 INFO - using testdate: 1466172614 07:10:14 INFO - actual date: 1466172614 07:10:14 INFO - starting webserver on 'localhost:43279' 07:10:14 INFO - SUITE-START | Running 2 tests 07:10:14 INFO - TEST-START | dromaeo_css 07:10:14 INFO - operating with platform_type : linux_ 07:10:14 INFO - Initialising browser for dromaeo_css test... 07:10:14 INFO - TEST-INFO | started process 11933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVSivrP/profile http://localhost:43279/getInfo.html) 07:10:19 INFO - PROCESS | 11933 | __metrics Screen width/height:1600/1200 07:10:19 INFO - PROCESS | 11933 | colorDepth:24 07:10:19 INFO - PROCESS | 11933 | Browser inner width/height: 1024/697 07:10:19 INFO - PROCESS | 11933 | __metrics 07:10:20 ERROR - PROCESS | 11933 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 07:10:21 INFO - TEST-INFO | 11933: exit 0 07:10:21 INFO - Browser initialized. 07:10:21 INFO - Running cycle 1/1 for dromaeo_css test... 07:10:21 INFO - TEST-INFO | started process 12051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVSivrP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:33 INFO - PROCESS | 12051 | RSS: Main: 185335808 07:10:33 INFO - PROCESS | 12051 | 07:11:23 INFO - PROCESS | 12051 | 1466172683009 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] 07:13:30 INFO - PROCESS | 12051 | Cycle 1(1): loaded http://localhost:43279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43279/tests/dromaeo/cssquery-ext.html) 07:13:31 INFO - PROCESS | 12051 | RSS: Main: 189558784 07:13:31 INFO - PROCESS | 12051 | 07:16:33 INFO - PROCESS | 12051 | Cycle 1(1): loaded http://localhost:43279/tests/dromaeo/cssquery-ext.html (next: http://localhost:43279/tests/dromaeo/cssquery-jquery.html) 07:16:34 INFO - PROCESS | 12051 | RSS: Main: 187944960 07:16:34 INFO - PROCESS | 12051 | 07:19:36 INFO - PROCESS | 12051 | Cycle 1(1): loaded http://localhost:43279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43279/tests/dromaeo/cssquery-mootools.html) 07:19:37 INFO - PROCESS | 12051 | RSS: Main: 189435904 07:19:37 INFO - PROCESS | 12051 | 07:22:38 INFO - PROCESS | 12051 | Cycle 1(1): loaded http://localhost:43279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43279/tests/dromaeo/cssquery-prototype.html) 07:22:39 INFO - PROCESS | 12051 | RSS: Main: 186994688 07:22:39 INFO - PROCESS | 12051 | 07:25:41 INFO - PROCESS | 12051 | Cycle 1(1): loaded http://localhost:43279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43279/tests/dromaeo/cssquery-yui.html) 07:25:42 INFO - PROCESS | 12051 | RSS: Main: 189100032 07:25:42 INFO - PROCESS | 12051 | 07:28:45 INFO - PROCESS | 12051 | Cycle 1(1): loaded http://localhost:43279/tests/dromaeo/cssquery-yui.html (next: http://localhost:43279/tests/dromaeo/cssquery-dojo.html) 07:28:45 INFO - PROCESS | 12051 | RSS: Main: 189923328 07:28:45 INFO - PROCESS | 12051 | 07:28:45 INFO - PROCESS | 12051 | __start_tp_report 07:28:45 INFO - PROCESS | 12051 | _x_x_mozilla_page_load 07:28:45 INFO - PROCESS | 12051 | _x_x_mozilla_page_load_details 07:28:45 INFO - PROCESS | 12051 | |i|pagename|runs| 07:28:45 INFO - PROCESS | 12051 | |0;dojo.html;2983.149802306343;2999.9850000750007;3023.2441889527618;3109.7201251887327;3133.5769671094395;5268.05175068487;5338.3860856001575;5347.973260133699;5417.160340147274;5436.646617969829;5295.947040529593;5370.838874833751;5393.73031348433;5422.48486393793;5496.532794712454;4817.951820481785;4868.5131486851205;4937.407511098673;4982.427020892589;5038.521340472667;667.5237113116017;4850.151223535885;4856.732879691615;4897.2898929655175;4952.479989601094;4956.058348913695;4962.454130045692;4977.477364876672;4984.750762461862;4996.700197988114;4996.650234483587;5008.54923056923;5015.3730783652045;5017.974910125463;5031.647784655075;4873.780679869415;4893.4617192108835;4928.827491037832;4944.752762361867;4959.776810043557;5362.892742145174;5405.459454054602;5438;5445.482679145475;5446.673199608036;5611.579131565149;5714.057180565202;5788.710564471801;5788.913166302509;5807.128930660392;5780.335261444946;5824.708764561755;5830.82507524775;5841.474267315962;5911.261092363455;5283.762230699628;5313.3092697949405;5323.334583177103;5333.333333333333;5340.759665815048;5818.679972601463;5943.524518038546;5952.464278214981;5952.821415357546;5959.910601340984;5700.743466543932;5708.857278568069;5711.057675483498;5715.599908006483;5719.628224165416;5860.355360910296;5863.501602363762;5864.67744274069;5872.148538461899;5878;5726;5777.653340799566;5799.333076696234;5827.912581311284;5839.970800145972;5777.480026797609;5805.042168042226;5815.941840581625;5850.210221620112;5870.3249126350165;4359.694821362475;4498.955010449919;4521.3896124023495;4527.47933987589;4540.909181816345;3910.3743401056263;3954.307996100671;3956.050547868491;3976.940345894814;4021.738586991836;5449.155380915964;5492.615516913777;5504.2018907258225;5548.944510554924;5561.054620714488;5607.52336051432;5850.210221620112;5861.062230043258;5865.442782935615;5869.530437564985;5555.166724991283;5586.078297080936;5599.160125981135;5626.043572592587;5631.521320687705;4978.203487442064;5042.193249080129;5050.444451110375;5054.393472783216;5107.310513080686;5787.681677507778;5919.911201331984;6062.727177277033;6083.087536869505;6123.540734444934;5749.913751293734;5761.769529218785;5809.2738407699035;5814.5348372130975;5833.416658334302;6037.09443583466;6046.183765191643;6047.758089676539;6057.273127224761;6064.514838812973;5515.200295956984;5719.456651618089;5734.5125664319;5748.109043098327;5775.653460792366;5899.410058994066;5902.852428689317;5909.113632955091;5920.911186332122;5969;5679.801206957736;5690;5690.061139911868;5696.772129114955;5738.311402631711;5398.9190162146815;5552.333719953632;5593.244911936837;5619.494245517923;5669.54643628517;5521.309836270466;5557.5553955682635;5561.63849349791;5576.665400076008;5585.581081418829;5593.272874526286;5694.772209111589;5710.857228569319;5713.542916566747;5731.627444216113;5437.238786569963;5507.669539827623;5559.19391688211;5636.323641163087;5677.1768093627015 07:28:45 INFO - PROCESS | 12051 | |1;ext.html;541.6614615865084;601.9736349524061;616.5961295351547;620.7206756959366;635.783833496611;38783.22433551331;40566;43229;43569.7821510892;43616.563834361645;44457;45077.77461112698;45148.3227751584;45347.319790203175;45662.315065274044;8918.197362237397;8963.507007114606;9023.511120665082;9023.864642030374;9100.317476189279;8791.692290769824;8876.334274929373;8898.110188981114;8922.509261990588;8965.462072275652;8984;8989.37074404792;8996.460212387277;9002.234810041155;9016.77458063547;8917.55412229386;8949.060348663394;8984.685536006275;8993.685221017266;9008.954955225181;8820.691275805317;8865.911340886638;8874.556272186364;8887.333449991213;8912.064233255545;34204.48693269603;42068.579314207076;42604.78697606523;42717.78641106805;42929.57070429287;3305.752068594865;3617.8371973261264;3668.8715894943816;3856.3058649443087;4249.617534421917;31120;31332.843335783404;31469.8426507866;31605.367892642247;32457.350852983043;4036.112055347848;4171.812268447897;4180.393842892763;4180.561041090703;4205.537390887031;290118;291166;292255;292356.07329450164;292479.53760231275;34818.30363392718;35155.296894061976;35228.82385588055;35326.82336588352;35418;35635.28729425397;36290.45564316538;36377;38591;38768.22463550713;17607.295708171787;17696.203670834584;17739.556511087325;17748.023858687895;17827.643447131246;13503.527376541773;13522.459101635824;13550.59348219555;13649.044566880422;13658;19825.20699172017;19832.801671983383;19866.70199947002;19925.402237932885;20029.198832046553;7349.889751653729;7388.593627350439;7400.888986665097;7472.626368681545;7486.213947535539;971.621067783565;1036.491904279272;1066.9253152279266;1091.4651820607844;1101.3942331717524;32452.83773581164;32540.83729581337;32660.18349541233;33078.17304567405;33312.3337533248;1095.370162156763;1136.7385501334738;1175.9823602645968;1177.735009622828;1183.3728124094243;17012.82987170137;17174.914125429543;17290.740638890427;17319;17587.29650813953;154903;155965;156630;156742;520031;59464.702676487206;59469.405305946384;59534.40465595289;59817;59922.101168482506;1324.913880597758;1340.9798853017212;1357.2060344698264;1361.3737680666807;1363.1616555817902;31116;31997.84001080073;32416;32453.51319730159;32637.836810815796;52394.476055238956;52453.7377313111;52987.470125298256;53115.46884531105;53148.20277695915;401497;409681.41911485407;410087;411436;411828;28592.71407285984;28647.57028644614;29047.419051619272;29077.563836542045;29183.124506264845;49297;49836.501634984634;49864;50056;51417.742911285204;40896.18207635771;41811.37282940697;41841;42224.15551688887;43332.566674332855;40928.386074209506;41138;41670.37494437525;42014.36978445265;42178;40926.795366022976;41469.79265103655;41526;41569;41926.58073419227;34941.30117397587;37167.814160929025;37684.43473347847;37811.62188378081;37828.81085594554;27603.58594621042;28010.579841301987;28170;28288.434231314848;28401.715982839905 07:28:45 INFO - PROCESS | 12051 | |2;jquery.html;373.4650586091165;382.2145491015961;385.5835697446758;391.1141265034695;399.81009020715163;17525.561860953465;19024.334148304828;19360.3223887164;19467.707984380228;19646.70529942052;17728.290868365282;18000.729989050174;18502.444926652188;18525.722114168297;18753.7186942196;5596.748146333414;5756.194132821408;5828.591998560102;5859.238299021121;5867.207926929874;5674.205611214413;5712.371639119693;5767.42325767422;5768.826935191951;5829.067349224125;5755.82732518023;5802.9844777164035;5806.44838740319;5818.912716309259;5834.387389324123;5697.857553561153;5791.391903850077;5801.9129713054335;5832.445917637818;5833.737481813308;4927.950720492785;5139.383274007106;5139.640225184238;5142.537171654569;5167.715775632339;22950.77049229503;23031.30906072804;23262;23492.177773778007;23639.527209455886;2385.153270588933;2417.1539961013505;2570.344562136662;2824.449232399683;3093.752499800033;14114.717705645933;14426.855731442656;14958.177300248482;15065.171415572138;15268.541943741706;1975.3876298347413;2000.4398768344886;2042.1831267492973;2057.1360028787944;2057.989710051455;54589.727051364884;56694.716526417105;65573.99999999952;67193.66403168002;79038;10138.239632027628;10511.789764204674;10598.788024239471;10606.416647084485;10818.837717434244;14793.633018716953;14864.331105100297;14893.70212595742;14928.925355373154;14932.40270389194;8136.674533018731;8477.74566762998;8510.617022234015;8522.659093636184;8562.871556926651;8242.340612750966;8368.414211005293;8370.455920365157;8375.036870759819;8459.788505287293;6620.5034622402545;6662.700178491979;6730.461563074942;6742.83142921421;6834.350736680008;1807.8372946434883;1885.0951543259312;1923.2979962313655;1942.6406114868794;1955.1592815089648;902.7517432705927;950.5579905344048;1009.6718566465928;1108.14672702019;1135.5798354608849;19076.33232836844;19701.901490492455;19997;19998.800011999985;20362.898185508977;947.4457442396275;985.0199051943363;1015.4719545836124;1028.7736697926443;1047.1256500821898;11129.499172537255;11474.196806223652;11538.942305288589;11677.190035544505;11686.941565292289;407452;408491;421248;421956;422985;50666;51668;68130;79018.6049069751;83126.58436707899;1006.8338724110587;1018.6791160784329;1025.4718819807806;1028.3521381529738;1029.5109822834095;17284.222210000833;17517.386891458736;17730.290788368322;17780;18061.729074063638;27436.17691469259;33385.499217512246;35277;36506;39344;48754.26868596903;50222;51187.488125118274;52055.219171713215;52362.73818630882;8360.205780450848;8380.455270407649;8443.535605541754;8500.064992850657;8619.956900215459;12614.684632884251;12616.87383126157;12858.099933004974;13978.580642580739;14117.08238964464;11659.417029148679;12103.394830258276;12404;12543.435545400662;12620.495180192689;11513.42432878336;11603.129765267808;11619.419029048344;12247.142700010914;12401.441935112762;12044.91595756386;12285.324307163191;12334.938325308316;12392.690182745504;12525.749485010067;8100.392470564613;8305.584720764058;8450;8468.153184681729;8669.003064647646;11630.76738465209;11880.10899182582;12087.697807554881;12190.2076365036;12539.184952978027 07:28:45 INFO - PROCESS | 12051 | |3;mootools.html;1431.3058166789106;1469.9853001469985;1564.5306408077574;1695.1608953567986;1700.9489715308546;7882.3300019498265;8577.571121443927;8664.653413863438;9134.954325228382;9144.628305754148;8691.26124279437;8891.688790892304;8938.106189381058;8958.596863141158;8975.730728078168;2305.9538809223804;2310.803581695558;2332.1371092695726;2346.038124369009;2348.6829278047417;2265.2524666859895;2285.1887579909144;2316.918907838226;2319.9884000579973;2321.2688003279;2274.590573696734;2288.702468679069;2297.1041293895396;2299.6895419118455;2304.7349554801162;2183.3122566391617;2188.1684959715367;2197.3627647982066;2201.6477363621825;2214.5128071824174;2225.3101538522947;2241.865488070721;2243.8204943604474;2248.730152381708;2252.8535645183174;8848.115188481164;8986.685466008723;9005.054469280696;9009.279257659371;9012.233960113399;5211.24436956643;5304.071787437221;5304.814331498417;5316.255724198615;5316.441773613754;3148.401803657298;3217.3404452087266;3354.127926739041;3396.83015849209;3423.4864770284407;1062.054771253585;1067.530286673861;1075.3762817565794;1078.4392116099664;1083.7236504691332;12190.695232619168;12231;12235;12277.815832762604;12331.321777302244;4619.422572178478;4634.165850146938;4745.691530050535;4779.235322348477;4794.328793968847;10316.535755890853;10362.015608517178;10375.481225938673;10396.532156052996;10409.895901040893;5332.626716129834;5351.474829673524;5356.839294821161;5380.24676545284;5381.623286369995;4437.667174961826;4721.079389519011;4852.393450818648;4915.508449155127;4933.45731969483;3972.66232370246;3986.242613903349;4089.7137200396282;4096.487939007624;4229.238737027303;1255.1966741285585;1279.9424025918856;1281.0008193609;1289.3875409180564;1310.5740634293702;937.1471960516034;953.4565297780199;961.7355227312405;972.1930797438109;992.4987881119988;5693.28833895763;5837;5843.474087332161;5863.648181109147;6046.244219472566;444.4466639034358;445.42317698580416;448.1887783112577;450.22561194744986;458.09526185783477;3879.8836034919;3904.2777086239134;3936.4292177634084;3966.0283230608684;4026;10499.842502362471;10682.51928663212;10942.343459392461;10974.615888444026;11352.829707554394;10978;11112.61105861307;11118.944405277922;11154.442277886235;11251.381174035343;8166.877496837552;8326;8376.869122668362;8390.077091519928;8409.789755256168;5897.439743224387;6001.969990150022;6026.186464827192;6054.091886217103;6068.575199735976;10046.899531004889;10215.846762298721;10417.479126043516;10478.685639430829;10515.894841051491;9898.703038908845;10050.49747512636;10125.038121378457;10140.949295253771;10165.186785057325;7046.894296585658;7630.1606823248285;7827.373810095292;7858.921410785819;7968.601569921365;8714.172153645393;8734.126587341216;8783.604737786944;8787.956060219658;8808;7643.5796031218815;7657.1959944205055;7789.5715735635085;7881.527108373516;8196.754097377088;7884.645190966535;7925.960370198112;7933.563653999086;7938.801529961797;8067.798305042186;7038.085048943604;7112.57324560528;7148.142222933281;7201.495895287279;7202.567845929261;4845.95154048455;5129.102407078672;5143.5113664201845;5223.45153758865;5276.023935571931;5049.64652474338;5143.074246635641;5167;5381.946180538144;5472.91790623149 07:28:45 INFO - PROCESS | 12051 | |4;prototype.html;308.65122411674804;312.210108425683;312.8123126124327;313.6972821227515;319.2258772476743;5634.3520495143075;5644.74598643061;5681.7784176402065;5713.314402271728;5726.455986681259;5489.368722596902;5526.198701188326;5548.611597188198;5551.250581171541;5553.972230138854;4124.835006599732;4134.607212314825;4228.133232687307;4246.851360202393;4254.97872510637;4213.5786421357925;4235.703500754948;4265.914681706364;4277.080427708042;4287.8070486828165;4211.136716973013;4237.8304867805255;4247.384129301249;4255.5957184067465;4257.638100761439;4075.940255533568;4272.380504826814;4299.978500107511;4300.397944287803;4303.505096913848;3679.5768486624115;3715.5912849586525;3730.5896351401325;3760.8683696070507;3767.190054138346;5405.486478784548;5426.480585436084;5431.619786614939;5452.945470545284;5467.781288748445;4844.539768721966;4884.3650325457465;4891.730954797485;4894.143524883131;4947.332110165154;5755;5767.298646899175;5768.711564421804;5777.306723193202;5785.508231800302;4080.224757296104;4094.1402305515876;4101.46680931477;4111.814968326433;4126.360414135814;5870.589058765888;6072.635641861502;6076.817695469143;6078.969605151946;6193.6903154842075;4182.937255941163;4201.789910504463;4216.388623649615;4241;4247.341662042389;4221.155768846243;4255.702100852911;4273.829046838154;4284.757420348126;4285.357196420562;4646.465656449484;4895.339129217581;4901.828436004723;4907.582855457326;4938.530839570235;5798.159266906359;5836.358000619928;5862.70686465675;5875.9118613220835;5886.321723615744;1490.2250829568563;1518.6203449137715;1519.4909705248865;1520.7566789313657;1525.8321584625905;955.6989548292405;982.8378317577663;982.9901700982898;994.2046362909643;1020.3826684855555;5650.152477128464;5660.179274005246;5668.044524638993;5674.716264186856;5680.403557626472;5917.289925208916;5958.523318134538;5964.284285885635;5983.640981541122;6020.638761674313;5396.109641909041;5637.915431268534;5729.828105156852;5747.712614369349;5797.710114494258;3218.452863013293;3218.645948945661;3240.4167249895245;3246.026192142348;3250.398676244902;6071.180390647206;6245.375462453719;6252.437280644764;6305.180326557518;6329.3987071229085;6171.13604095427;6202.751889924442;6241.34465881085;6241.750329986749;6260.874782504325;5980.372060933626;6295.213098362705;6330.651814150266;6351.2060992375955;6362.491000719931;6066.241719785027;6084.7222083362985;6101.237345331833;6118.847028824315;6135.233095863017;5992.790252341147;6010.699465026819;6051.606645568024;6052.636841789331;6064.120702498201;6018.21763170785;6228.875422491616;6246.718897649707;6255.874882502416;6284.685765711788;4230.450041494709;4260.657892763769;4279.529251782364;4304.460368382669;4305.3111502160755;5879.412058794086;5896.64620122794;6094.146819445193;6135.417135372132;6139.324674285915;5784.2769653793275;5813.82558523245;5823.70881455934;5854.121881717776;5885.47030767233;5737.368889422077;5846;5846.129238643593;5861.505316144356;5872.412758724094;5539.335279766454;5694.206325007609;5706.8573285666525;5729;5762.711864406847;5763.884722305615;5860.238169037998;5900.970495147497;5943.970280148572;5963.73163207648;5544.916826247529;5805.796797112081;5806.44838740319;5819.447152520504;5833.737481813413 07:28:45 INFO - PROCESS | 12051 | |5;yui.html;717.9784606461808;778.5912395992103;810.0195023168354;830.2859540794917;831.604987630875;15280.92359538202;16094.1952902355;16103.194840257998;16286.674266514678;16470.91764541177;14805.185714785683;14906.776398354006;14975.400983960655;14993.325300361483;15003.099814011168;655.158121813471;764.4763337114094;788.6451097006342;789.3961119743401;791.2799352589145;766.9539827610333;773.4315278270467;782.3662833105175;782.538302401583;788.2550989315099;835.7158566087529;841.1672444280149;845.2603971524916;845.6955496021427;847.4406891451644;834.7787836223406;839.093778718982;839.7228914458215;841.3269384492443;842.3135144856922;603.6740160313426;608.5223099866583;610.4079043327964;612.9417705318032;614.5145335185198;14684;14781.187034713086;14802.333894974752;14849.777253341208;14863;15097.698046039128;15342.846571534365;15544.76682849758;15595.688086238326;15757.68484630301;12239.938800305941;12245.755084898341;12289.754204915851;12495.687607809787;12699.428525716365;3806.8210107045056;3888.319544079803;3936.940945885814;3955.0310174007263;4019.155977244782;73797.63101184514;74244;74621.99999999946;74801.25198748051;74865.62567187184;11919.3444360561;11971.401429928643;11998.64004079879;12265.26408415498;12473.189242699196;22285.440019198824;22450.887745561493;22493.32520024402;22580.887095564416;22991.770082298965;8972.102789721106;8973.416727912665;8989.865152022725;9019;9204.355695101278;4816.397950256218;4852.078105160008;4924.901501969941;4999.900001999939;5052.646314758005;3677.9448308275396;3711.4432835074954;3748.325301445766;3808.2383523295453;3818.59904710007;619.603453789575;620.1999420747276;633.7306644675995;634.7334119669749;647.1166857239833;702.8945658151318;713.6717110129294;716.9641517924083;721.4228617106294;725.0863911471479;9094.59074341643;9737.415755054719;10045.543396207655;10233.48832558369;10492.16062714981;632.686820024091;654.715198888485;669.146837781832;684.5447777228187;717.1000394504968;4811.422629284508;4948.208286674115;4971.304017437562;4983.476734942778;5046.84859454217;67507.66246168737;67686;67729.66135169292;68109.65945170242;73430;98617.50691246497;104387;104410.47794761129;104470;105509.47245263879;55657.44342556522;67378.32621673819;70970;83569.99999999878;88930;9333.25333973294;9672.95163524178;9736;9775.560099795384;9855.162311203341;54231.72884135554;54884;55980.6004849882;56048.719756400955;57134.142987854386;75414.62292688501;80960.59519702599;81407.59296203482;81721;81899;12311.384430778246;12313.692157696129;12452.688682783002;12653.620391388273;12964.52912790386;13762.862371376157;13828.86171138316;13846.515371961934;13936.432760808708;14004.159750415009;12929.54746583865;12979.870201298243;13104.344782761014;13323.800142997668;13730.45078196901;12444.56444024491;12921.612351629467;12981.286029268482;13130.934345328213;13233.801492977806;12605.810912836132;12610.18231409;12954.326229850718;13076.934615326862;13186;10626;11031.33061558505;11060;11157.66527004191;11439.59961401347;10975.725606859573;11176.385298808644;11185;11384.203105782515;11463.598774042868 07:28:45 INFO - PROCESS | 12051 | __end_tp_report 07:28:45 INFO - PROCESS | 12051 | __start_cc_report 07:28:45 INFO - PROCESS | 12051 | _x_x_mozilla_cycle_collect,351 07:28:45 INFO - PROCESS | 12051 | __end_cc_report 07:28:45 INFO - PROCESS | 12051 | __startTimestamp1466173725630__endTimestamp 07:28:45 INFO - PROCESS | 12051 | 07:28:45 INFO - PROCESS | 12051 | ------- Summary: start ------- 07:28:45 INFO - PROCESS | 12051 | Number of tests: 6 07:28:45 INFO - PROCESS | 12051 | 07:28:45 INFO - PROCESS | 12051 | [#0] dojo.html Cycles:165 Average:5366.38 Median:5593.24 stddev:721.65 (12.9%) stddev-sans-first:699.22 07:28:45 INFO - PROCESS | 12051 | Values: 2983.1 3000.0 3023.2 3109.7 3133.6 5268.1 5338.4 5348.0 5417.2 5436.6 5295.9 5370.8 5393.7 5422.5 5496.5 4818.0 4868.5 4937.4 4982.4 5038.5 667.5 4850.2 4856.7 4897.3 4952.5 4956.1 4962.5 4977.5 4984.8 4996.7 4996.7 5008.5 5015.4 5018.0 5031.6 4873.8 4893.5 4928.8 4944.8 4959.8 5362.9 5405.5 5438.0 5445.5 5446.7 5611.6 5714.1 5788.7 5788.9 5807.1 5780.3 5824.7 5830.8 5841.5 5911.3 5283.8 5313.3 5323.3 5333.3 5340.8 5818.7 5943.5 5952.5 5952.8 5959.9 5700.7 5708.9 5711.1 5715.6 5719.6 5860.4 5863.5 5864.7 5872.1 5878.0 5726.0 5777.7 5799.3 5827.9 5840.0 5777.5 5805.0 5815.9 5850.2 5870.3 4359.7 4499.0 4521.4 4527.5 4540.9 3910.4 3954.3 3956.1 3976.9 4021.7 5449.2 5492.6 5504.2 5548.9 5561.1 5607.5 5850.2 5861.1 5865.4 5869.5 5555.2 5586.1 5599.2 5626.0 5631.5 4978.2 5042.2 5050.4 5054.4 5107.3 5787.7 5919.9 6062.7 6083.1 6123.5 5749.9 5761.8 5809.3 5814.5 5833.4 6037.1 6046.2 6047.8 6057.3 6064.5 5515.2 5719.5 5734.5 5748.1 5775.7 5899.4 5902.9 5909.1 5920.9 5969.0 5679.8 5690.0 5690.1 5696.8 5738.3 5398.9 5552.3 5593.2 5619.5 5669.5 5521.3 5557.6 5561.6 5576.7 5585.6 5593.3 5694.8 5710.9 5713.5 5731.6 5437.2 5507.7 5559.2 5636.3 5677.2 07:28:45 INFO - PROCESS | 12051 | 07:28:45 INFO - PROCESS | 12051 | [#1] ext.html Cycles:180 Average:48352.95 Median:22301.06 stddev:87111.99 (390.6%) stddev-sans-first:87282.40 07:28:45 INFO - PROCESS | 12051 | Values: 541.7 602.0 616.6 620.7 635.8 38783.2 40566.0 43229.0 43569.8 43616.6 44457.0 45077.8 45148.3 45347.3 45662.3 8918.2 8963.5 9023.5 9023.9 9100.3 8791.7 8876.3 8898.1 8922.5 8965.5 8984.0 8989.4 8996.5 9002.2 9016.8 8917.6 8949.1 8984.7 8993.7 9009.0 8820.7 8865.9 8874.6 8887.3 8912.1 34204.5 42068.6 42604.8 42717.8 42929.6 3305.8 3617.8 3668.9 3856.3 4249.6 31120.0 31332.8 31469.8 31605.4 32457.4 4036.1 4171.8 4180.4 4180.6 4205.5 290118.0 291166.0 292255.0 292356.1 292479.5 34818.3 35155.3 35228.8 35326.8 35418.0 35635.3 36290.5 36377.0 38591.0 38768.2 17607.3 17696.2 17739.6 17748.0 17827.6 13503.5 13522.5 13550.6 13649.0 13658.0 19825.2 19832.8 19866.7 19925.4 20029.2 7349.9 7388.6 7400.9 7472.6 7486.2 971.6 1036.5 1066.9 1091.5 1101.4 32452.8 32540.8 32660.2 33078.2 33312.3 1095.4 1136.7 1176.0 1177.7 1183.4 17012.8 17174.9 17290.7 17319.0 17587.3 154903.0 155965.0 156630.0 156742.0 520031.0 59464.7 59469.4 59534.4 59817.0 59922.1 1324.9 1341.0 1357.2 1361.4 1363.2 31116.0 31997.8 32416.0 32453.5 32637.8 52394.5 52453.7 52987.5 53115.5 53148.2 401497.0 409681.4 410087.0 411436.0 411828.0 28592.7 28647.6 29047.4 29077.6 29183.1 49297.0 49836.5 49864.0 50056.0 51417.7 40896.2 41811.4 41841.0 42224.2 43332.6 40928.4 41138.0 41670.4 42014.4 42178.0 40926.8 41469.8 41526.0 41569.0 41926.6 34941.3 37167.8 37684.4 37811.6 37828.8 27603.6 28010.6 28170.0 28288.4 28401.7 07:28:45 INFO - PROCESS | 12051 | 07:28:45 INFO - PROCESS | 12051 | [#2] jquery.html Cycles:180 Average:25640.00 Median:13012.34 stddev:68164.59 (523.8%) stddev-sans-first:68329.41 07:28:45 INFO - PROCESS | 12051 | Values: 373.5 382.2 385.6 391.1 399.8 17525.6 19024.3 19360.3 19467.7 19646.7 17728.3 18000.7 18502.4 18525.7 18753.7 5596.7 5756.2 5828.6 5859.2 5867.2 5674.2 5712.4 5767.4 5768.8 5829.1 5755.8 5803.0 5806.4 5818.9 5834.4 5697.9 5791.4 5801.9 5832.4 5833.7 4928.0 5139.4 5139.6 5142.5 5167.7 22950.8 23031.3 23262.0 23492.2 23639.5 2385.2 2417.2 2570.3 2824.4 3093.8 14114.7 14426.9 14958.2 15065.2 15268.5 1975.4 2000.4 2042.2 2057.1 2058.0 54589.7 56694.7 65574.0 67193.7 79038.0 10138.2 10511.8 10598.8 10606.4 10818.8 14793.6 14864.3 14893.7 14928.9 14932.4 8136.7 8477.7 8510.6 8522.7 8562.9 8242.3 8368.4 8370.5 8375.0 8459.8 6620.5 6662.7 6730.5 6742.8 6834.4 1807.8 1885.1 1923.3 1942.6 1955.2 902.8 950.6 1009.7 1108.1 1135.6 19076.3 19701.9 19997.0 19998.8 20362.9 947.4 985.0 1015.5 1028.8 1047.1 11129.5 11474.2 11538.9 11677.2 11686.9 407452.0 408491.0 421248.0 421956.0 422985.0 50666.0 51668.0 68130.0 79018.6 83126.6 1006.8 1018.7 1025.5 1028.4 1029.5 17284.2 17517.4 17730.3 17780.0 18061.7 27436.2 33385.5 35277.0 36506.0 39344.0 48754.3 50222.0 51187.5 52055.2 52362.7 8360.2 8380.5 8443.5 8500.1 8620.0 12614.7 12616.9 12858.1 13978.6 14117.1 11659.4 12103.4 12404.0 12543.4 12620.5 11513.4 11603.1 11619.4 12247.1 12401.4 12044.9 12285.3 12334.9 12392.7 12525.7 8100.4 8305.6 8450.0 8468.2 8669.0 11630.8 11880.1 12087.7 12190.2 12539.2 07:28:45 INFO - PROCESS | 12051 | 07:28:45 INFO - PROCESS | 12051 | [#3] mootools.html Cycles:180 Average:5824.58 Median:4626.79 stddev:3361.25 (72.6%) stddev-sans-first:3354.46 07:28:45 INFO - PROCESS | 12051 | Values: 1431.3 1470.0 1564.5 1695.2 1700.9 7882.3 8577.6 8664.7 9135.0 9144.6 8691.3 8891.7 8938.1 8958.6 8975.7 2306.0 2310.8 2332.1 2346.0 2348.7 2265.3 2285.2 2316.9 2320.0 2321.3 2274.6 2288.7 2297.1 2299.7 2304.7 2183.3 2188.2 2197.4 2201.6 2214.5 2225.3 2241.9 2243.8 2248.7 2252.9 8848.1 8986.7 9005.1 9009.3 9012.2 5211.2 5304.1 5304.8 5316.3 5316.4 3148.4 3217.3 3354.1 3396.8 3423.5 1062.1 1067.5 1075.4 1078.4 1083.7 12190.7 12231.0 12235.0 12277.8 12331.3 4619.4 4634.2 4745.7 4779.2 4794.3 10316.5 10362.0 10375.5 10396.5 10409.9 5332.6 5351.5 5356.8 5380.2 5381.6 4437.7 4721.1 4852.4 4915.5 4933.5 3972.7 3986.2 4089.7 4096.5 4229.2 1255.2 1279.9 1281.0 1289.4 1310.6 937.1 953.5 961.7 972.2 992.5 5693.3 5837.0 5843.5 5863.6 6046.2 444.4 445.4 448.2 450.2 458.1 3879.9 3904.3 3936.4 3966.0 4026.0 10499.8 10682.5 10942.3 10974.6 11352.8 10978.0 11112.6 11118.9 11154.4 11251.4 8166.9 8326.0 8376.9 8390.1 8409.8 5897.4 6002.0 6026.2 6054.1 6068.6 10046.9 10215.8 10417.5 10478.7 10515.9 9898.7 10050.5 10125.0 10140.9 10165.2 7046.9 7630.2 7827.4 7858.9 7968.6 8714.2 8734.1 8783.6 8788.0 8808.0 7643.6 7657.2 7789.6 7881.5 8196.8 7884.6 7926.0 7933.6 7938.8 8067.8 7038.1 7112.6 7148.1 7201.5 7202.6 4846.0 5129.1 5143.5 5223.5 5276.0 5049.6 5143.1 5167.0 5381.9 5472.9 07:28:45 INFO - PROCESS | 12051 | 07:28:45 INFO - PROCESS | 12051 | [#4] prototype.html Cycles:180 Average:4918.55 Median:5677.56 stddev:1471.79 (25.9%) stddev-sans-first:1434.68 07:28:45 INFO - PROCESS | 12051 | Values: 308.7 312.2 312.8 313.7 319.2 5634.4 5644.7 5681.8 5713.3 5726.5 5489.4 5526.2 5548.6 5551.3 5554.0 4124.8 4134.6 4228.1 4246.9 4255.0 4213.6 4235.7 4265.9 4277.1 4287.8 4211.1 4237.8 4247.4 4255.6 4257.6 4075.9 4272.4 4300.0 4300.4 4303.5 3679.6 3715.6 3730.6 3760.9 3767.2 5405.5 5426.5 5431.6 5452.9 5467.8 4844.5 4884.4 4891.7 4894.1 4947.3 5755.0 5767.3 5768.7 5777.3 5785.5 4080.2 4094.1 4101.5 4111.8 4126.4 5870.6 6072.6 6076.8 6079.0 6193.7 4182.9 4201.8 4216.4 4241.0 4247.3 4221.2 4255.7 4273.8 4284.8 4285.4 4646.5 4895.3 4901.8 4907.6 4938.5 5798.2 5836.4 5862.7 5875.9 5886.3 1490.2 1518.6 1519.5 1520.8 1525.8 955.7 982.8 983.0 994.2 1020.4 5650.2 5660.2 5668.0 5674.7 5680.4 5917.3 5958.5 5964.3 5983.6 6020.6 5396.1 5637.9 5729.8 5747.7 5797.7 3218.5 3218.6 3240.4 3246.0 3250.4 6071.2 6245.4 6252.4 6305.2 6329.4 6171.1 6202.8 6241.3 6241.8 6260.9 5980.4 6295.2 6330.7 6351.2 6362.5 6066.2 6084.7 6101.2 6118.8 6135.2 5992.8 6010.7 6051.6 6052.6 6064.1 6018.2 6228.9 6246.7 6255.9 6284.7 4230.5 4260.7 4279.5 4304.5 4305.3 5879.4 5896.6 6094.1 6135.4 6139.3 5784.3 5813.8 5823.7 5854.1 5885.5 5737.4 5846.0 5846.1 5861.5 5872.4 5539.3 5694.2 5706.9 5729.0 5762.7 5763.9 5860.2 5901.0 5944.0 5963.7 5544.9 5805.8 5806.4 5819.4 5833.7 07:28:45 INFO - PROCESS | 12051 | 07:28:45 INFO - PROCESS | 12051 | [#5] yui.html Cycles:180 Average:19582.90 Median:4936.55 stddev:26678.76 (540.4%) stddev-sans-first:26716.00 07:28:45 INFO - PROCESS | 12051 | Values: 718.0 778.6 810.0 830.3 831.6 15280.9 16094.2 16103.2 16286.7 16470.9 14805.2 14906.8 14975.4 14993.3 15003.1 655.2 764.5 788.6 789.4 791.3 767.0 773.4 782.4 782.5 788.3 835.7 841.2 845.3 845.7 847.4 834.8 839.1 839.7 841.3 842.3 603.7 608.5 610.4 612.9 614.5 14684.0 14781.2 14802.3 14849.8 14863.0 15097.7 15342.8 15544.8 15595.7 15757.7 12239.9 12245.8 12289.8 12495.7 12699.4 3806.8 3888.3 3936.9 3955.0 4019.2 73797.6 74244.0 74622.0 74801.3 74865.6 11919.3 11971.4 11998.6 12265.3 12473.2 22285.4 22450.9 22493.3 22580.9 22991.8 8972.1 8973.4 8989.9 9019.0 9204.4 4816.4 4852.1 4924.9 4999.9 5052.6 3677.9 3711.4 3748.3 3808.2 3818.6 619.6 620.2 633.7 634.7 647.1 702.9 713.7 717.0 721.4 725.1 9094.6 9737.4 10045.5 10233.5 10492.2 632.7 654.7 669.1 684.5 717.1 4811.4 4948.2 4971.3 4983.5 5046.8 67507.7 67686.0 67729.7 68109.7 73430.0 98617.5 104387.0 104410.5 104470.0 105509.5 55657.4 67378.3 70970.0 83570.0 88930.0 9333.3 9673.0 9736.0 9775.6 9855.2 54231.7 54884.0 55980.6 56048.7 57134.1 75414.6 80960.6 81407.6 81721.0 81899.0 12311.4 12313.7 12452.7 12653.6 12964.5 13762.9 13828.9 13846.5 13936.4 14004.2 12929.5 12979.9 13104.3 13323.8 13730.5 12444.6 12921.6 12981.3 13130.9 13233.8 12605.8 12610.2 12954.3 13076.9 13186.0 10626.0 11031.3 11060.0 11157.7 11439.6 10975.7 11176.4 11185.0 11384.2 11463.6 07:28:45 INFO - PROCESS | 12051 | -------- Summary: end -------- 07:28:45 INFO - PROCESS | 12051 | 07:28:46 INFO - TEST-INFO | 12051: exit 0 07:28:46 INFO - TEST-OK | dromaeo_css | took 1111689ms 07:28:46 INFO - TEST-START | kraken 07:28:46 INFO - operating with platform_type : linux_ 07:28:46 INFO - Initialising browser for kraken test... 07:28:46 INFO - TEST-INFO | started process 12289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5m5mUG/profile http://localhost:43279/getInfo.html) 07:28:51 INFO - PROCESS | 12289 | __metrics Screen width/height:1600/1200 07:28:51 INFO - PROCESS | 12289 | colorDepth:24 07:28:51 INFO - PROCESS | 12289 | Browser inner width/height: 1024/697 07:28:51 INFO - PROCESS | 12289 | __metrics 07:28:52 ERROR - PROCESS | 12289 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 07:28:52 INFO - TEST-INFO | 12289: exit 0 07:28:52 INFO - Browser initialized. 07:28:52 INFO - Running cycle 1/1 for kraken test... 07:28:52 INFO - TEST-INFO | started process 12409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5m5mUG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:04 INFO - PROCESS | 12409 | RSS: Main: 185229312 07:29:04 INFO - PROCESS | 12409 | 07:29:07 INFO - PROCESS | 12409 | Cycle 1(1): loaded http://localhost:43279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43279/tests/kraken/driver.html?testName=audio-beat-detection) 07:29:08 INFO - PROCESS | 12409 | RSS: Main: 191033344 07:29:08 INFO - PROCESS | 12409 | 07:29:10 INFO - PROCESS | 12409 | Cycle 1(1): loaded http://localhost:43279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43279/tests/kraken/driver.html?testName=audio-dft) 07:29:11 INFO - PROCESS | 12409 | RSS: Main: 190455808 07:29:11 INFO - PROCESS | 12409 | 07:29:14 INFO - PROCESS | 12409 | Cycle 1(1): loaded http://localhost:43279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43279/tests/kraken/driver.html?testName=audio-fft) 07:29:15 INFO - PROCESS | 12409 | RSS: Main: 185008128 07:29:15 INFO - PROCESS | 12409 | 07:29:17 INFO - PROCESS | 12409 | Cycle 1(1): loaded http://localhost:43279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43279/tests/kraken/driver.html?testName=audio-oscillator) 07:29:17 INFO - PROCESS | 12409 | RSS: Main: 185982976 07:29:17 INFO - PROCESS | 12409 | 07:29:20 INFO - PROCESS | 12409 | Cycle 1(1): loaded http://localhost:43279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:29:20 INFO - PROCESS | 12409 | RSS: Main: 186535936 07:29:20 INFO - PROCESS | 12409 | 07:29:23 INFO - PROCESS | 12409 | Cycle 1(1): loaded http://localhost:43279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43279/tests/kraken/driver.html?testName=imaging-darkroom) 07:29:24 INFO - PROCESS | 12409 | RSS: Main: 187392000 07:29:24 INFO - PROCESS | 12409 | 07:29:27 INFO - PROCESS | 12409 | Cycle 1(1): loaded http://localhost:43279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43279/tests/kraken/driver.html?testName=imaging-desaturate) 07:29:28 INFO - PROCESS | 12409 | RSS: Main: 185163776 07:29:28 INFO - PROCESS | 12409 | 07:29:31 INFO - PROCESS | 12409 | Cycle 1(1): loaded http://localhost:43279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43279/tests/kraken/driver.html?testName=json-parse-financial) 07:29:32 INFO - PROCESS | 12409 | RSS: Main: 185749504 07:29:32 INFO - PROCESS | 12409 | 07:29:33 INFO - PROCESS | 12409 | Cycle 1(1): loaded http://localhost:43279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:29:34 INFO - PROCESS | 12409 | RSS: Main: 186097664 07:29:34 INFO - PROCESS | 12409 | 07:29:36 INFO - PROCESS | 12409 | Cycle 1(1): loaded http://localhost:43279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43279/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:29:36 INFO - PROCESS | 12409 | RSS: Main: 186347520 07:29:36 INFO - PROCESS | 12409 | 07:29:38 INFO - PROCESS | 12409 | Cycle 1(1): loaded http://localhost:43279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:29:39 INFO - PROCESS | 12409 | RSS: Main: 186740736 07:29:39 INFO - PROCESS | 12409 | 07:29:42 INFO - PROCESS | 12409 | Cycle 1(1): loaded http://localhost:43279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:29:42 INFO - PROCESS | 12409 | RSS: Main: 186916864 07:29:42 INFO - PROCESS | 12409 | 07:29:45 INFO - PROCESS | 12409 | Cycle 1(1): loaded http://localhost:43279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:29:46 INFO - PROCESS | 12409 | RSS: Main: 186900480 07:29:46 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | Cycle 1(1): loaded http://localhost:43279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43279/tests/kraken/driver.html?testName=ai-astar) 07:29:47 INFO - PROCESS | 12409 | RSS: Main: 188223488 07:29:47 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | __start_tp_report 07:29:47 INFO - PROCESS | 12409 | _x_x_mozilla_page_load 07:29:47 INFO - PROCESS | 12409 | _x_x_mozilla_page_load_details 07:29:47 INFO - PROCESS | 12409 | |i|pagename|runs| 07:29:47 INFO - PROCESS | 12409 | |0;ai-astar;112;106;109;114;110;111;110;114;109;110 07:29:47 INFO - PROCESS | 12409 | |1;audio-beat-detection;156;133;153;182;127;157;161;136;185;126 07:29:47 INFO - PROCESS | 12409 | |2;audio-dft;162;161;161;161;167;168;164;163;165;162 07:29:47 INFO - PROCESS | 12409 | |3;audio-fft;75;74;78;161;76;74;75;75;167;76 07:29:47 INFO - PROCESS | 12409 | |4;audio-oscillator;85;85;147;90;85;86;142;86;85;146 07:29:47 INFO - PROCESS | 12409 | |5;imaging-gaussian-blur;119;117;117;118;117;117;118;118;118;119 07:29:47 INFO - PROCESS | 12409 | |6;imaging-darkroom;148;147;147;147;147;147;146;147;147;147 07:29:47 INFO - PROCESS | 12409 | |7;imaging-desaturate;97;98;95;95;95;95;95;96;95;96 07:29:47 INFO - PROCESS | 12409 | |8;json-parse-financial;57;54;54;52;54;54;54;54;53;53 07:29:47 INFO - PROCESS | 12409 | |9;json-stringify-tinderbox;65;64;63;63;64;65;63;63;64;63 07:29:47 INFO - PROCESS | 12409 | |10;stanford-crypto-aes;80;81;80;81;86;83;82;88;102;86 07:29:47 INFO - PROCESS | 12409 | |11;stanford-crypto-ccm;125;130;130;121;129;121;135;133;139;138 07:29:47 INFO - PROCESS | 12409 | |12;stanford-crypto-pbkdf2;161;164;161;166;161;167;164;158;159;161 07:29:47 INFO - PROCESS | 12409 | |13;stanford-crypto-sha256-iterative;64;64;64;63;64;63;65;62;65;61 07:29:47 INFO - PROCESS | 12409 | __end_tp_report 07:29:47 INFO - PROCESS | 12409 | __start_cc_report 07:29:47 INFO - PROCESS | 12409 | _x_x_mozilla_cycle_collect,892 07:29:47 INFO - PROCESS | 12409 | __end_cc_report 07:29:47 INFO - PROCESS | 12409 | __startTimestamp1466173787956__endTimestamp 07:29:47 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | ------- Summary: start ------- 07:29:47 INFO - PROCESS | 12409 | Number of tests: 14 07:29:47 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | [#0] ai-astar Cycles:10 Average:110.50 Median:110.50 stddev:2.42 (2.2%) stddev-sans-first:2.50 07:29:47 INFO - PROCESS | 12409 | Values: 112.0 106.0 109.0 114.0 110.0 111.0 110.0 114.0 109.0 110.0 07:29:47 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:156.50 stddev:21.16 (13.5%) stddev-sans-first:22.38 07:29:47 INFO - PROCESS | 12409 | Values: 156.0 133.0 153.0 182.0 127.0 157.0 161.0 136.0 185.0 126.0 07:29:47 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:2.55 (1.6%) stddev-sans-first:2.65 07:29:47 INFO - PROCESS | 12409 | Values: 162.0 161.0 161.0 161.0 167.0 168.0 164.0 163.0 165.0 162.0 07:29:47 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.00 stddev:37.41 (49.9%) stddev-sans-first:39.10 07:29:47 INFO - PROCESS | 12409 | Values: 75.0 74.0 78.0 161.0 76.0 74.0 75.0 75.0 167.0 76.0 07:29:47 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:85.00 stddev:28.57 (33.6%) stddev-sans-first:29.49 07:29:47 INFO - PROCESS | 12409 | Values: 85.0 85.0 147.0 90.0 85.0 86.0 142.0 86.0 85.0 146.0 07:29:47 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 07:29:47 INFO - PROCESS | 12409 | Values: 119.0 117.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 119.0 07:29:47 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 07:29:47 INFO - PROCESS | 12409 | Values: 148.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 07:29:47 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.50 stddev:1.06 (1.1%) stddev-sans-first:1.01 07:29:47 INFO - PROCESS | 12409 | Values: 97.0 98.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 07:29:47 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.29 (2.4%) stddev-sans-first:0.73 07:29:47 INFO - PROCESS | 12409 | Values: 57.0 54.0 54.0 52.0 54.0 54.0 54.0 54.0 53.0 53.0 07:29:47 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 07:29:47 INFO - PROCESS | 12409 | Values: 65.0 64.0 63.0 63.0 64.0 65.0 63.0 63.0 64.0 63.0 07:29:47 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:82.50 stddev:6.62 (8.0%) stddev-sans-first:6.78 07:29:47 INFO - PROCESS | 12409 | Values: 80.0 81.0 80.0 81.0 86.0 83.0 82.0 88.0 102.0 86.0 07:29:47 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:131.50 stddev:6.38 (4.9%) stddev-sans-first:6.50 07:29:47 INFO - PROCESS | 12409 | Values: 125.0 130.0 130.0 121.0 129.0 121.0 135.0 133.0 139.0 138.0 07:29:47 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:162.50 stddev:2.94 (1.8%) stddev-sans-first:3.08 07:29:47 INFO - PROCESS | 12409 | Values: 161.0 164.0 161.0 166.0 161.0 167.0 164.0 158.0 159.0 161.0 07:29:47 INFO - PROCESS | 12409 | 07:29:47 INFO - PROCESS | 12409 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.27 (2.0%) stddev-sans-first:1.33 07:29:47 INFO - PROCESS | 12409 | Values: 64.0 64.0 64.0 63.0 64.0 63.0 65.0 62.0 65.0 61.0 07:29:47 INFO - PROCESS | 12409 | -------- Summary: end -------- 07:29:47 INFO - PROCESS | 12409 | 07:29:48 INFO - TEST-INFO | 12409: exit 0 07:29:49 INFO - TEST-OK | kraken | took 62577ms 07:29:49 INFO - SUITE-END | took 1174s 07:29:49 INFO - Completed test suite (00:19:34) 07:29:49 INFO - javascript benchmark 07:29:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7230.732468093127, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2983.149802306343, 2999.9850000750007, 3023.2441889527618, 3109.7201251887327, 3133.5769671094395, 5268.05175068487, 5338.3860856001575, 5347.973260133699, 5417.160340147274, 5436.646617969829, 5295.947040529593, 5370.838874833751, 5393.73031348433, 5422.48486393793, 5496.532794712454, 4817.951820481785, 4868.5131486851205, 4937.407511098673, 4982.427020892589, 5038.521340472667, 667.5237113116017, 4850.151223535885, 4856.732879691615, 4897.2898929655175, 4952.479989601094, 4956.058348913695, 4962.454130045692, 4977.477364876672, 4984.750762461862, 4996.700197988114, 4996.650234483587, 5008.54923056923, 5015.3730783652045, 5017.974910125463, 5031.647784655075, 4873.780679869415, 4893.4617192108835, 4928.827491037832, 4944.752762361867, 4959.776810043557, 5362.892742145174, 5405.459454054602, 5438.0, 5445.482679145475, 5446.673199608036, 5611.579131565149, 5714.057180565202, 5788.710564471801, 5788.913166302509, 5807.128930660392, 5780.335261444946, 5824.708764561755, 5830.82507524775, 5841.474267315962, 5911.261092363455, 5283.762230699628, 5313.3092697949405, 5323.334583177103, 5333.333333333333, 5340.759665815048, 5818.679972601463, 5943.524518038546, 5952.464278214981, 5952.821415357546, 5959.910601340984, 5700.743466543932, 5708.857278568069, 5711.057675483498, 5715.599908006483, 5719.628224165416, 5860.355360910296, 5863.501602363762, 5864.67744274069, 5872.148538461899, 5878.0, 5726.0, 5777.653340799566, 5799.333076696234, 5827.912581311284, 5839.970800145972, 5777.480026797609, 5805.042168042226, 5815.941840581625, 5850.210221620112, 5870.3249126350165, 4359.694821362475, 4498.955010449919, 4521.3896124023495, 4527.47933987589, 4540.909181816345, 3910.3743401056263, 3954.307996100671, 3956.050547868491, 3976.940345894814, 4021.738586991836, 5449.155380915964, 5492.615516913777, 5504.2018907258225, 5548.944510554924, 5561.054620714488, 5607.52336051432, 5850.210221620112, 5861.062230043258, 5865.442782935615, 5869.530437564985, 5555.166724991283, 5586.078297080936, 5599.160125981135, 5626.043572592587, 5631.521320687705, 4978.203487442064, 5042.193249080129, 5050.444451110375, 5054.393472783216, 5107.310513080686, 5787.681677507778, 5919.911201331984, 6062.727177277033, 6083.087536869505, 6123.540734444934, 5749.913751293734, 5761.769529218785, 5809.2738407699035, 5814.5348372130975, 5833.416658334302, 6037.09443583466, 6046.183765191643, 6047.758089676539, 6057.273127224761, 6064.514838812973, 5515.200295956984, 5719.456651618089, 5734.5125664319, 5748.109043098327, 5775.653460792366, 5899.410058994066, 5902.852428689317, 5909.113632955091, 5920.911186332122, 5969.0, 5679.801206957736, 5690.0, 5690.061139911868, 5696.772129114955, 5738.311402631711, 5398.9190162146815, 5552.333719953632, 5593.244911936837, 5619.494245517923, 5669.54643628517, 5521.309836270466, 5557.5553955682635, 5561.63849349791, 5576.665400076008, 5585.581081418829, 5593.272874526286, 5694.772209111589, 5710.857228569319, 5713.542916566747, 5731.627444216113, 5437.238786569963, 5507.669539827623, 5559.19391688211, 5636.323641163087, 5677.1768093627015], "value": 5318.149319868805, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.6614615865084, 601.9736349524061, 616.5961295351547, 620.7206756959366, 635.783833496611, 38783.22433551331, 40566.0, 43229.0, 43569.7821510892, 43616.563834361645, 44457.0, 45077.77461112698, 45148.3227751584, 45347.319790203175, 45662.315065274044, 8918.197362237397, 8963.507007114606, 9023.511120665082, 9023.864642030374, 9100.317476189279, 8791.692290769824, 8876.334274929373, 8898.110188981114, 8922.509261990588, 8965.462072275652, 8984.0, 8989.37074404792, 8996.460212387277, 9002.234810041155, 9016.77458063547, 8917.55412229386, 8949.060348663394, 8984.685536006275, 8993.685221017266, 9008.954955225181, 8820.691275805317, 8865.911340886638, 8874.556272186364, 8887.333449991213, 8912.064233255545, 34204.48693269603, 42068.579314207076, 42604.78697606523, 42717.78641106805, 42929.57070429287, 3305.752068594865, 3617.8371973261264, 3668.8715894943816, 3856.3058649443087, 4249.617534421917, 31120.0, 31332.843335783404, 31469.8426507866, 31605.367892642247, 32457.350852983043, 4036.112055347848, 4171.812268447897, 4180.393842892763, 4180.561041090703, 4205.537390887031, 290118.0, 291166.0, 292255.0, 292356.07329450164, 292479.53760231275, 34818.30363392718, 35155.296894061976, 35228.82385588055, 35326.82336588352, 35418.0, 35635.28729425397, 36290.45564316538, 36377.0, 38591.0, 38768.22463550713, 17607.295708171787, 17696.203670834584, 17739.556511087325, 17748.023858687895, 17827.643447131246, 13503.527376541773, 13522.459101635824, 13550.59348219555, 13649.044566880422, 13658.0, 19825.20699172017, 19832.801671983383, 19866.70199947002, 19925.402237932885, 20029.198832046553, 7349.889751653729, 7388.593627350439, 7400.888986665097, 7472.626368681545, 7486.213947535539, 971.621067783565, 1036.491904279272, 1066.9253152279266, 1091.4651820607844, 1101.3942331717524, 32452.83773581164, 32540.83729581337, 32660.18349541233, 33078.17304567405, 33312.3337533248, 1095.370162156763, 1136.7385501334738, 1175.9823602645968, 1177.735009622828, 1183.3728124094243, 17012.82987170137, 17174.914125429543, 17290.740638890427, 17319.0, 17587.29650813953, 154903.0, 155965.0, 156630.0, 156742.0, 520031.0, 59464.702676487206, 59469.405305946384, 59534.40465595289, 59817.0, 59922.101168482506, 1324.913880597758, 1340.9798853017212, 1357.2060344698264, 1361.3737680666807, 1363.1616555817902, 31116.0, 31997.84001080073, 32416.0, 32453.51319730159, 32637.836810815796, 52394.476055238956, 52453.7377313111, 52987.470125298256, 53115.46884531105, 53148.20277695915, 401497.0, 409681.41911485407, 410087.0, 411436.0, 411828.0, 28592.71407285984, 28647.57028644614, 29047.419051619272, 29077.563836542045, 29183.124506264845, 49297.0, 49836.501634984634, 49864.0, 50056.0, 51417.742911285204, 40896.18207635771, 41811.37282940697, 41841.0, 42224.15551688887, 43332.566674332855, 40928.386074209506, 41138.0, 41670.37494437525, 42014.36978445265, 42178.0, 40926.795366022976, 41469.79265103655, 41526.0, 41569.0, 41926.58073419227, 34941.30117397587, 37167.814160929025, 37684.43473347847, 37811.62188378081, 37828.81085594554, 27603.58594621042, 28010.579841301987, 28170.0, 28288.434231314848, 28401.715982839905], "value": 19246.095257919525, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.4650586091165, 382.2145491015961, 385.5835697446758, 391.1141265034695, 399.81009020715163, 17525.561860953465, 19024.334148304828, 19360.3223887164, 19467.707984380228, 19646.70529942052, 17728.290868365282, 18000.729989050174, 18502.444926652188, 18525.722114168297, 18753.7186942196, 5596.748146333414, 5756.194132821408, 5828.591998560102, 5859.238299021121, 5867.207926929874, 5674.205611214413, 5712.371639119693, 5767.42325767422, 5768.826935191951, 5829.067349224125, 5755.82732518023, 5802.9844777164035, 5806.44838740319, 5818.912716309259, 5834.387389324123, 5697.857553561153, 5791.391903850077, 5801.9129713054335, 5832.445917637818, 5833.737481813308, 4927.950720492785, 5139.383274007106, 5139.640225184238, 5142.537171654569, 5167.715775632339, 22950.77049229503, 23031.30906072804, 23262.0, 23492.177773778007, 23639.527209455886, 2385.153270588933, 2417.1539961013505, 2570.344562136662, 2824.449232399683, 3093.752499800033, 14114.717705645933, 14426.855731442656, 14958.177300248482, 15065.171415572138, 15268.541943741706, 1975.3876298347413, 2000.4398768344886, 2042.1831267492973, 2057.1360028787944, 2057.989710051455, 54589.727051364884, 56694.716526417105, 65573.99999999952, 67193.66403168002, 79038.0, 10138.239632027628, 10511.789764204674, 10598.788024239471, 10606.416647084485, 10818.837717434244, 14793.633018716953, 14864.331105100297, 14893.70212595742, 14928.925355373154, 14932.40270389194, 8136.674533018731, 8477.74566762998, 8510.617022234015, 8522.659093636184, 8562.871556926651, 8242.340612750966, 8368.414211005293, 8370.455920365157, 8375.036870759819, 8459.788505287293, 6620.5034622402545, 6662.700178491979, 6730.461563074942, 6742.83142921421, 6834.350736680008, 1807.8372946434883, 1885.0951543259312, 1923.2979962313655, 1942.6406114868794, 1955.1592815089648, 902.7517432705927, 950.5579905344048, 1009.6718566465928, 1108.14672702019, 1135.5798354608849, 19076.33232836844, 19701.901490492455, 19997.0, 19998.800011999985, 20362.898185508977, 947.4457442396275, 985.0199051943363, 1015.4719545836124, 1028.7736697926443, 1047.1256500821898, 11129.499172537255, 11474.196806223652, 11538.942305288589, 11677.190035544505, 11686.941565292289, 407452.0, 408491.0, 421248.0, 421956.0, 422985.0, 50666.0, 51668.0, 68130.0, 79018.6049069751, 83126.58436707899, 1006.8338724110587, 1018.6791160784329, 1025.4718819807806, 1028.3521381529738, 1029.5109822834095, 17284.222210000833, 17517.386891458736, 17730.290788368322, 17780.0, 18061.729074063638, 27436.17691469259, 33385.499217512246, 35277.0, 36506.0, 39344.0, 48754.26868596903, 50222.0, 51187.488125118274, 52055.219171713215, 52362.73818630882, 8360.205780450848, 8380.455270407649, 8443.535605541754, 8500.064992850657, 8619.956900215459, 12614.684632884251, 12616.87383126157, 12858.099933004974, 13978.580642580739, 14117.08238964464, 11659.417029148679, 12103.394830258276, 12404.0, 12543.435545400662, 12620.495180192689, 11513.42432878336, 11603.129765267808, 11619.419029048344, 12247.142700010914, 12401.441935112762, 12044.91595756386, 12285.324307163191, 12334.938325308316, 12392.690182745504, 12525.749485010067, 8100.392470564613, 8305.584720764058, 8450.0, 8468.153184681729, 8669.003064647646, 11630.76738465209, 11880.10899182582, 12087.697807554881, 12190.2076365036, 12539.184952978027], "value": 9223.50694462396, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.3058166789106, 1469.9853001469985, 1564.5306408077574, 1695.1608953567986, 1700.9489715308546, 7882.3300019498265, 8577.571121443927, 8664.653413863438, 9134.954325228382, 9144.628305754148, 8691.26124279437, 8891.688790892304, 8938.106189381058, 8958.596863141158, 8975.730728078168, 2305.9538809223804, 2310.803581695558, 2332.1371092695726, 2346.038124369009, 2348.6829278047417, 2265.2524666859895, 2285.1887579909144, 2316.918907838226, 2319.9884000579973, 2321.2688003279, 2274.590573696734, 2288.702468679069, 2297.1041293895396, 2299.6895419118455, 2304.7349554801162, 2183.3122566391617, 2188.1684959715367, 2197.3627647982066, 2201.6477363621825, 2214.5128071824174, 2225.3101538522947, 2241.865488070721, 2243.8204943604474, 2248.730152381708, 2252.8535645183174, 8848.115188481164, 8986.685466008723, 9005.054469280696, 9009.279257659371, 9012.233960113399, 5211.24436956643, 5304.071787437221, 5304.814331498417, 5316.255724198615, 5316.441773613754, 3148.401803657298, 3217.3404452087266, 3354.127926739041, 3396.83015849209, 3423.4864770284407, 1062.054771253585, 1067.530286673861, 1075.3762817565794, 1078.4392116099664, 1083.7236504691332, 12190.695232619168, 12231.0, 12235.0, 12277.815832762604, 12331.321777302244, 4619.422572178478, 4634.165850146938, 4745.691530050535, 4779.235322348477, 4794.328793968847, 10316.535755890853, 10362.015608517178, 10375.481225938673, 10396.532156052996, 10409.895901040893, 5332.626716129834, 5351.474829673524, 5356.839294821161, 5380.24676545284, 5381.623286369995, 4437.667174961826, 4721.079389519011, 4852.393450818648, 4915.508449155127, 4933.45731969483, 3972.66232370246, 3986.242613903349, 4089.7137200396282, 4096.487939007624, 4229.238737027303, 1255.1966741285585, 1279.9424025918856, 1281.0008193609, 1289.3875409180564, 1310.5740634293702, 937.1471960516034, 953.4565297780199, 961.7355227312405, 972.1930797438109, 992.4987881119988, 5693.28833895763, 5837.0, 5843.474087332161, 5863.648181109147, 6046.244219472566, 444.4466639034358, 445.42317698580416, 448.1887783112577, 450.22561194744986, 458.09526185783477, 3879.8836034919, 3904.2777086239134, 3936.4292177634084, 3966.0283230608684, 4026.0, 10499.842502362471, 10682.51928663212, 10942.343459392461, 10974.615888444026, 11352.829707554394, 10978.0, 11112.61105861307, 11118.944405277922, 11154.442277886235, 11251.381174035343, 8166.877496837552, 8326.0, 8376.869122668362, 8390.077091519928, 8409.789755256168, 5897.439743224387, 6001.969990150022, 6026.186464827192, 6054.091886217103, 6068.575199735976, 10046.899531004889, 10215.846762298721, 10417.479126043516, 10478.685639430829, 10515.894841051491, 9898.703038908845, 10050.49747512636, 10125.038121378457, 10140.949295253771, 10165.186785057325, 7046.894296585658, 7630.1606823248285, 7827.373810095292, 7858.921410785819, 7968.601569921365, 8714.172153645393, 8734.126587341216, 8783.604737786944, 8787.956060219658, 8808.0, 7643.5796031218815, 7657.1959944205055, 7789.5715735635085, 7881.527108373516, 8196.754097377088, 7884.645190966535, 7925.960370198112, 7933.563653999086, 7938.801529961797, 8067.798305042186, 7038.085048943604, 7112.57324560528, 7148.142222933281, 7201.495895287279, 7202.567845929261, 4845.95154048455, 5129.102407078672, 5143.5113664201845, 5223.45153758865, 5276.023935571931, 5049.64652474338, 5143.074246635641, 5167.0, 5381.946180538144, 5472.91790623149], "value": 4554.376664293884, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.65122411674804, 312.210108425683, 312.8123126124327, 313.6972821227515, 319.2258772476743, 5634.3520495143075, 5644.74598643061, 5681.7784176402065, 5713.314402271728, 5726.455986681259, 5489.368722596902, 5526.198701188326, 5548.611597188198, 5551.250581171541, 5553.972230138854, 4124.835006599732, 4134.607212314825, 4228.133232687307, 4246.851360202393, 4254.97872510637, 4213.5786421357925, 4235.703500754948, 4265.914681706364, 4277.080427708042, 4287.8070486828165, 4211.136716973013, 4237.8304867805255, 4247.384129301249, 4255.5957184067465, 4257.638100761439, 4075.940255533568, 4272.380504826814, 4299.978500107511, 4300.397944287803, 4303.505096913848, 3679.5768486624115, 3715.5912849586525, 3730.5896351401325, 3760.8683696070507, 3767.190054138346, 5405.486478784548, 5426.480585436084, 5431.619786614939, 5452.945470545284, 5467.781288748445, 4844.539768721966, 4884.3650325457465, 4891.730954797485, 4894.143524883131, 4947.332110165154, 5755.0, 5767.298646899175, 5768.711564421804, 5777.306723193202, 5785.508231800302, 4080.224757296104, 4094.1402305515876, 4101.46680931477, 4111.814968326433, 4126.360414135814, 5870.589058765888, 6072.635641861502, 6076.817695469143, 6078.969605151946, 6193.6903154842075, 4182.937255941163, 4201.789910504463, 4216.388623649615, 4241.0, 4247.341662042389, 4221.155768846243, 4255.702100852911, 4273.829046838154, 4284.757420348126, 4285.357196420562, 4646.465656449484, 4895.339129217581, 4901.828436004723, 4907.582855457326, 4938.530839570235, 5798.159266906359, 5836.358000619928, 5862.70686465675, 5875.9118613220835, 5886.321723615744, 1490.2250829568563, 1518.6203449137715, 1519.4909705248865, 1520.7566789313657, 1525.8321584625905, 955.6989548292405, 982.8378317577663, 982.9901700982898, 994.2046362909643, 1020.3826684855555, 5650.152477128464, 5660.179274005246, 5668.044524638993, 5674.716264186856, 5680.403557626472, 5917.289925208916, 5958.523318134538, 5964.284285885635, 5983.640981541122, 6020.638761674313, 5396.109641909041, 5637.915431268534, 5729.828105156852, 5747.712614369349, 5797.710114494258, 3218.452863013293, 3218.645948945661, 3240.4167249895245, 3246.026192142348, 3250.398676244902, 6071.180390647206, 6245.375462453719, 6252.437280644764, 6305.180326557518, 6329.3987071229085, 6171.13604095427, 6202.751889924442, 6241.34465881085, 6241.750329986749, 6260.874782504325, 5980.372060933626, 6295.213098362705, 6330.651814150266, 6351.2060992375955, 6362.491000719931, 6066.241719785027, 6084.7222083362985, 6101.237345331833, 6118.847028824315, 6135.233095863017, 5992.790252341147, 6010.699465026819, 6051.606645568024, 6052.636841789331, 6064.120702498201, 6018.21763170785, 6228.875422491616, 6246.718897649707, 6255.874882502416, 6284.685765711788, 4230.450041494709, 4260.657892763769, 4279.529251782364, 4304.460368382669, 4305.3111502160755, 5879.412058794086, 5896.64620122794, 6094.146819445193, 6135.417135372132, 6139.324674285915, 5784.2769653793275, 5813.82558523245, 5823.70881455934, 5854.121881717776, 5885.47030767233, 5737.368889422077, 5846.0, 5846.129238643593, 5861.505316144356, 5872.412758724094, 5539.335279766454, 5694.206325007609, 5706.8573285666525, 5729.0, 5762.711864406847, 5763.884722305615, 5860.238169037998, 5900.970495147497, 5943.970280148572, 5963.73163207648, 5544.916826247529, 5805.796797112081, 5806.44838740319, 5819.447152520504, 5833.737481813413], "value": 4439.77694520883, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.9784606461808, 778.5912395992103, 810.0195023168354, 830.2859540794917, 831.604987630875, 15280.92359538202, 16094.1952902355, 16103.194840257998, 16286.674266514678, 16470.91764541177, 14805.185714785683, 14906.776398354006, 14975.400983960655, 14993.325300361483, 15003.099814011168, 655.158121813471, 764.4763337114094, 788.6451097006342, 789.3961119743401, 791.2799352589145, 766.9539827610333, 773.4315278270467, 782.3662833105175, 782.538302401583, 788.2550989315099, 835.7158566087529, 841.1672444280149, 845.2603971524916, 845.6955496021427, 847.4406891451644, 834.7787836223406, 839.093778718982, 839.7228914458215, 841.3269384492443, 842.3135144856922, 603.6740160313426, 608.5223099866583, 610.4079043327964, 612.9417705318032, 614.5145335185198, 14684.0, 14781.187034713086, 14802.333894974752, 14849.777253341208, 14863.0, 15097.698046039128, 15342.846571534365, 15544.76682849758, 15595.688086238326, 15757.68484630301, 12239.938800305941, 12245.755084898341, 12289.754204915851, 12495.687607809787, 12699.428525716365, 3806.8210107045056, 3888.319544079803, 3936.940945885814, 3955.0310174007263, 4019.155977244782, 73797.63101184514, 74244.0, 74621.99999999946, 74801.25198748051, 74865.62567187184, 11919.3444360561, 11971.401429928643, 11998.64004079879, 12265.26408415498, 12473.189242699196, 22285.440019198824, 22450.887745561493, 22493.32520024402, 22580.887095564416, 22991.770082298965, 8972.102789721106, 8973.416727912665, 8989.865152022725, 9019.0, 9204.355695101278, 4816.397950256218, 4852.078105160008, 4924.901501969941, 4999.900001999939, 5052.646314758005, 3677.9448308275396, 3711.4432835074954, 3748.325301445766, 3808.2383523295453, 3818.59904710007, 619.603453789575, 620.1999420747276, 633.7306644675995, 634.7334119669749, 647.1166857239833, 702.8945658151318, 713.6717110129294, 716.9641517924083, 721.4228617106294, 725.0863911471479, 9094.59074341643, 9737.415755054719, 10045.543396207655, 10233.48832558369, 10492.16062714981, 632.686820024091, 654.715198888485, 669.146837781832, 684.5447777228187, 717.1000394504968, 4811.422629284508, 4948.208286674115, 4971.304017437562, 4983.476734942778, 5046.84859454217, 67507.66246168737, 67686.0, 67729.66135169292, 68109.65945170242, 73430.0, 98617.50691246497, 104387.0, 104410.47794761129, 104470.0, 105509.47245263879, 55657.44342556522, 67378.32621673819, 70970.0, 83569.99999999878, 88930.0, 9333.25333973294, 9672.95163524178, 9736.0, 9775.560099795384, 9855.162311203341, 54231.72884135554, 54884.0, 55980.6004849882, 56048.719756400955, 57134.142987854386, 75414.62292688501, 80960.59519702599, 81407.59296203482, 81721.0, 81899.0, 12311.384430778246, 12313.692157696129, 12452.688682783002, 12653.620391388273, 12964.52912790386, 13762.862371376157, 13828.86171138316, 13846.515371961934, 13936.432760808708, 14004.159750415009, 12929.54746583865, 12979.870201298243, 13104.344782761014, 13323.800142997668, 13730.45078196901, 12444.56444024491, 12921.612351629467, 12981.286029268482, 13130.934345328213, 13233.801492977806, 12605.810912836132, 12610.18231409, 12954.326229850718, 13076.934615326862, 13186.0, 10626.0, 11031.33061558505, 11060.0, 11157.66527004191, 11439.59961401347, 10975.725606859573, 11176.385298808644, 11185.0, 11384.203105782515, 11463.598774042868], "value": 7486.215202842921, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 109.0, 114.0, 110.0, 111.0, 110.0, 114.0, 109.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 133.0, 153.0, 182.0, 127.0, 157.0, 161.0, 136.0, 185.0, 126.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 167.0, 168.0, 164.0, 163.0, 165.0, 162.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 78.0, 161.0, 76.0, 74.0, 75.0, 75.0, 167.0, 76.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 147.0, 90.0, 85.0, 86.0, 142.0, 86.0, 85.0, 146.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 119.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 54.0, 52.0, 54.0, 54.0, 54.0, 54.0, 53.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 63.0, 64.0, 65.0, 63.0, 63.0, 64.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 81.0, 86.0, 83.0, 82.0, 88.0, 102.0, 86.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 130.0, 130.0, 121.0, 129.0, 121.0, 135.0, 133.0, 139.0, 138.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 161.0, 166.0, 161.0, 167.0, 164.0, 158.0, 159.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 65.0, 62.0, 65.0, 61.0], "value": 63.5, "unit": "score"}]}]} 07:29:49 INFO - Return code: 0 07:29:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:29:49 ERROR - # TBPL SUCCESS # 07:29:49 INFO - Running post-action listener: _resource_record_post_action 07:29:49 INFO - ##### 07:29:49 INFO - ##### Finished run-tests step (success) 07:29:49 INFO - ##### 07:29:49 INFO - Running post-run listener: _resource_record_post_run 07:29:49 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 549163008; Read time: 372; Write time: 615688 07:29:49 INFO - TinderboxPrint: CPU usage
13.5% 07:29:49 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 372 07:29:49 INFO - TinderboxPrint: I/O write bytes / time
549,163,008 / 615,688 07:29:49 INFO - TinderboxPrint: CPU idle
8,226.3 (86.5%) 07:29:49 INFO - TinderboxPrint: CPU user
1,223.9 (12.9%) 07:29:49 INFO - TinderboxPrint: Swap in / out
0 / 0 07:29:49 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 262111232; Read time: 176; Write time: 392752 07:29:49 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 287051776; Read time: 196; Write time: 222936 07:29:49 INFO - Running post-run listener: _upload_blobber_files 07:29:49 INFO - Blob upload gear active. 07:29:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:29:49 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 07:29:49 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'] 07:29:49 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 07:29:50 INFO - (blobuploader) - INFO - Open directory for files ... 07:29:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:29:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:29:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:54 INFO - (blobuploader) - INFO - Done attempting. 07:29:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:29:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:29:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:55 INFO - (blobuploader) - INFO - Done attempting. 07:29:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:29:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:29:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:29:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:29:56 INFO - (blobuploader) - INFO - Done attempting. 07:29:56 INFO - (blobuploader) - INFO - Iteration through files over. 07:29:56 INFO - Return code: 0 07:29:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:29:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:29:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/528577df7ad17b9bf12fb35736ce2ede26bf2922aa1577f263be8f758989f136732df26df5d3efb98e8afa0cdbcc3f308f84da6cbac61e6c1631eab7e78c35be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/179215cf677ece403f748e1f72be72b8cae4b48071bedc3c18578edaddafefabcff745a5505928fbec1eba70592e0a86540be13788a831e2713402bfe12c2567", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f968bfc736a7e7250b97becd395fb915cf492e5158511c970624c1fdd51341419120dcefd26385387dd62f7a0c0e29fc65021f40f9e9f019a78748706e75ba2e"} 07:29:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:29:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:29:56 INFO - Contents: 07:29:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/528577df7ad17b9bf12fb35736ce2ede26bf2922aa1577f263be8f758989f136732df26df5d3efb98e8afa0cdbcc3f308f84da6cbac61e6c1631eab7e78c35be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/179215cf677ece403f748e1f72be72b8cae4b48071bedc3c18578edaddafefabcff745a5505928fbec1eba70592e0a86540be13788a831e2713402bfe12c2567", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f968bfc736a7e7250b97becd395fb915cf492e5158511c970624c1fdd51341419120dcefd26385387dd62f7a0c0e29fc65021f40f9e9f019a78748706e75ba2e"} 07:29:56 INFO - Running post-run listener: copy_logs_to_upload_dir 07:29:56 INFO - Copying logs to upload dir... 07:29:56 INFO - mkdir: /builds/slave/test/build/upload/logs 07:29:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.458145 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-17 07:29:56.065670) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 07:29:56.069709) ========= 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=cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342 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/528577df7ad17b9bf12fb35736ce2ede26bf2922aa1577f263be8f758989f136732df26df5d3efb98e8afa0cdbcc3f308f84da6cbac61e6c1631eab7e78c35be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/179215cf677ece403f748e1f72be72b8cae4b48071bedc3c18578edaddafefabcff745a5505928fbec1eba70592e0a86540be13788a831e2713402bfe12c2567", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f968bfc736a7e7250b97becd395fb915cf492e5158511c970624c1fdd51341419120dcefd26385387dd62f7a0c0e29fc65021f40f9e9f019a78748706e75ba2e"} build_url:https://queue.taskcluster.net/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/ZlyPRGS1SCKHvxu8kLnbUg/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/528577df7ad17b9bf12fb35736ce2ede26bf2922aa1577f263be8f758989f136732df26df5d3efb98e8afa0cdbcc3f308f84da6cbac61e6c1631eab7e78c35be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/179215cf677ece403f748e1f72be72b8cae4b48071bedc3c18578edaddafefabcff745a5505928fbec1eba70592e0a86540be13788a831e2713402bfe12c2567", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f968bfc736a7e7250b97becd395fb915cf492e5158511c970624c1fdd51341419120dcefd26385387dd62f7a0c0e29fc65021f40f9e9f019a78748706e75ba2e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 07:29:56.096355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 07:29:56.096707) ========= 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=cbe409c6de289db6ac707de3000001d4-1466172559.790233-223179342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 07:29:56.178624) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 07:29:56.178956) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 07:29:56.179300) ========= ========= Total master_lag: 0.17 =========