builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1465405057.07 results: success (0) buildid: 20160608071315 builduid: 2f74231857e54e4d872f371e682b3ef8 revision: f22cca9ad502563f7e15a5a44c4bf9d04ad2e87f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 09:57:37.068791) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 09:57:37.069322) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 09:57:37.069944) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 09:57:37.085668) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 09:57:37.086113) ========= 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=41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 09:57:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-06-08 09:57:37 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125443 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 09:57:37.226309) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 09:57:37.226671) ========= 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=41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017980 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 09:57:37.276970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 09:57:37.277405) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f22cca9ad502563f7e15a5a44c4bf9d04ad2e87f --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 f22cca9ad502563f7e15a5a44c4bf9d04ad2e87f --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=41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 09:57:37,460 truncating revision to first 12 chars 2016-06-08 09:57:37,460 Setting DEBUG logging. 2016-06-08 09:57:37,460 attempt 1/10 2016-06-08 09:57:37,460 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f22cca9ad502?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 09:57:38,492 unpacking tar archive at: mozilla-inbound-f22cca9ad502/testing/mozharness/ program finished with exit code 0 elapsedTime=1.373802 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 09:57:38.667396) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 09:57:38.668157) ========= script_repo_revision: f22cca9ad502563f7e15a5a44c4bf9d04ad2e87f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 09:57:38.669081) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 09:57:38.669766) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 09:57:38.680738) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-08 09:57:38.681154) ========= /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=41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:57:38 INFO - MultiFileLogger online at 20160608 09:57:38 in /builds/slave/test 09:57:38 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 09:57:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:57:38 INFO - {'append_to_log': False, 09:57:38 INFO - 'base_work_dir': '/builds/slave/test', 09:57:38 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:57:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:57:38 INFO - 'branch': 'Mozilla-Inbound', 09:57:38 INFO - 'buildbot_json_path': 'buildprops.json', 09:57:38 INFO - 'config_files': ('talos/linux_config.py',), 09:57:38 INFO - 'default_actions': ('clobber', 09:57:38 INFO - 'read-buildbot-config', 09:57:38 INFO - 'download-and-extract', 09:57:38 INFO - 'populate-webroot', 09:57:38 INFO - 'create-virtualenv', 09:57:38 INFO - 'install', 09:57:38 INFO - 'run-tests'), 09:57:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:57:38 INFO - 'download_minidump_stackwalk': True, 09:57:38 INFO - 'download_symbols': 'ondemand', 09:57:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:57:38 INFO - 'tooltool.py': '/tools/tooltool.py', 09:57:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:57:38 INFO - '/tools/misc-python/virtualenv.py')}, 09:57:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:57:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:57:38 INFO - 'installer_path': 'installer.exe', 09:57:38 INFO - 'log_level': 'info', 09:57:38 INFO - 'log_name': 'talos', 09:57:38 INFO - 'log_to_console': True, 09:57:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:57:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:57:38 INFO - 'opt_config_files': (), 09:57:38 INFO - 'pip_index': False, 09:57:38 INFO - 'sps_profile': False, 09:57:38 INFO - 'sps_profile_interval': 0, 09:57:38 INFO - 'suite': 'dromaeojs-e10s', 09:57:38 INFO - 'system_bits': '32', 09:57:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:57:38 INFO - 'title': 'talos-linux64-ix-026', 09:57:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:57:38 INFO - 'use_talos_json': True, 09:57:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:57:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:57:38 INFO - 'work_dir': 'build'} 09:57:38 INFO - ##### 09:57:38 INFO - ##### Running clobber step. 09:57:38 INFO - ##### 09:57:38 INFO - Running pre-action listener: _resource_record_pre_action 09:57:38 INFO - Running main action method: clobber 09:57:38 INFO - rmtree: /builds/slave/test/build 09:57:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:57:39 INFO - Running post-action listener: _resource_record_post_action 09:57:39 INFO - ##### 09:57:39 INFO - ##### Finished clobber step (success) 09:57:39 INFO - ##### 09:57:39 INFO - ##### 09:57:39 INFO - ##### Running read-buildbot-config step. 09:57:39 INFO - ##### 09:57:39 INFO - Running pre-action listener: _resource_record_pre_action 09:57:39 INFO - Running main action method: read_buildbot_config 09:57:39 INFO - Using buildbot properties: 09:57:39 INFO - { 09:57:39 INFO - "project": "", 09:57:39 INFO - "product": "firefox", 09:57:39 INFO - "script_repo_revision": "production", 09:57:39 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 09:57:39 INFO - "repository": "", 09:57:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 09:57:39 INFO - "buildid": "20160608071315", 09:57:39 INFO - "pgo_build": "True", 09:57:39 INFO - "basedir": "/builds/slave/test", 09:57:39 INFO - "buildnumber": 832, 09:57:39 INFO - "slavename": "talos-linux64-ix-026", 09:57:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:57:39 INFO - "platform": "ubuntu64_hw", 09:57:39 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:57:39 INFO - "branch": "mozilla-inbound", 09:57:39 INFO - "repo_path": "integration/mozilla-inbound", 09:57:39 INFO - "revision": "f22cca9ad502563f7e15a5a44c4bf9d04ad2e87f", 09:57:39 INFO - "stage_platform": "linux64-pgo", 09:57:39 INFO - "builduid": "2f74231857e54e4d872f371e682b3ef8", 09:57:39 INFO - "slavebuilddir": "test" 09:57:39 INFO - } 09:57:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:57:39 INFO - Running post-action listener: _resource_record_post_action 09:57:39 INFO - ##### 09:57:39 INFO - ##### Finished read-buildbot-config step (success) 09:57:39 INFO - ##### 09:57:39 INFO - ##### 09:57:39 INFO - ##### Running download-and-extract step. 09:57:39 INFO - ##### 09:57:39 INFO - Running pre-action listener: _resource_record_pre_action 09:57:39 INFO - Running main action method: download_and_extract 09:57:39 INFO - mkdir: /builds/slave/test/build/tests 09:57: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')]} 09:57:39 INFO - https://queue.taskcluster.net/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:57:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:57:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:57:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/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 09:57:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/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 09:57:40 INFO - Downloaded 1361 bytes. 09:57:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:57:40 INFO - Using the following test package requirements: 09:57:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:57:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:57:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:40 INFO - u'jsshell-linux-x86_64.zip'], 09:57:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:57:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:57:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:57:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:57:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:57:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:57:40 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')]} 09:57:40 INFO - https://queue.taskcluster.net/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:57:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:57:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:57:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/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 09:57:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/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 09:57:41 INFO - Downloaded 24450192 bytes. 09:57:41 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'] 09:57:41 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 09:57:42 INFO - Return code: 0 09:57:42 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 09:57: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')]} 09:57:42 INFO - https://queue.taskcluster.net/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:57:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:57:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:57:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/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 09:57:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/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 09:57:44 INFO - Downloaded 24450192 bytes. 09:57:44 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'] 09:57:44 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 09:57:45 INFO - Return code: 0 09:57: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')]} 09:57:45 INFO - https://queue.taskcluster.net/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:57:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/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 09:57:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/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 09:57:47 INFO - Downloaded 10833369 bytes. 09:57:47 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'] 09:57:47 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 09:57:47 INFO - Return code: 0 09:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:47 INFO - https://queue.taskcluster.net/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:57:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:57:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:57:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/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 09:57:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNiILmhyTqaPvgb1y4xOyw/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 09:57:48 INFO - Downloaded 59270824 bytes. 09:57:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:57:48 INFO - mkdir: /builds/slave/test/properties 09:57:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:57:48 INFO - Writing to file /builds/slave/test/properties/build_url 09:57:48 INFO - Contents: 09:57:48 INFO - build_url:https://queue.taskcluster.net/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:57:49 INFO - Running post-action listener: _resource_record_post_action 09:57:49 INFO - Running post-action listener: set_extra_try_arguments 09:57:49 INFO - ##### 09:57:49 INFO - ##### Finished download-and-extract step (success) 09:57:49 INFO - ##### 09:57:49 INFO - ##### 09:57:49 INFO - ##### Running populate-webroot step. 09:57:49 INFO - ##### 09:57:49 INFO - Running pre-action listener: _resource_record_pre_action 09:57:49 INFO - Running main action method: populate_webroot 09:57:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:49 INFO - '--tppagecycles', 09:57:49 INFO - '7'], 09:57:49 INFO - 'tests': ['tsvgm']}}, 09:57:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:57:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:57:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:57:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:57:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:57:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:49 INFO - 'talos_options': ['--disable-e10s'], 09:57:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:49 INFO - 'talos_options': ['--disable-e10s'], 09:57:49 INFO - 'tests': ['damp', 'tps']}, 09:57:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:49 INFO - 'tests': ['damp', 'tps']}, 09:57:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:57:49 INFO - 'tests': ['dromaeo_dom']}, 09:57:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:57:49 INFO - 'tests': ['a11yr', 09:57:49 INFO - 'ts_paint', 09:57:49 INFO - 'tpaint', 09:57:49 INFO - 'sessionrestore', 09:57:49 INFO - 'sessionrestore_no_auto_restore', 09:57:49 INFO - 'tabpaint']}, 09:57:49 INFO - 'other-e10s': {'tests': ['a11yr', 09:57:49 INFO - 'ts_paint', 09:57:49 INFO - 'tpaint', 09:57:49 INFO - 'sessionrestore', 09:57:49 INFO - 'sessionrestore_no_auto_restore', 09:57:49 INFO - 'tabpaint']}, 09:57:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:57:49 INFO - 'ts_paint', 09:57:49 INFO - 'tpaint', 09:57:49 INFO - 'sessionrestore', 09:57:49 INFO - 'sessionrestore_no_auto_restore', 09:57:49 INFO - 'tabpaint']}, 09:57:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:57:49 INFO - 'ts_paint', 09:57:49 INFO - 'tpaint', 09:57:49 INFO - 'sessionrestore', 09:57:49 INFO - 'sessionrestore_no_auto_restore', 09:57:49 INFO - 'tabpaint']}, 09:57:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:57:49 INFO - 'tests': ['a11yr', 09:57:49 INFO - 'ts_paint', 09:57:49 INFO - 'tpaint', 09:57:49 INFO - 'sessionrestore', 09:57:49 INFO - 'sessionrestore_no_auto_restore', 09:57:49 INFO - 'tabpaint']}, 09:57:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:57:49 INFO - 'tests': ['a11yr', 09:57:49 INFO - 'ts_paint', 09:57:49 INFO - 'tpaint', 09:57:49 INFO - 'sessionrestore', 09:57:49 INFO - 'sessionrestore_no_auto_restore', 09:57:49 INFO - 'tabpaint']}, 09:57:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:57:49 INFO - 'tests': ['tsvgx', 09:57:49 INFO - 'tsvgr_opacity', 09:57:49 INFO - 'tart', 09:57:49 INFO - 'tscrollx', 09:57:49 INFO - 'cart']}, 09:57:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:57:49 INFO - 'tsvgr_opacity', 09:57:49 INFO - 'tart', 09:57:49 INFO - 'tscrollx', 09:57:49 INFO - 'cart']}, 09:57:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:49 INFO - 'talos_options': ['--disable-e10s'], 09:57:49 INFO - 'tests': ['tp5o']}, 09:57:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:49 INFO - 'tests': ['tp5o']}, 09:57:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:49 INFO - 'talos_options': ['--disable-e10s', 09:57:49 INFO - '--xperf_path', 09:57:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:49 INFO - 'tests': ['tp5n']}, 09:57:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:49 INFO - 'talos_options': ['--xperf_path', 09:57:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:49 INFO - 'tests': ['tp5n']}}, 09:57:49 INFO - 'talos.zip': {'path': '', 09:57:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:49 INFO - Running post-action listener: _resource_record_post_action 09:57:49 INFO - ##### 09:57:49 INFO - ##### Finished populate-webroot step (success) 09:57:49 INFO - ##### 09:57:49 INFO - ##### 09:57:49 INFO - ##### Running create-virtualenv step. 09:57:49 INFO - ##### 09:57:49 INFO - Running pre-action listener: _resource_record_pre_action 09:57:49 INFO - Running main action method: create_virtualenv 09:57:49 INFO - Creating virtualenv /builds/slave/test/build/venv 09:57:49 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 09:57:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:57:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:49 INFO - Using real prefix '/usr' 09:57:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:57:50 INFO - Installing distribute.............................................................................................................................................................................................done. 09:57:52 INFO - Installing pip.................done. 09:57:52 INFO - Return code: 0 09:57:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:52 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 0x7f143830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce2e0>, '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 0x153a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153a5d0>, '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': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', '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 09:57:52 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 09:57:52 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 09:57:52 INFO - Using env: {'DISPLAY': ':0', 09:57:52 INFO - 'HOME': '/home/cltbld', 09:57:52 INFO - 'LANG': 'en_US.UTF-8', 09:57:52 INFO - 'LANGUAGE': 'en_US:en', 09:57:52 INFO - 'LOGNAME': 'cltbld', 09:57:52 INFO - 'MAIL': '/var/mail/cltbld', 09:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:52 INFO - 'MOZ_NO_REMOTE': '1', 09:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:52 INFO - 'NO_EM_RESTART': '1', 09:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:52 INFO - 'PWD': '/builds/slave/test', 09:57:52 INFO - 'SHELL': '/bin/bash', 09:57:52 INFO - 'SHLVL': '1', 09:57:52 INFO - 'TERM': 'linux', 09:57:52 INFO - 'TMOUT': '86400', 09:57:52 INFO - 'USER': 'cltbld', 09:57:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', 09:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:52 INFO - '_': '/tools/buildbot/bin/python'} 09:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:52 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 09:57:52 INFO - Cleaning up... 09:57:52 INFO - Return code: 0 09:57:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:52 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 0x7f143830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce2e0>, '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 0x153a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153a5d0>, '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': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', '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 09:57:52 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 09:57:52 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 09:57:52 INFO - Using env: {'DISPLAY': ':0', 09:57:52 INFO - 'HOME': '/home/cltbld', 09:57:52 INFO - 'LANG': 'en_US.UTF-8', 09:57:52 INFO - 'LANGUAGE': 'en_US:en', 09:57:52 INFO - 'LOGNAME': 'cltbld', 09:57:52 INFO - 'MAIL': '/var/mail/cltbld', 09:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:52 INFO - 'MOZ_NO_REMOTE': '1', 09:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:52 INFO - 'NO_EM_RESTART': '1', 09:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:52 INFO - 'PWD': '/builds/slave/test', 09:57:52 INFO - 'SHELL': '/bin/bash', 09:57:52 INFO - 'SHLVL': '1', 09:57:52 INFO - 'TERM': 'linux', 09:57:52 INFO - 'TMOUT': '86400', 09:57:52 INFO - 'USER': 'cltbld', 09:57:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', 09:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:52 INFO - '_': '/tools/buildbot/bin/python'} 09:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:52 INFO - Downloading/unpacking psutil>=3.1.1 09:57:52 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 09:57:52 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 09:57:52 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 09:57:52 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 09:57:52 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 09:57:52 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 09:57:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:54 INFO - Installing collected packages: psutil 09:57:54 INFO - Running setup.py install for psutil 09:57:54 INFO - building 'psutil._psutil_linux' extension 09:57:54 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 09:57:54 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 09:57:54 INFO - building 'psutil._psutil_posix' extension 09:57:54 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 09:57:54 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 09:57:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:55 INFO - Successfully installed psutil 09:57:55 INFO - Cleaning up... 09:57:55 INFO - Return code: 0 09:57:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:57:55 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')]} 09:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:55 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')]} 09:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:55 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 0x7f143830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce2e0>, '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 0x153a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153a5d0>, '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': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', '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 09:57:55 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 09:57:55 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 09:57:55 INFO - Using env: {'DISPLAY': ':0', 09:57:55 INFO - 'HOME': '/home/cltbld', 09:57:55 INFO - 'LANG': 'en_US.UTF-8', 09:57:55 INFO - 'LANGUAGE': 'en_US:en', 09:57:55 INFO - 'LOGNAME': 'cltbld', 09:57:55 INFO - 'MAIL': '/var/mail/cltbld', 09:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:55 INFO - 'MOZ_NO_REMOTE': '1', 09:57:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:55 INFO - 'NO_EM_RESTART': '1', 09:57:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:55 INFO - 'PWD': '/builds/slave/test', 09:57:55 INFO - 'SHELL': '/bin/bash', 09:57:55 INFO - 'SHLVL': '1', 09:57:55 INFO - 'TERM': 'linux', 09:57:55 INFO - 'TMOUT': '86400', 09:57:55 INFO - 'USER': 'cltbld', 09:57:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', 09:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:55 INFO - '_': '/tools/buildbot/bin/python'} 09:57:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:57:57 INFO - Installing collected packages: mozsystemmonitor 09:57:57 INFO - Running setup.py install for mozsystemmonitor 09:57:57 INFO - Successfully installed mozsystemmonitor 09:57:57 INFO - Cleaning up... 09:57:57 INFO - Return code: 0 09:57:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:57:57 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')]} 09:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:57 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')]} 09:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:57 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 0x7f143830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce2e0>, '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 0x153a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153a5d0>, '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': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', '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 09:57:57 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 09:57:57 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 09:57:57 INFO - Using env: {'DISPLAY': ':0', 09:57:57 INFO - 'HOME': '/home/cltbld', 09:57:57 INFO - 'LANG': 'en_US.UTF-8', 09:57:57 INFO - 'LANGUAGE': 'en_US:en', 09:57:57 INFO - 'LOGNAME': 'cltbld', 09:57:57 INFO - 'MAIL': '/var/mail/cltbld', 09:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:57 INFO - 'MOZ_NO_REMOTE': '1', 09:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:57 INFO - 'NO_EM_RESTART': '1', 09:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:57 INFO - 'PWD': '/builds/slave/test', 09:57:57 INFO - 'SHELL': '/bin/bash', 09:57:57 INFO - 'SHLVL': '1', 09:57:57 INFO - 'TERM': 'linux', 09:57:57 INFO - 'TMOUT': '86400', 09:57:57 INFO - 'USER': 'cltbld', 09:57:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', 09:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:57 INFO - '_': '/tools/buildbot/bin/python'} 09:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:57 INFO - Downloading/unpacking jsonschema==2.5.1 09:57:57 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 09:57:57 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 09:57:57 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 09:57:57 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 09:57:57 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 09:57:57 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 09:57:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:57:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:59 INFO - Downloading functools32-3.2.3-2.tar.gz 09:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:57:59 INFO - warning: no files found matching '*.txt' 09:57:59 INFO - no previously-included directories found matching 'build' 09:57:59 INFO - no previously-included directories found matching 'dist' 09:57:59 INFO - no previously-included directories found matching '.git*' 09:57:59 INFO - Installing collected packages: jsonschema, functools32 09:57:59 INFO - Running setup.py install for functools32 09:57:59 INFO - warning: no files found matching '*.txt' 09:57:59 INFO - no previously-included directories found matching 'build' 09:57:59 INFO - no previously-included directories found matching 'dist' 09:57:59 INFO - no previously-included directories found matching '.git*' 09:57:59 INFO - Successfully installed jsonschema functools32 09:57:59 INFO - Cleaning up... 09:57:59 INFO - Return code: 0 09:57:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f143830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce2e0>, '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 0x153a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153a5d0>, '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': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', '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 09:57:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:57:59 INFO - Using env: {'DISPLAY': ':0', 09:57:59 INFO - 'HOME': '/home/cltbld', 09:57:59 INFO - 'LANG': 'en_US.UTF-8', 09:57:59 INFO - 'LANGUAGE': 'en_US:en', 09:57:59 INFO - 'LOGNAME': 'cltbld', 09:57:59 INFO - 'MAIL': '/var/mail/cltbld', 09:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:59 INFO - 'MOZ_NO_REMOTE': '1', 09:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:59 INFO - 'NO_EM_RESTART': '1', 09:57:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:59 INFO - 'PWD': '/builds/slave/test', 09:57:59 INFO - 'SHELL': '/bin/bash', 09:57:59 INFO - 'SHLVL': '1', 09:57:59 INFO - 'TERM': 'linux', 09:57:59 INFO - 'TMOUT': '86400', 09:57:59 INFO - 'USER': 'cltbld', 09:57:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', 09:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:59 INFO - '_': '/tools/buildbot/bin/python'} 09:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:00 INFO - Downloading/unpacking blobuploader==1.2.4 09:58:00 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 09:58:00 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 09:58:00 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 09:58:00 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 09:58:00 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 09:58:00 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 09:58:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:58:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:58:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:58:02 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 09:58:02 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 09:58:02 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 09:58:02 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 09:58:02 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 09:58:02 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 09:58:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:58:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:58:02 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 09:58:02 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 09:58:02 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 09:58:02 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 09:58:02 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 09:58:02 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 09:58:02 INFO - Downloading docopt-0.6.1.tar.gz 09:58:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:58:02 INFO - Installing collected packages: blobuploader, requests, docopt 09:58:02 INFO - Running setup.py install for blobuploader 09:58:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:58:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:58:02 INFO - Running setup.py install for requests 09:58:03 INFO - Running setup.py install for docopt 09:58:03 INFO - Successfully installed blobuploader requests docopt 09:58:03 INFO - Cleaning up... 09:58:03 INFO - Return code: 0 09:58:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:03 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 0x7f143830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce2e0>, '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 0x153a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153a5d0>, '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': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', '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 09:58:03 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 09:58:03 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 09:58:03 INFO - Using env: {'DISPLAY': ':0', 09:58:03 INFO - 'HOME': '/home/cltbld', 09:58:03 INFO - 'LANG': 'en_US.UTF-8', 09:58:03 INFO - 'LANGUAGE': 'en_US:en', 09:58:03 INFO - 'LOGNAME': 'cltbld', 09:58:03 INFO - 'MAIL': '/var/mail/cltbld', 09:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:03 INFO - 'MOZ_NO_REMOTE': '1', 09:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:03 INFO - 'NO_EM_RESTART': '1', 09:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:03 INFO - 'PWD': '/builds/slave/test', 09:58:03 INFO - 'SHELL': '/bin/bash', 09:58:03 INFO - 'SHLVL': '1', 09:58:03 INFO - 'TERM': 'linux', 09:58:03 INFO - 'TMOUT': '86400', 09:58:03 INFO - 'USER': 'cltbld', 09:58:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', 09:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:03 INFO - '_': '/tools/buildbot/bin/python'} 09:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:03 INFO - Running setup.py (path:/tmp/pip-wwNPdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:03 INFO - Running setup.py (path:/tmp/pip-KFSNjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:03 INFO - Running setup.py (path:/tmp/pip-Gmfao2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:03 INFO - Running setup.py (path:/tmp/pip-MsYq_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:03 INFO - Running setup.py (path:/tmp/pip-4CHWrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:04 INFO - Running setup.py (path:/tmp/pip-iahYjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:04 INFO - Running setup.py (path:/tmp/pip-PCrwHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:04 INFO - Running setup.py (path:/tmp/pip-NNT_D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:04 INFO - Running setup.py (path:/tmp/pip-tDXEdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:04 INFO - Running setup.py (path:/tmp/pip-0rsXfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:04 INFO - Running setup.py (path:/tmp/pip-lGtVo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:04 INFO - Running setup.py (path:/tmp/pip-JIj6wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:04 INFO - Running setup.py (path:/tmp/pip-FoZ5qE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:04 INFO - Running setup.py (path:/tmp/pip-unqXlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:04 INFO - Running setup.py (path:/tmp/pip-MDqaBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:04 INFO - Running setup.py (path:/tmp/pip-e49K7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:04 INFO - Running setup.py (path:/tmp/pip-7eOeSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:58:04 INFO - Running setup.py install for manifestparser 09:58:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:58:04 INFO - Running setup.py install for mozcrash 09:58:05 INFO - Running setup.py install for mozdebug 09:58:05 INFO - Running setup.py install for mozdevice 09:58:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:58:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:58:05 INFO - Running setup.py install for mozfile 09:58:05 INFO - Running setup.py install for mozhttpd 09:58:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:58:05 INFO - Running setup.py install for mozinfo 09:58:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:58:05 INFO - Running setup.py install for mozInstall 09:58:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:58:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:58:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:58:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:58:05 INFO - Running setup.py install for mozleak 09:58:05 INFO - Running setup.py install for mozlog 09:58:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:58:05 INFO - Running setup.py install for moznetwork 09:58:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:58:05 INFO - Running setup.py install for mozprocess 09:58:06 INFO - Running setup.py install for mozprofile 09:58:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:58:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:58:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:58:06 INFO - Running setup.py install for mozrunner 09:58:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:06 INFO - Running setup.py install for mozscreenshot 09:58:06 INFO - Running setup.py install for moztest 09:58:06 INFO - Running setup.py install for mozversion 09:58:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:06 INFO - Cleaning up... 09:58:06 INFO - Return code: 0 09:58:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:06 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 0x7f143830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce2e0>, '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 0x153a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153a5d0>, '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': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', '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 09:58:06 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 09:58:06 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 09:58:06 INFO - Using env: {'DISPLAY': ':0', 09:58:06 INFO - 'HOME': '/home/cltbld', 09:58:06 INFO - 'LANG': 'en_US.UTF-8', 09:58:06 INFO - 'LANGUAGE': 'en_US:en', 09:58:06 INFO - 'LOGNAME': 'cltbld', 09:58:06 INFO - 'MAIL': '/var/mail/cltbld', 09:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:06 INFO - 'MOZ_NO_REMOTE': '1', 09:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:06 INFO - 'NO_EM_RESTART': '1', 09:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:06 INFO - 'PWD': '/builds/slave/test', 09:58:06 INFO - 'SHELL': '/bin/bash', 09:58:06 INFO - 'SHLVL': '1', 09:58:06 INFO - 'TERM': 'linux', 09:58:06 INFO - 'TMOUT': '86400', 09:58:06 INFO - 'USER': 'cltbld', 09:58:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', 09:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:06 INFO - '_': '/tools/buildbot/bin/python'} 09:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:06 INFO - Running setup.py (path:/tmp/pip-EXN8in-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:06 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)) 09:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:06 INFO - Running setup.py (path:/tmp/pip-k0uyHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:07 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)) 09:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:07 INFO - Running setup.py (path:/tmp/pip-GIl9hB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:07 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)) 09:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:07 INFO - Running setup.py (path:/tmp/pip-DB67BX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:07 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)) 09:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:07 INFO - Running setup.py (path:/tmp/pip-mJz2dS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:07 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)) 09:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:07 INFO - Running setup.py (path:/tmp/pip-Z70JGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:07 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)) 09:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:07 INFO - Running setup.py (path:/tmp/pip-biWWRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:07 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)) 09:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:07 INFO - Running setup.py (path:/tmp/pip-06JOzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:07 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)) 09:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:07 INFO - Running setup.py (path:/tmp/pip-E9pa_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:07 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)) 09:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:07 INFO - Running setup.py (path:/tmp/pip-6FnwjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:07 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)) 09:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:07 INFO - Running setup.py (path:/tmp/pip-mUlox9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:07 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)) 09:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:07 INFO - Running setup.py (path:/tmp/pip-lcmsUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:07 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)) 09:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:07 INFO - Running setup.py (path:/tmp/pip-UXA8hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:07 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)) 09:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:07 INFO - Running setup.py (path:/tmp/pip-gUjwJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:07 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)) 09:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:07 INFO - Running setup.py (path:/tmp/pip-HBnoYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:08 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)) 09:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:08 INFO - Running setup.py (path:/tmp/pip-3lGdcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:08 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)) 09:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:08 INFO - Running setup.py (path:/tmp/pip-t5mkI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:08 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)) 09:58:08 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)) 09:58:08 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)) 09:58:08 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)) 09:58:08 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)) 09:58:08 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)) 09:58:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:08 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 09:58:08 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 09:58:08 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 09:58:08 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 09:58:08 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 09:58:08 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 09:58:10 INFO - Downloading blessings-1.6.tar.gz 09:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:58:10 INFO - Installing collected packages: blessings 09:58:10 INFO - Running setup.py install for blessings 09:58:10 INFO - Successfully installed blessings 09:58:10 INFO - Cleaning up... 09:58:10 INFO - Return code: 0 09:58:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:58:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:10 INFO - Reading from file tmpfile_stdout 09:58:10 INFO - Current package versions: 09:58:10 INFO - argparse == 1.2.1 09:58:10 INFO - blessings == 1.6 09:58:10 INFO - blobuploader == 1.2.4 09:58:10 INFO - docopt == 0.6.1 09:58:10 INFO - functools32 == 3.2.3-2 09:58:10 INFO - jsonschema == 2.5.1 09:58:10 INFO - manifestparser == 1.1 09:58:10 INFO - mozInstall == 1.12 09:58:10 INFO - mozcrash == 0.17 09:58:10 INFO - mozdebug == 0.1 09:58:10 INFO - mozdevice == 0.48 09:58:10 INFO - mozfile == 1.2 09:58:10 INFO - mozhttpd == 0.7 09:58:10 INFO - mozinfo == 0.9 09:58:10 INFO - mozleak == 0.1 09:58:10 INFO - mozlog == 3.2 09:58:10 INFO - moznetwork == 0.27 09:58:10 INFO - mozprocess == 0.22 09:58:10 INFO - mozprofile == 0.28 09:58:10 INFO - mozrunner == 6.11 09:58:10 INFO - mozscreenshot == 0.1 09:58:10 INFO - mozsystemmonitor == 0.3 09:58:10 INFO - moztest == 0.7 09:58:10 INFO - mozversion == 1.4 09:58:10 INFO - psutil == 3.1.1 09:58:10 INFO - requests == 1.2.3 09:58:10 INFO - wsgiref == 0.1.2 09:58:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:10 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 0x7f143830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce2e0>, '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 0x153a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153a5d0>, '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': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', '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 09:58:10 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 09:58:10 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 09:58:10 INFO - Using env: {'DISPLAY': ':0', 09:58:10 INFO - 'HOME': '/home/cltbld', 09:58:10 INFO - 'LANG': 'en_US.UTF-8', 09:58:10 INFO - 'LANGUAGE': 'en_US:en', 09:58:10 INFO - 'LOGNAME': 'cltbld', 09:58:10 INFO - 'MAIL': '/var/mail/cltbld', 09:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:10 INFO - 'MOZ_NO_REMOTE': '1', 09:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:10 INFO - 'NO_EM_RESTART': '1', 09:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:10 INFO - 'PWD': '/builds/slave/test', 09:58:10 INFO - 'SHELL': '/bin/bash', 09:58:10 INFO - 'SHLVL': '1', 09:58:10 INFO - 'TERM': 'linux', 09:58:10 INFO - 'TMOUT': '86400', 09:58:10 INFO - 'USER': 'cltbld', 09:58:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', 09:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:10 INFO - '_': '/tools/buildbot/bin/python'} 09:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 INFO - Cleaning up... 09:58:10 INFO - Return code: 0 09:58:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:10 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 0x7f143830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce2e0>, '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 0x153a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153a5d0>, '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': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', '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 09:58:10 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 09:58:10 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 09:58:10 INFO - Using env: {'DISPLAY': ':0', 09:58:10 INFO - 'HOME': '/home/cltbld', 09:58:10 INFO - 'LANG': 'en_US.UTF-8', 09:58:10 INFO - 'LANGUAGE': 'en_US:en', 09:58:10 INFO - 'LOGNAME': 'cltbld', 09:58:10 INFO - 'MAIL': '/var/mail/cltbld', 09:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:10 INFO - 'MOZ_NO_REMOTE': '1', 09:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:10 INFO - 'NO_EM_RESTART': '1', 09:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:10 INFO - 'PWD': '/builds/slave/test', 09:58:10 INFO - 'SHELL': '/bin/bash', 09:58:10 INFO - 'SHLVL': '1', 09:58:10 INFO - 'TERM': 'linux', 09:58:10 INFO - 'TMOUT': '86400', 09:58:10 INFO - 'USER': 'cltbld', 09:58:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', 09:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:10 INFO - '_': '/tools/buildbot/bin/python'} 09:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:58:10 INFO - Cleaning up... 09:58:10 INFO - Return code: 0 09:58:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:10 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 0x7f143830df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ce2e0>, '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 0x153a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153a5d0>, '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': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', '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 09:58:10 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 09:58:10 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 09:58:10 INFO - Using env: {'DISPLAY': ':0', 09:58:10 INFO - 'HOME': '/home/cltbld', 09:58:10 INFO - 'LANG': 'en_US.UTF-8', 09:58:10 INFO - 'LANGUAGE': 'en_US:en', 09:58:10 INFO - 'LOGNAME': 'cltbld', 09:58:10 INFO - 'MAIL': '/var/mail/cltbld', 09:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:10 INFO - 'MOZ_NO_REMOTE': '1', 09:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:10 INFO - 'NO_EM_RESTART': '1', 09:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:10 INFO - 'PWD': '/builds/slave/test', 09:58:10 INFO - 'SHELL': '/bin/bash', 09:58:10 INFO - 'SHLVL': '1', 09:58:10 INFO - 'TERM': 'linux', 09:58:10 INFO - 'TMOUT': '86400', 09:58:10 INFO - 'USER': 'cltbld', 09:58:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', 09:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:10 INFO - '_': '/tools/buildbot/bin/python'} 09:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:11 INFO - Downloading/unpacking flake8 09:58:11 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 09:58:11 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 09:58:11 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 09:58:11 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 09:58:11 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 09:58:11 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 09:58:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:58:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:58:13 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 09:58:13 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 09:58:13 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 09:58:13 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 09:58:13 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 09:58:13 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 09:58:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:58:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:58:13 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 09:58:13 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 09:58:13 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 09:58:13 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 09:58:13 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 09:58:13 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 09:58:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:58:13 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 09:58:13 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 09:58:13 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 09:58:13 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 09:58:13 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 09:58:13 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 09:58:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:58:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:58:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:58:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:58:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:58:13 INFO - no previously-included directories found matching 'docs/_build' 09:58:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:58:13 INFO - Running setup.py install for pep8 09:58:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:58:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:58:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:58:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:58:13 INFO - no previously-included directories found matching 'docs/_build' 09:58:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:58:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:58:13 INFO - Cleaning up... 09:58:14 INFO - Return code: 0 09:58:14 INFO - Running post-action listener: _resource_record_post_action 09:58:14 INFO - Running post-action listener: _start_resource_monitoring 09:58:14 INFO - Starting resource monitoring. 09:58:14 INFO - ##### 09:58:14 INFO - ##### Finished create-virtualenv step (success) 09:58:14 INFO - ##### 09:58:14 INFO - ##### 09:58:14 INFO - ##### Running install step. 09:58:14 INFO - ##### 09:58:14 INFO - Running pre-action listener: _resource_record_pre_action 09:58:14 INFO - Running main action method: install 09:58:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:14 INFO - Reading from file tmpfile_stdout 09:58:14 INFO - Detecting whether we're running mozinstall >=1.0... 09:58:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:58:14 INFO - Reading from file tmpfile_stdout 09:58:14 INFO - Output received: 09:58:14 INFO - Usage: mozinstall [options] installer 09:58:14 INFO - Options: 09:58:14 INFO - -h, --help show this help message and exit 09:58:14 INFO - -d DEST, --destination=DEST 09:58:14 INFO - Directory to install application into. [default: 09:58:14 INFO - "/builds/slave/test"] 09:58:14 INFO - --app=APP Application being installed. [default: firefox] 09:58:14 INFO - mkdir: /builds/slave/test/build/application 09:58:14 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'] 09:58:14 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 09:58:31 INFO - Reading from file tmpfile_stdout 09:58:31 INFO - Output received: 09:58:31 INFO - /builds/slave/test/build/application/firefox/firefox 09:58:31 INFO - Running post-action listener: _resource_record_post_action 09:58:31 INFO - ##### 09:58:31 INFO - ##### Finished install step (success) 09:58:31 INFO - ##### 09:58:31 INFO - ##### 09:58:31 INFO - ##### Running run-tests step. 09:58:31 INFO - ##### 09:58:31 INFO - Running pre-action listener: _resource_record_pre_action 09:58:31 INFO - Running main action method: run_tests 09:58:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:58:31 INFO - Python 2.7.3 09:58:31 INFO - Return code: 0 09:58:31 INFO - grabbing minidump binary from tooltool 09:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:31 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 0x15ce2e0>, '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 0x153a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153a5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:58:31 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 09:58:31 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 09:58:31 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 09:58:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:31 INFO - Return code: 0 09:58:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:58:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:58:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:58:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:58:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:58:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:58:32 INFO - Return code: 0 09:58:32 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/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 09:58:32 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/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 09:58:32 INFO - Using env: {'DISPLAY': ':0', 09:58:32 INFO - 'HOME': '/home/cltbld', 09:58:32 INFO - 'LANG': 'en_US.UTF-8', 09:58:32 INFO - 'LANGUAGE': 'en_US:en', 09:58:32 INFO - 'LOGNAME': 'cltbld', 09:58:32 INFO - 'MAIL': '/var/mail/cltbld', 09:58:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:32 INFO - 'MOZ_NO_REMOTE': '1', 09:58:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:32 INFO - 'NO_EM_RESTART': '1', 09:58:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:32 INFO - 'PWD': '/builds/slave/test', 09:58:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:32 INFO - 'SHELL': '/bin/bash', 09:58:32 INFO - 'SHLVL': '1', 09:58:32 INFO - 'TERM': 'linux', 09:58:32 INFO - 'TMOUT': '86400', 09:58:32 INFO - 'USER': 'cltbld', 09:58:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446', 09:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:32 INFO - '_': '/tools/buildbot/bin/python'} 09:58:32 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/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 09:58:32 INFO - mozversion application_buildid: 20160608071315 09:58:32 INFO - mozversion application_changeset: f22cca9ad502563f7e15a5a44c4bf9d04ad2e87f 09:58:32 INFO - mozversion application_display_name: Nightly 09:58:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:32 INFO - mozversion application_name: Firefox 09:58:32 INFO - mozversion application_remotingname: firefox 09:58:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:58:32 INFO - mozversion application_vendor: Mozilla 09:58:32 INFO - mozversion application_version: 50.0a1 09:58:32 INFO - mozversion platform_buildid: 20160608071315 09:58:32 INFO - mozversion platform_changeset: f22cca9ad502563f7e15a5a44c4bf9d04ad2e87f 09:58:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:58:32 INFO - mozversion platform_version: 50.0a1 09:58:32 INFO - using testdate: 1465405112 09:58:32 INFO - actual date: 1465405112 09:58:32 INFO - starting webserver on 'localhost:59434' 09:58:32 INFO - SUITE-START | Running 2 tests 09:58:32 INFO - TEST-START | dromaeo_css 09:58:32 INFO - operating with platform_type : linux_ 09:58:32 INFO - Initialising browser for dromaeo_css test... 09:58:32 INFO - TEST-INFO | started process 3674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDtyrGd/profile http://localhost:59434/getInfo.html) 09:58:36 INFO - PROCESS | 3674 | __metrics Screen width/height:1600/1200 09:58:36 INFO - PROCESS | 3674 | colorDepth:24 09:58:36 INFO - PROCESS | 3674 | Browser inner width/height: 1024/697 09:58:36 INFO - PROCESS | 3674 | __metrics 09:58:37 ERROR - PROCESS | 3674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 09:58:38 INFO - TEST-INFO | 3674: exit 0 09:58:38 INFO - Browser initialized. 09:58:38 INFO - Running cycle 1/1 for dromaeo_css test... 09:58:38 INFO - TEST-INFO | started process 3793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDtyrGd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:50 INFO - PROCESS | 3793 | RSS: Main: 167538688 09:58:50 INFO - PROCESS | 3793 | 09:59:39 INFO - PROCESS | 3793 | 1465405179846 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] 10:01:47 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59434/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59434/tests/dromaeo/cssquery-ext.html) 10:01:48 INFO - PROCESS | 3793 | RSS: Main: 170631168 10:01:48 INFO - PROCESS | 3793 | 10:04:50 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59434/tests/dromaeo/cssquery-ext.html (next: http://localhost:59434/tests/dromaeo/cssquery-jquery.html) 10:04:51 INFO - PROCESS | 3793 | RSS: Main: 169553920 10:04:51 INFO - PROCESS | 3793 | 10:07:53 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59434/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59434/tests/dromaeo/cssquery-mootools.html) 10:07:54 INFO - PROCESS | 3793 | RSS: Main: 171270144 10:07:54 INFO - PROCESS | 3793 | 10:10:55 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59434/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59434/tests/dromaeo/cssquery-prototype.html) 10:10:56 INFO - PROCESS | 3793 | RSS: Main: 168239104 10:10:56 INFO - PROCESS | 3793 | 10:13:58 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59434/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59434/tests/dromaeo/cssquery-yui.html) 10:13:59 INFO - PROCESS | 3793 | RSS: Main: 170541056 10:13:59 INFO - PROCESS | 3793 | 10:17:02 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:59434/tests/dromaeo/cssquery-yui.html (next: http://localhost:59434/tests/dromaeo/cssquery-dojo.html) 10:17:02 INFO - PROCESS | 3793 | RSS: Main: 171429888 10:17:02 INFO - PROCESS | 3793 | 10:17:02 INFO - PROCESS | 3793 | __start_tp_report 10:17:02 INFO - PROCESS | 3793 | _x_x_mozilla_page_load 10:17:02 INFO - PROCESS | 3793 | _x_x_mozilla_page_load_details 10:17:02 INFO - PROCESS | 3793 | |i|pagename|runs| 10:17:02 INFO - PROCESS | 3793 | |0;dojo.html;3129.624445066592;3189.0911090339227;3209;3213.180638937071;3235.094173631384;5341.839744807652;5387.515123638872;5387.649802762818;5404.32445944257;5427;5288.60335474839;5316.9734151329285;5322.733863306838;5381;5403.567714582834;4811.278308253755;4896.24108263218;4939;4978.402591688984;5005.449400565934;4855.198892182803;5110.207917772733;5128.974355128219;5130.07658621448;5138.306328645641;4824;4866.926996095061;4894.5105489451125;4952.281919121725;4967.0810899983435;4889.975550122226;4920.729883338312;4927.926081108786;4929.260610908356;4968.6025117990475;4891.388576427947;4895.199054472529;4902.681325713817;4905.509449055102;4942.431620363668;5088.898222035538;5190.974045129788;5200.843974680765;5290.788368465257;5328.573714102862;5757.366689664133;5796.13058041293;5801.332846722638;5806.912896306559;5823.505002074829;5851.64890106595;5852.4440178183;5864.325602555718;5872.882542349129;5873.060310350366;5246.7638956247065;5354.812581559627;5370.865728356784;5399.37907140676;5420.403755586843;5883.117532370179;5887.264091988502;5900.1739756434135;5900.468957793819;5916.378780228014;5478.643888147258;5632.943670563324;5638.295213098363;5648.85877853057;5664.943350566524;5607.046802043662;5655.462731040627;5679.346875109415;5699.088145896637;5703.857403564861;5576.052071147915;5660.490555849993;5673.971630141823;5686.943130568724;5731.111677689882;5801.564882633819;5802.390748971382;5853.414658534198;5864.266966629171;5866.941330586725;4374.21264172452;4376.3654270130655;4433.578810013044;4446.933296000562;4450.8442204523335;3923.431102490123;3942.0933185366953;3951.2887680217264;3979.1444839359096;3980.3233450313514;5321.866953326198;5509.228707980886;5549.833504994856;5559.444055594408;5581.720913954286;5591.41290164535;5639.210510528529;5659.773609055674;5694.686792226385;5700.201971723962;5397.487238712316;5398.676079435168;5399;5404.648697834628;5406.945930540644;4713.787879545429;4744.525547445297;4750.857474275777;4777.140114779304;4820.638452116035;5930.11048342752;5961.463468287875;5983.132445795422;5986.670733109634;6006.6696331701305;5783.624064435799;5791.044477661138;5815.04051831443;5821.214136091573;5822.70886455684;5869.8553782012095;5956.970215148896;5957.880842383041;5962.135490353961;5981.222441082631;5777.04678728022;5778.682172480554;5779.450952159538;5790.94209057904;5821.94178058214;5848.883022339614;5851.61964472325;5863.032599621015;5886.705664716833;5896.9975104233245;5482.095454250004;5522.420145884625;5533.280673512418;5596.776128954959;5670;5513.173024046425;5532.640378375393;5552.944470555404;5580.525655319181;5628.746706398304;5538.667679939216;5561.805336813192;5563.944360556343;5565.387807341108;5566.52684521804;5534.252875861707;5636.2954630671165;5686.488216060575;5710.229119068873;5728.885422291614;5613.775448982158;5633.0705433603;5650.180723794944;5684.8010319638615;5692.4876761090045 10:17:02 INFO - PROCESS | 3793 | |1;ext.html;571.2716286734416;621.7761605821903;628.9308176100625;642.9453496452803;666.3869240298925;37221.44167837481;42521.78739106308;42532.23540469875;42582.57417425825;42661.57338426615;43718.56281437185;44382;44417.55582444175;44429;44486.77756611221;8532.70135545256;8639.52482613456;8728.258098061673;8750.649974001033;8755.824883502326;8506;8553.101924297922;8577;8577.95711021444;8578.270846977983;8630.223279904807;8659.913400865973;8662.17709317617;8665.826683466326;8668.653253869837;8546.957265213696;8561;8586.441881277728;8590.098039705803;8593.484390936565;8518.70184543538;8528.189821966904;8559;8580.785480362978;8639.784005399852;32958.50562241568;40777;41129;41150.1769964599;41184;2953.394554116401;3229.757768167397;3539.6460353964653;3895.14306852492;4026.1947610477728;29422;29715.10854674363;30665;31070.378592428024;31173.688263117307;4140.730852494578;4187.895302617429;4288.142371525707;4300.6989510734265;4342.38786483484;309365.45317273494;310134;310243;310632;311695;32016.519752203734;35066.824665876506;35210.64789352125;35334.64665353365;35344;35435.645643543234;35577;35749.821250893576;35824.28351432957;36033;14416.42334306637;14425.422983080769;14470.348834302482;14498.202598857164;14644.19456929879;13481.662958426117;13561.321933903266;13627.727445451035;13652.590422287347;13663.316834158253;8094.190580941859;8122.390820688472;8166.959165204136;8193.344532437392;8208.46644968075;3069.5549145374243;3116.236522052112;3147.1030756234363;3177.602799650044;3192.521121831744;1033.2715435618022;1052.7262911642874;1065.0840277361463;1112.1547623805966;1146.3179408252242;32489.350212995607;32699.346013079605;32966.67033329684;33004.66995330016;33163.3367332652;1088.8856670049688;1092.6612750047511;1115.9497822598003;1201.9939900300442;1204.993830151833;16485.505434836974;17124.40064597733;17169;17211.311547538207;17324.539621367152;534783;547714;549744;552278;554195;57784.4221557779;58341.12488312679;58471.70764146152;58647;58761.41238587645;1347.3196036001953;1369.7808350664045;1382.7856682214274;1398.6013986013936;1398.664320563037;30373.544396834506;31220.43897805146;31732.67916732863;31858.522122167724;32142.196445088124;50477.49522504875;50712.74643626758;50830.74584627053;50888.236676449145;51084;438285;439846;440223;441181;441736;28229.858850705616;28354.574681380207;28531.14406567806;28576.57135143016;28666.283342916595;44169.77915110404;48103.27845082257;48899.51100488949;50170.49829501658;50299.24551131809;40805.183896321316;41321.586784131774;41773.66140636806;42702.145957080065;42834.357484637134;40382.79808600938;40950.795246023576;41044;41344;41351.79324103481;40330.596694033855;41125.383119252634;41510;41544.37683434811;43842.56157438512;33545.49681754727;36905;37275.62724372721;37431.81284093562;37946;27638.86180569084;27658.585121222794;27660.308492287048;28037;28116.43767124687 10:17:02 INFO - PROCESS | 3793 | |2;jquery.html;382.8832206177117;388.80365415465184;390.7362530292052;394.92299001694664;416;17858.553536161588;18597.349092781722;19276.132574034167;19304;19345.70981435278;18058;18427.72358414625;18524.536886577844;18605.627887442242;18807.811921880777;5494.80768173114;5507.476789704971;5648.700012935184;5651.604387692863;5735.369109397963;5572.192032155355;5595.076812325961;5598.1322894951145;5601.915971260434;5602.60781745278;5394.487523685244;5529.060059789846;5575.526080283181;5610.438956104398;5612.971935140339;5563.415841336642;5575.637583557076;5589.692566908819;5607.523360514361;5612.102063669814;4880.463149053601;5021.719461537321;5027.019731152427;5029.421616514074;5047.520485553903;21882.23412180582;22245;22360.888195558917;22654.207102751323;22730.88634556833;2304.331743794298;2405.434722840131;2442.1818690738623;2529.519391315644;2546.7835234005133;13933.651658708512;13991;14072.507462238875;14138.08102473336;14264.928675356558;1887.4149013805763;1889.3576184097335;1970.4088773367932;1986.145957238387;1989.3634037108131;77208;79482.6025869867;80720.99999999942;81678.59160704158;81868.59065704692;10181.21828679978;10300.939812037472;10462.424566648755;10529.788084766154;10641.148708103334;14506.782398264035;14566.19885906264;14566.635834104232;14583.781243281359;14616.26918654063;7658.693652253847;7990.121086680577;8032.196780321921;8104.675812967415;8170.142135075732;7653.425993050543;7696;7810.906473093772;7834.647440865175;7850.489718168301;6378.521610879203;6533.640649764214;6622.966885165543;6662.300458451889;6670.365760388736;1852.8888266704041;1868.6921651760065;1876.3151449720754;1900.8859468431938;1923.4806602217323;967.2503809547657;1006.0794373148633;1027.664036752219;1088.7931293054294;1130.6438471881331;18106.909465452587;18415.355462558746;18902.905485472485;19035.904820475807;19194.69994853843;1017.9083882450615;1033.1270076785104;1039.2673165418362;1076.6178006807627;1076.7200527862813;10489.685309440729;10928.672139835817;10979.341239525655;10979.451027448597;11038.779224415466;462803;472783;474191;477121;479529;75924.24075759172;80896;82985.17014829894;83191;83942;1053.373242920461;1054.1092776603757;1057.6932689520106;1059.4384975962753;1065.3235195650818;15650.843491565394;16258;16729.91635041817;16804.831951680328;16837.831621684116;41347.793261033505;42395.364069539595;43362;43430.131397372505;44128.11743765043;57440.71279643575;57954.710226448595;58552.4144758564;58585;58680.70659646674;8142.145074767301;8261.917380826115;8284.757286406846;8491.83016339682;8576.44253123545;9232.815343693223;11023.897610238912;11598.652040438801;12610.369481525704;12645.683857903627;11122.833157502482;11293.604723834625;11446.198766086294;11497.19519633651;11527.8270825936;9280.767980800534;11190.32858028521;11277.266977646756;11302.321860688386;11428;11276.661700148681;11302.265352752045;11413.315201087962;11475.598354057567;11821.527138914347;8233.752987410388;8271.875921861056;8283.83432331362;8329.583520823813;8414.915850841659;10520.631777887736;11001.22991390595;11120;11595.884041159481;11631.59289424866 10:17:02 INFO - PROCESS | 3793 | |3;mootools.html;1492.5223928342928;1508.8264849542302;1612.2583611538691;1681.2938565802363;1760.683077046131;7748.380129589634;8290.70982515612;8576.271016963557;8824.91175088249;8842.336824738146;8628.568571571428;8756.474611523314;8802.955985220065;8836.293096552277;8844.867326990101;2215.1139544182374;2266.3087758233733;2270.1713874435877;2277.453411181321;2281.646344816556;2246.618074927258;2260.9773902261013;2291.129370839087;2298.6781850540856;2306.400335912658;2054.6917962305624;2066.3904148276297;2069.896505174735;2201.1635578480236;2259.164109279569;2118.4641135177026;2122.1829595605727;2137.1237792505076;2137.5190582119053;2148.0870629982273;2140.7645159032495;2144.839137064711;2162.9783702162936;2163.891805409739;2167.8916054197384;8551.657933682707;8642.395032347738;8662.220400164015;8669.523176225304;8712;4789.473157952622;4940.407151141886;4955.231939049453;4959.70241785494;4970.726610036447;3122.3078187169313;3187.2509960159346;3230.6769323067506;3231.434498962672;3248.5127230915314;1082.3830416662506;1095.583678202278;1120.9495572699248;1123.4775829239443;1133.3086817041599;12223.633291001284;12255.632331029994;12259.816102758467;12273.570425035081;12300.8154877676;4290.764007979591;4382.23310920594;4384.846530371422;4424.778761061998;4446.599806017474;10226.079652831133;10298.3820970742;10328.277020608635;10341.844872326921;10344.741381465523;4984.177610694195;4992.226204938241;5017.37282839645;5022.84931452057;5024.6733962293065;4139.606737359946;4517.503074661785;4546.681732278775;4621.260598304322;4718.268668356411;3806.7525610835205;3837.347650899354;3908.8241029153755;3927.273454410943;3932.2921874062945;1189.8631657359342;1207.4264724255909;1224.1859163656247;1232.4761976160096;1241.845084071822;809.4495742894889;889.6308032166578;957.1816097236901;972.3776782858835;995.3281534964016;5877.882442351129;5924.881502369928;5980.431858973478;6005.609635373687;6075.969620151959;432.414078923061;432.6949500602131;436.49366734587727;448.7957979119493;454.7453426081405;4038.7980600969836;4175.436316097349;4204.51648060477;4218.093109981369;4236.809343579546;10863.07663848566;11127.499262533205;11254;11258.887411125948;11261.831072533918;11034.889651103385;11082.722931926766;11123.443827808576;11139.832902506469;11185.72035699114;7839.412044096715;8221.712240071689;8310;8359.874601880976;8398.412111152284;5894.646321220741;5960.701964901651;5985.221921150222;6138.662373569497;6205;10123.392596444237;10200.132988695746;10399.636012739518;10408.895911040792;10423.166146708396;10004.449755263531;10371.27401081917;10564.260501764802;10627.04356607909;10656.200784941315;6978.511504194657;7687.423443241667;7737.11023232313;7866.803329916798;7944.920550794418;8569.657213711382;8609.69866054685;8618.267447267053;8641.395102343027;8650.480971141751;7592.4305677073335;7619.1999840016;7631;7720.729774457867;7906.288434040964;7527.962360188164;7570;7619.733309334369;7738.264864837832;7792.220777922163;6945.722171113301;6973.930260697328;6979.5114341997605;7030.859382812213;7051.083359163276;4892.290617860462;5012.874678133076;5089.923651145162;5122.385313762373;5168.147255702917;4986.301917731448;5033.6476446648385;5290.761915713725;5375.569954403716;5548.750306236309 10:17:02 INFO - PROCESS | 3793 | |4;prototype.html;320.9630892447368;324.3998602585217;330.47289573130865;332.94839299908523;336.89893032090396;5625.1843482694985;5670.610700378403;5706.629069110505;5715.542756579474;5718.653823094447;5580.944190558103;5593;5595.776168953247;5616.157576363547;5624.3531993820725;4157.33482642778;4259.424977628027;4368.584984426474;4378.737275763448;4394.736315821045;4378.6715996300245;4388.517263101056;4402.8679139625865;4403.361512580674;4409.316555933835;4345.760983145926;4370.6940514164025;4370.956290437102;4371.191329604034;4388.451443569554;4305.913881722364;4333.198358303724;4348.21732088224;4352.216601011816;4354.651627869763;3780.206156707095;3817.3701339278987;3819.7899115548635;3830.425436184567;3837.194189220267;5386.353637563518;5419.945800541984;5439.93921185369;5481.150421684645;5501.5323697485765;4751.857444276643;4973.204287314013;4986.202207646796;4996.725180115092;5035.62232832539;5832.795852145197;5834.474897259267;5856.853578660568;5902.291724992985;5938.198343223696;4241.830326786956;4251.27728286189;4253.638440732541;4262.552431994658;4271.530131685512;5923.644581325091;6055.5646331258995;6058.545609079337;6086.817395478099;6113.480354169857;4307.289297265916;4312.482502099768;4349.630281426051;4350.195213885441;4387.100644367897;4371.650267978554;4398.868033958986;4400.625946794495;4408.55914408563;4433.202023635777;4693.577578017995;4957.157283261854;4975.228839529878;4982.476839931827;5047.873803154877;5905.291365036223;5919.3192782829665;5932.584719069624;5937.228160339128;5943.167956486095;1492.7984722062383;1495.5961890289777;1515.628670975618;1521.193767303331;1522.8933974621891;970.7281961050917;1002.0730823987782;1005.1958433253368;1027.5838285494387;1034.534459493231;5709.257796486513;5728.713564321851;5774.740136693859;5779.653220806765;5804.4195580442465;6036.909446358308;6093.66484843329;6116.724747386378;6120.265568131853;6144.29650953579;5562.638428502215;5578.581606379456;5700.914486282709;5733.197352370671;5759.424057594291;3266.6406695263504;3277.115178901683;3287.4575695010535;3300.3234336960863;3301.372739179596;6053.636781793107;6209.5963762356205;6218.31598524162;6242.781502647476;6250.562460627712;6102.176206212193;6124.448799608057;6161.96919015411;6169.691515424211;6251.624902505864;5977.193078934375;6219.720112594944;6220.200909590702;6229.972054610938;6256.624602523863;5989.850253743517;6095.664738439251;6111.297200821962;6123.234595675541;6128.571000030133;5969.850753731192;5993.022302640205;6023.728932198149;6046.879062418639;6057.7879774207695;5895.7052147393315;6129.478994285536;6140.635855195693;6154.723037463235;6174;4166.0834616384345;4178.767263657168;4194.895127621712;4203.201391735561;4232.555581663881;5944.3164036136395;5967.37342579023;5999.940000599938;6014.428629280212;6065.484433823174;5790.884182316246;5819.912701309569;5833.67914764692;5854.385289544536;5883.588148829712;5718.485336319751;5768.221290125947;5787.681677507778;5812.76748930055;5819.79630712923;5216.634835561475;5731.197632331394;5741.540676745767;5779.2775903012125;5789.1605717171615;5924.526037917042;5926.970365148147;5943.316518600243;5952.910706339495;5968.4031596841705;5663.3770285267765;5860.472557469848;5882.382349853204;5903.439173278532;5909.645421274738 10:17:02 INFO - PROCESS | 3793 | |5;yui.html;686.9828254293642;706.4489698035533;708.4474110194047;725.1479511573899;758.1016495452889;14427.567172984815;14634.707305853877;14641.853581464182;14704.558863234106;14794.334254958525;14505.347259373328;14706.11763294203;14726.852731472682;14751.77872331916;14757.557273281818;673.9629320387389;770.1412924589071;792.6829268292671;795.5862951265339;795.6658203554521;804.9839003219932;808.3815880851154;809.0453265147124;809.6397103289039;817.0685418622775;860.8708693695964;862.6118246788939;862.7153039496982;864.4813112132733;866.2550206822128;849.838530679169;850.3834719828106;850.5917159763318;854.4104567848227;857.2456238510102;619.6127420362274;620.4632992461488;622.5424313129846;623.0747340199799;624.7032659486707;13761.793573096411;13771.586852394445;13786.586402407944;13794.724105517833;13810;14735.705285894222;15152.772708409382;15174.620634484116;15327.923360383238;15491.147986860718;12302.75394492105;12317.876821231763;12515.061370397256;12532.937335313265;12567.308798016105;3798.2593394288124;3929.8603405012514;3931.429942658327;3976.681865450757;3988.561258261589;69263.3073669262;70435.64782176107;70525.29474705238;71642;76266.23733762647;11240.662780116609;11307.830382544269;11644.53421863133;11948.223365481215;12243.08176886737;21320;21364.78635213659;21429.89285053565;22117.557648847254;24103.638445423334;8097.797555061053;8183.059700748641;8286.917130828735;8299.875501867476;8407.70573029941;4359.825606975685;4365.934510982338;4400.933985990213;4429.601335879786;4532.138893610204;3195.680431956786;3323.8670453181603;3329.001299610156;3333.983330083334;3342.649021852719;585.6866576381616;590.3948452835878;600.1088383750127;605.0802779774717;606.0787602843653;579.4326101119311;633.9666343859479;654.4125678990313;691.6714560583682;726.1436514510561;8668.78328041804;8890.288776897833;9016.18854303116;9168.587413566405;9257.722268331961;667.6361383046251;674.357938419949;677.7322957431787;683.7555648719382;689.6379400814512;4253.659707223414;4431.7562534060935;4481.843135490242;4483.75339356332;4522.66080043998;70661.2933870665;72614.63692681503;72947;115721;115812;99637.50181249193;99686;100190.49904750576;101301.49349253354;101699;67977.66011169912;88189.55905220562;88366.55816720876;88578.55710721534;88579;8282.213189746964;8453.239208471266;8618.439801412887;8660.13398660129;8901.955490222508;51717.7414112927;52014.47985520097;52905.20642190447;53009.20486192787;53496;67079.66460167668;76658;78671.21328786638;79160.60419698094;81304.5934770346;10804.783904322027;10951.671449856518;11007.559697612005;11129.888701113208;11177.832332515181;11872.584459543874;12388.194767340094;12495.000399968163;12637.431315591004;12791.936040319739;11024.44877756125;11168.776624467628;12193.207441516273;12263.69340766488;12395.380230988594;11188.720281993015;11757.235779674294;11761.588344407905;11857.16999810005;12216;11333.26333788301;11638.312444695302;11818.586349477728;11874.940625296818;12195.512179513074;9368.765780855532;9568.1625740897;9586.233101352014;9649.324547281623;9831.754206144904;9805;9845.45849978258;9874;9915.851262231217;9948.204143668634 10:17:02 INFO - PROCESS | 3793 | __end_tp_report 10:17:02 INFO - PROCESS | 3793 | __start_cc_report 10:17:02 INFO - PROCESS | 3793 | _x_x_mozilla_cycle_collect,345 10:17:02 INFO - PROCESS | 3793 | __end_cc_report 10:17:02 INFO - PROCESS | 3793 | __startTimestamp1465406222496__endTimestamp 10:17:02 INFO - PROCESS | 3793 | 10:17:02 INFO - PROCESS | 3793 | ------- Summary: start ------- 10:17:02 INFO - PROCESS | 3793 | Number of tests: 6 10:17:02 INFO - PROCESS | 3793 | 10:17:02 INFO - PROCESS | 3793 | [#0] dojo.html Cycles:165 Average:5353.32 Median:5559.44 stddev:601.31 (10.8%) stddev-sans-first:577.29 10:17:02 INFO - PROCESS | 3793 | Values: 3129.6 3189.1 3209.0 3213.2 3235.1 5341.8 5387.5 5387.6 5404.3 5427.0 5288.6 5317.0 5322.7 5381.0 5403.6 4811.3 4896.2 4939.0 4978.4 5005.4 4855.2 5110.2 5129.0 5130.1 5138.3 4824.0 4866.9 4894.5 4952.3 4967.1 4890.0 4920.7 4927.9 4929.3 4968.6 4891.4 4895.2 4902.7 4905.5 4942.4 5088.9 5191.0 5200.8 5290.8 5328.6 5757.4 5796.1 5801.3 5806.9 5823.5 5851.6 5852.4 5864.3 5872.9 5873.1 5246.8 5354.8 5370.9 5399.4 5420.4 5883.1 5887.3 5900.2 5900.5 5916.4 5478.6 5632.9 5638.3 5648.9 5664.9 5607.0 5655.5 5679.3 5699.1 5703.9 5576.1 5660.5 5674.0 5686.9 5731.1 5801.6 5802.4 5853.4 5864.3 5866.9 4374.2 4376.4 4433.6 4446.9 4450.8 3923.4 3942.1 3951.3 3979.1 3980.3 5321.9 5509.2 5549.8 5559.4 5581.7 5591.4 5639.2 5659.8 5694.7 5700.2 5397.5 5398.7 5399.0 5404.6 5406.9 4713.8 4744.5 4750.9 4777.1 4820.6 5930.1 5961.5 5983.1 5986.7 6006.7 5783.6 5791.0 5815.0 5821.2 5822.7 5869.9 5957.0 5957.9 5962.1 5981.2 5777.0 5778.7 5779.5 5790.9 5821.9 5848.9 5851.6 5863.0 5886.7 5897.0 5482.1 5522.4 5533.3 5596.8 5670.0 5513.2 5532.6 5552.9 5580.5 5628.7 5538.7 5561.8 5563.9 5565.4 5566.5 5534.3 5636.3 5686.5 5710.2 5728.9 5613.8 5633.1 5650.2 5684.8 5692.5 10:17:02 INFO - PROCESS | 3793 | 10:17:02 INFO - PROCESS | 3793 | [#1] ext.html Cycles:180 Average:57644.75 Median:40877.99 stddev:118056.39 (288.8%) stddev-sans-first:118309.80 10:17:02 INFO - PROCESS | 3793 | Values: 571.3 621.8 628.9 642.9 666.4 37221.4 42521.8 42532.2 42582.6 42661.6 43718.6 44382.0 44417.6 44429.0 44486.8 8532.7 8639.5 8728.3 8750.6 8755.8 8506.0 8553.1 8577.0 8578.0 8578.3 8630.2 8659.9 8662.2 8665.8 8668.7 8547.0 8561.0 8586.4 8590.1 8593.5 8518.7 8528.2 8559.0 8580.8 8639.8 32958.5 40777.0 41129.0 41150.2 41184.0 2953.4 3229.8 3539.6 3895.1 4026.2 29422.0 29715.1 30665.0 31070.4 31173.7 4140.7 4187.9 4288.1 4300.7 4342.4 309365.5 310134.0 310243.0 310632.0 311695.0 32016.5 35066.8 35210.6 35334.6 35344.0 35435.6 35577.0 35749.8 35824.3 36033.0 14416.4 14425.4 14470.3 14498.2 14644.2 13481.7 13561.3 13627.7 13652.6 13663.3 8094.2 8122.4 8167.0 8193.3 8208.5 3069.6 3116.2 3147.1 3177.6 3192.5 1033.3 1052.7 1065.1 1112.2 1146.3 32489.4 32699.3 32966.7 33004.7 33163.3 1088.9 1092.7 1115.9 1202.0 1205.0 16485.5 17124.4 17169.0 17211.3 17324.5 534783.0 547714.0 549744.0 552278.0 554195.0 57784.4 58341.1 58471.7 58647.0 58761.4 1347.3 1369.8 1382.8 1398.6 1398.7 30373.5 31220.4 31732.7 31858.5 32142.2 50477.5 50712.7 50830.7 50888.2 51084.0 438285.0 439846.0 440223.0 441181.0 441736.0 28229.9 28354.6 28531.1 28576.6 28666.3 44169.8 48103.3 48899.5 50170.5 50299.2 40805.2 41321.6 41773.7 42702.1 42834.4 40382.8 40950.8 41044.0 41344.0 41351.8 40330.6 41125.4 41510.0 41544.4 43842.6 33545.5 36905.0 37275.6 37431.8 37946.0 27638.9 27658.6 27660.3 28037.0 28116.4 10:17:02 INFO - PROCESS | 3793 | 10:17:02 INFO - PROCESS | 3793 | [#2] jquery.html Cycles:180 Average:28149.84 Median:22692.55 stddev:77922.87 (343.4%) stddev-sans-first:78113.57 10:17:02 INFO - PROCESS | 3793 | Values: 382.9 388.8 390.7 394.9 416.0 17858.6 18597.3 19276.1 19304.0 19345.7 18058.0 18427.7 18524.5 18605.6 18807.8 5494.8 5507.5 5648.7 5651.6 5735.4 5572.2 5595.1 5598.1 5601.9 5602.6 5394.5 5529.1 5575.5 5610.4 5613.0 5563.4 5575.6 5589.7 5607.5 5612.1 4880.5 5021.7 5027.0 5029.4 5047.5 21882.2 22245.0 22360.9 22654.2 22730.9 2304.3 2405.4 2442.2 2529.5 2546.8 13933.7 13991.0 14072.5 14138.1 14264.9 1887.4 1889.4 1970.4 1986.1 1989.4 77208.0 79482.6 80721.0 81678.6 81868.6 10181.2 10300.9 10462.4 10529.8 10641.1 14506.8 14566.2 14566.6 14583.8 14616.3 7658.7 7990.1 8032.2 8104.7 8170.1 7653.4 7696.0 7810.9 7834.6 7850.5 6378.5 6533.6 6623.0 6662.3 6670.4 1852.9 1868.7 1876.3 1900.9 1923.5 967.3 1006.1 1027.7 1088.8 1130.6 18106.9 18415.4 18902.9 19035.9 19194.7 1017.9 1033.1 1039.3 1076.6 1076.7 10489.7 10928.7 10979.3 10979.5 11038.8 462803.0 472783.0 474191.0 477121.0 479529.0 75924.2 80896.0 82985.2 83191.0 83942.0 1053.4 1054.1 1057.7 1059.4 1065.3 15650.8 16258.0 16729.9 16804.8 16837.8 41347.8 42395.4 43362.0 43430.1 44128.1 57440.7 57954.7 58552.4 58585.0 58680.7 8142.1 8261.9 8284.8 8491.8 8576.4 9232.8 11023.9 11598.7 12610.4 12645.7 11122.8 11293.6 11446.2 11497.2 11527.8 9280.8 11190.3 11277.3 11302.3 11428.0 11276.7 11302.3 11413.3 11475.6 11821.5 8233.8 8271.9 8283.8 8329.6 8414.9 10520.6 11001.2 11120.0 11595.9 11631.6 10:17:02 INFO - PROCESS | 3793 | 10:17:02 INFO - PROCESS | 3793 | [#3] mootools.html Cycles:180 Average:5749.09 Median:4383.54 stddev:3376.93 (77.0%) stddev-sans-first:3371.25 10:17:02 INFO - PROCESS | 3793 | Values: 1492.5 1508.8 1612.3 1681.3 1760.7 7748.4 8290.7 8576.3 8824.9 8842.3 8628.6 8756.5 8803.0 8836.3 8844.9 2215.1 2266.3 2270.2 2277.5 2281.6 2246.6 2261.0 2291.1 2298.7 2306.4 2054.7 2066.4 2069.9 2201.2 2259.2 2118.5 2122.2 2137.1 2137.5 2148.1 2140.8 2144.8 2163.0 2163.9 2167.9 8551.7 8642.4 8662.2 8669.5 8712.0 4789.5 4940.4 4955.2 4959.7 4970.7 3122.3 3187.3 3230.7 3231.4 3248.5 1082.4 1095.6 1120.9 1123.5 1133.3 12223.6 12255.6 12259.8 12273.6 12300.8 4290.8 4382.2 4384.8 4424.8 4446.6 10226.1 10298.4 10328.3 10341.8 10344.7 4984.2 4992.2 5017.4 5022.8 5024.7 4139.6 4517.5 4546.7 4621.3 4718.3 3806.8 3837.3 3908.8 3927.3 3932.3 1189.9 1207.4 1224.2 1232.5 1241.8 809.4 889.6 957.2 972.4 995.3 5877.9 5924.9 5980.4 6005.6 6076.0 432.4 432.7 436.5 448.8 454.7 4038.8 4175.4 4204.5 4218.1 4236.8 10863.1 11127.5 11254.0 11258.9 11261.8 11034.9 11082.7 11123.4 11139.8 11185.7 7839.4 8221.7 8310.0 8359.9 8398.4 5894.6 5960.7 5985.2 6138.7 6205.0 10123.4 10200.1 10399.6 10408.9 10423.2 10004.4 10371.3 10564.3 10627.0 10656.2 6978.5 7687.4 7737.1 7866.8 7944.9 8569.7 8609.7 8618.3 8641.4 8650.5 7592.4 7619.2 7631.0 7720.7 7906.3 7528.0 7570.0 7619.7 7738.3 7792.2 6945.7 6973.9 6979.5 7030.9 7051.1 4892.3 5012.9 5089.9 5122.4 5168.1 4986.3 5033.6 5290.8 5375.6 5548.8 10:17:02 INFO - PROCESS | 3793 | 10:17:02 INFO - PROCESS | 3793 | [#4] prototype.html Cycles:180 Average:4954.26 Median:5703.77 stddev:1456.48 (25.5%) stddev-sans-first:1418.44 10:17:02 INFO - PROCESS | 3793 | Values: 321.0 324.4 330.5 332.9 336.9 5625.2 5670.6 5706.6 5715.5 5718.7 5580.9 5593.0 5595.8 5616.2 5624.4 4157.3 4259.4 4368.6 4378.7 4394.7 4378.7 4388.5 4402.9 4403.4 4409.3 4345.8 4370.7 4371.0 4371.2 4388.5 4305.9 4333.2 4348.2 4352.2 4354.7 3780.2 3817.4 3819.8 3830.4 3837.2 5386.4 5419.9 5439.9 5481.2 5501.5 4751.9 4973.2 4986.2 4996.7 5035.6 5832.8 5834.5 5856.9 5902.3 5938.2 4241.8 4251.3 4253.6 4262.6 4271.5 5923.6 6055.6 6058.5 6086.8 6113.5 4307.3 4312.5 4349.6 4350.2 4387.1 4371.7 4398.9 4400.6 4408.6 4433.2 4693.6 4957.2 4975.2 4982.5 5047.9 5905.3 5919.3 5932.6 5937.2 5943.2 1492.8 1495.6 1515.6 1521.2 1522.9 970.7 1002.1 1005.2 1027.6 1034.5 5709.3 5728.7 5774.7 5779.7 5804.4 6036.9 6093.7 6116.7 6120.3 6144.3 5562.6 5578.6 5700.9 5733.2 5759.4 3266.6 3277.1 3287.5 3300.3 3301.4 6053.6 6209.6 6218.3 6242.8 6250.6 6102.2 6124.4 6162.0 6169.7 6251.6 5977.2 6219.7 6220.2 6230.0 6256.6 5989.9 6095.7 6111.3 6123.2 6128.6 5969.9 5993.0 6023.7 6046.9 6057.8 5895.7 6129.5 6140.6 6154.7 6174.0 4166.1 4178.8 4194.9 4203.2 4232.6 5944.3 5967.4 5999.9 6014.4 6065.5 5790.9 5819.9 5833.7 5854.4 5883.6 5718.5 5768.2 5787.7 5812.8 5819.8 5216.6 5731.2 5741.5 5779.3 5789.2 5924.5 5927.0 5943.3 5952.9 5968.4 5663.4 5860.5 5882.4 5903.4 5909.6 10:17:02 INFO - PROCESS | 3793 | 10:17:02 INFO - PROCESS | 3793 | [#5] yui.html Cycles:180 Average:19623.80 Median:582.56 stddev:28213.69 (4843.1%) stddev-sans-first:28257.01 10:17:02 INFO - PROCESS | 3793 | Values: 687.0 706.4 708.4 725.1 758.1 14427.6 14634.7 14641.9 14704.6 14794.3 14505.3 14706.1 14726.9 14751.8 14757.6 674.0 770.1 792.7 795.6 795.7 805.0 808.4 809.0 809.6 817.1 860.9 862.6 862.7 864.5 866.3 849.8 850.4 850.6 854.4 857.2 619.6 620.5 622.5 623.1 624.7 13761.8 13771.6 13786.6 13794.7 13810.0 14735.7 15152.8 15174.6 15327.9 15491.1 12302.8 12317.9 12515.1 12532.9 12567.3 3798.3 3929.9 3931.4 3976.7 3988.6 69263.3 70435.6 70525.3 71642.0 76266.2 11240.7 11307.8 11644.5 11948.2 12243.1 21320.0 21364.8 21429.9 22117.6 24103.6 8097.8 8183.1 8286.9 8299.9 8407.7 4359.8 4365.9 4400.9 4429.6 4532.1 3195.7 3323.9 3329.0 3334.0 3342.6 585.7 590.4 600.1 605.1 606.1 579.4 634.0 654.4 691.7 726.1 8668.8 8890.3 9016.2 9168.6 9257.7 667.6 674.4 677.7 683.8 689.6 4253.7 4431.8 4481.8 4483.8 4522.7 70661.3 72614.6 72947.0 115721.0 115812.0 99637.5 99686.0 100190.5 101301.5 101699.0 67977.7 88189.6 88366.6 88578.6 88579.0 8282.2 8453.2 8618.4 8660.1 8902.0 51717.7 52014.5 52905.2 53009.2 53496.0 67079.7 76658.0 78671.2 79160.6 81304.6 10804.8 10951.7 11007.6 11129.9 11177.8 11872.6 12388.2 12495.0 12637.4 12791.9 11024.4 11168.8 12193.2 12263.7 12395.4 11188.7 11757.2 11761.6 11857.2 12216.0 11333.3 11638.3 11818.6 11874.9 12195.5 9368.8 9568.2 9586.2 9649.3 9831.8 9805.0 9845.5 9874.0 9915.9 9948.2 10:17:02 INFO - PROCESS | 3793 | -------- Summary: end -------- 10:17:02 INFO - PROCESS | 3793 | 10:17:03 INFO - TEST-INFO | 3793: exit 0 10:17:03 INFO - TEST-OK | dromaeo_css | took 1110771ms 10:17:03 INFO - TEST-START | kraken 10:17:03 INFO - operating with platform_type : linux_ 10:17:03 INFO - Initialising browser for kraken test... 10:17:03 INFO - TEST-INFO | started process 4025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFIwHu2/profile http://localhost:59434/getInfo.html) 10:17:07 INFO - PROCESS | 4025 | __metrics Screen width/height:1600/1200 10:17:07 INFO - PROCESS | 4025 | colorDepth:24 10:17:07 INFO - PROCESS | 4025 | Browser inner width/height: 1024/697 10:17:07 INFO - PROCESS | 4025 | __metrics 10:17:08 ERROR - PROCESS | 4025 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 10:17:08 INFO - TEST-INFO | 4025: exit 0 10:17:08 INFO - Browser initialized. 10:17:08 INFO - Running cycle 1/1 for kraken test... 10:17:08 INFO - TEST-INFO | started process 4143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFIwHu2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:20 INFO - PROCESS | 4143 | RSS: Main: 167411712 10:17:20 INFO - PROCESS | 4143 | 10:17:23 INFO - PROCESS | 4143 | Cycle 1(1): loaded http://localhost:59434/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59434/tests/kraken/driver.html?testName=audio-beat-detection) 10:17:24 INFO - PROCESS | 4143 | RSS: Main: 172412928 10:17:24 INFO - PROCESS | 4143 | 10:17:26 INFO - PROCESS | 4143 | Cycle 1(1): loaded http://localhost:59434/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59434/tests/kraken/driver.html?testName=audio-dft) 10:17:27 INFO - PROCESS | 4143 | RSS: Main: 171950080 10:17:27 INFO - PROCESS | 4143 | 10:17:30 INFO - PROCESS | 4143 | Cycle 1(1): loaded http://localhost:59434/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59434/tests/kraken/driver.html?testName=audio-fft) 10:17:30 INFO - PROCESS | 4143 | RSS: Main: 166903808 10:17:30 INFO - PROCESS | 4143 | 10:17:33 INFO - PROCESS | 4143 | Cycle 1(1): loaded http://localhost:59434/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59434/tests/kraken/driver.html?testName=audio-oscillator) 10:17:33 INFO - PROCESS | 4143 | RSS: Main: 167698432 10:17:33 INFO - PROCESS | 4143 | 10:17:36 INFO - PROCESS | 4143 | Cycle 1(1): loaded http://localhost:59434/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59434/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:17:36 INFO - PROCESS | 4143 | RSS: Main: 167735296 10:17:36 INFO - PROCESS | 4143 | 10:17:39 INFO - PROCESS | 4143 | Cycle 1(1): loaded http://localhost:59434/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59434/tests/kraken/driver.html?testName=imaging-darkroom) 10:17:40 INFO - PROCESS | 4143 | RSS: Main: 168382464 10:17:40 INFO - PROCESS | 4143 | 10:17:43 INFO - PROCESS | 4143 | Cycle 1(1): loaded http://localhost:59434/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59434/tests/kraken/driver.html?testName=imaging-desaturate) 10:17:44 INFO - PROCESS | 4143 | RSS: Main: 168542208 10:17:44 INFO - PROCESS | 4143 | 10:17:47 INFO - PROCESS | 4143 | Cycle 1(1): loaded http://localhost:59434/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59434/tests/kraken/driver.html?testName=json-parse-financial) 10:17:47 INFO - PROCESS | 4143 | RSS: Main: 168529920 10:17:47 INFO - PROCESS | 4143 | 10:17:49 INFO - PROCESS | 4143 | Cycle 1(1): loaded http://localhost:59434/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59434/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:17:50 INFO - PROCESS | 4143 | RSS: Main: 168878080 10:17:50 INFO - PROCESS | 4143 | 10:17:51 INFO - PROCESS | 4143 | Cycle 1(1): loaded http://localhost:59434/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59434/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:17:52 INFO - PROCESS | 4143 | RSS: Main: 168595456 10:17:52 INFO - PROCESS | 4143 | 10:17:54 INFO - PROCESS | 4143 | Cycle 1(1): loaded http://localhost:59434/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59434/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:17:55 INFO - PROCESS | 4143 | RSS: Main: 168845312 10:17:55 INFO - PROCESS | 4143 | 10:17:57 INFO - PROCESS | 4143 | Cycle 1(1): loaded http://localhost:59434/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:17:58 INFO - PROCESS | 4143 | RSS: Main: 169172992 10:17:58 INFO - PROCESS | 4143 | 10:18:01 INFO - PROCESS | 4143 | Cycle 1(1): loaded http://localhost:59434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:18:01 INFO - PROCESS | 4143 | RSS: Main: 169017344 10:18:01 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | Cycle 1(1): loaded http://localhost:59434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59434/tests/kraken/driver.html?testName=ai-astar) 10:18:03 INFO - PROCESS | 4143 | RSS: Main: 169656320 10:18:03 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | __start_tp_report 10:18:03 INFO - PROCESS | 4143 | _x_x_mozilla_page_load 10:18:03 INFO - PROCESS | 4143 | _x_x_mozilla_page_load_details 10:18:03 INFO - PROCESS | 4143 | |i|pagename|runs| 10:18:03 INFO - PROCESS | 4143 | |0;ai-astar;112;106;113;112;114;113;111;111;114;111 10:18:03 INFO - PROCESS | 4143 | |1;audio-beat-detection;151;130;159;176;127;152;161;142;194;126 10:18:03 INFO - PROCESS | 4143 | |2;audio-dft;162;167;165;165;168;176;163;162;163;161 10:18:03 INFO - PROCESS | 4143 | |3;audio-fft;76;75;75;169;75;77;75;75;168;75 10:18:03 INFO - PROCESS | 4143 | |4;audio-oscillator;85;85;143;84;85;85;152;86;85;146 10:18:03 INFO - PROCESS | 4143 | |5;imaging-gaussian-blur;118;117;117;118;118;118;119;117;117;118 10:18:03 INFO - PROCESS | 4143 | |6;imaging-darkroom;147;147;147;148;148;147;147;147;147;146 10:18:03 INFO - PROCESS | 4143 | |7;imaging-desaturate;95;95;96;96;97;96;96;96;96;96 10:18:03 INFO - PROCESS | 4143 | |8;json-parse-financial;64;56;58;57;56;58;60;55;57;56 10:18:03 INFO - PROCESS | 4143 | |9;json-stringify-tinderbox;60;60;61;61;61;62;60;61;62;61 10:18:03 INFO - PROCESS | 4143 | |10;stanford-crypto-aes;82;79;79;81;85;89;80;81;105;83 10:18:03 INFO - PROCESS | 4143 | |11;stanford-crypto-ccm;124;124;136;144;133;122;127;124;136;128 10:18:03 INFO - PROCESS | 4143 | |12;stanford-crypto-pbkdf2;159;158;159;158;160;160;160;157;167;166 10:18:03 INFO - PROCESS | 4143 | |13;stanford-crypto-sha256-iterative;64;64;63;63;65;61;62;63;62;62 10:18:03 INFO - PROCESS | 4143 | __end_tp_report 10:18:03 INFO - PROCESS | 4143 | __start_cc_report 10:18:03 INFO - PROCESS | 4143 | _x_x_mozilla_cycle_collect,916 10:18:03 INFO - PROCESS | 4143 | __end_cc_report 10:18:03 INFO - PROCESS | 4143 | __startTimestamp1465406283821__endTimestamp 10:18:03 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | ------- Summary: start ------- 10:18:03 INFO - PROCESS | 4143 | Number of tests: 14 10:18:03 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:2.31 (2.1%) stddev-sans-first:2.45 10:18:03 INFO - PROCESS | 4143 | Values: 112.0 106.0 113.0 112.0 114.0 113.0 111.0 111.0 114.0 111.0 10:18:03 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:155.50 stddev:22.00 (14.1%) stddev-sans-first:23.33 10:18:03 INFO - PROCESS | 4143 | Values: 151.0 130.0 159.0 176.0 127.0 152.0 161.0 142.0 194.0 126.0 10:18:03 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.00 stddev:4.42 (2.7%) stddev-sans-first:4.53 10:18:03 INFO - PROCESS | 4143 | Values: 162.0 167.0 165.0 165.0 168.0 176.0 163.0 162.0 163.0 161.0 10:18:03 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:39.27 (52.4%) stddev-sans-first:41.11 10:18:03 INFO - PROCESS | 4143 | Values: 76.0 75.0 75.0 169.0 75.0 77.0 75.0 75.0 168.0 75.0 10:18:03 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:85.00 stddev:30.03 (35.3%) stddev-sans-first:31.09 10:18:03 INFO - PROCESS | 4143 | Values: 85.0 85.0 143.0 84.0 85.0 85.0 152.0 86.0 85.0 146.0 10:18:03 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:18:03 INFO - PROCESS | 4143 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 119.0 117.0 117.0 118.0 10:18:03 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 10:18:03 INFO - PROCESS | 4143 | Values: 147.0 147.0 147.0 148.0 148.0 147.0 147.0 147.0 147.0 146.0 10:18:03 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 10:18:03 INFO - PROCESS | 4143 | Values: 95.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 10:18:03 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.50 stddev:2.63 (4.6%) stddev-sans-first:1.50 10:18:03 INFO - PROCESS | 4143 | Values: 64.0 56.0 58.0 57.0 56.0 58.0 60.0 55.0 57.0 56.0 10:18:03 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 10:18:03 INFO - PROCESS | 4143 | Values: 60.0 60.0 61.0 61.0 61.0 62.0 60.0 61.0 62.0 61.0 10:18:03 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:81.50 stddev:7.85 (9.6%) stddev-sans-first:8.28 10:18:03 INFO - PROCESS | 4143 | Values: 82.0 79.0 79.0 81.0 85.0 89.0 80.0 81.0 105.0 83.0 10:18:03 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:130.50 stddev:7.16 (5.5%) stddev-sans-first:7.28 10:18:03 INFO - PROCESS | 4143 | Values: 124.0 124.0 136.0 144.0 133.0 122.0 127.0 124.0 136.0 128.0 10:18:03 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.00 stddev:3.37 (2.1%) stddev-sans-first:3.54 10:18:03 INFO - PROCESS | 4143 | Values: 159.0 158.0 159.0 158.0 160.0 160.0 160.0 157.0 167.0 166.0 10:18:03 INFO - PROCESS | 4143 | 10:18:03 INFO - PROCESS | 4143 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.20 (1.9%) stddev-sans-first:1.20 10:18:03 INFO - PROCESS | 4143 | Values: 64.0 64.0 63.0 63.0 65.0 61.0 62.0 63.0 62.0 62.0 10:18:03 INFO - PROCESS | 4143 | -------- Summary: end -------- 10:18:03 INFO - PROCESS | 4143 | 10:18:04 INFO - TEST-INFO | 4143: exit 0 10:18:04 INFO - TEST-OK | kraken | took 61559ms 10:18:04 INFO - SUITE-END | took 1172s 10:18:04 INFO - Completed test suite (00:19:32) 10:18:04 INFO - javascript benchmark 10:18:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7112.23376655252, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3129.624445066592, 3189.0911090339227, 3209.0, 3213.180638937071, 3235.094173631384, 5341.839744807652, 5387.515123638872, 5387.649802762818, 5404.32445944257, 5427.0, 5288.60335474839, 5316.9734151329285, 5322.733863306838, 5381.0, 5403.567714582834, 4811.278308253755, 4896.24108263218, 4939.0, 4978.402591688984, 5005.449400565934, 4855.198892182803, 5110.207917772733, 5128.974355128219, 5130.07658621448, 5138.306328645641, 4824.0, 4866.926996095061, 4894.5105489451125, 4952.281919121725, 4967.0810899983435, 4889.975550122226, 4920.729883338312, 4927.926081108786, 4929.260610908356, 4968.6025117990475, 4891.388576427947, 4895.199054472529, 4902.681325713817, 4905.509449055102, 4942.431620363668, 5088.898222035538, 5190.974045129788, 5200.843974680765, 5290.788368465257, 5328.573714102862, 5757.366689664133, 5796.13058041293, 5801.332846722638, 5806.912896306559, 5823.505002074829, 5851.64890106595, 5852.4440178183, 5864.325602555718, 5872.882542349129, 5873.060310350366, 5246.7638956247065, 5354.812581559627, 5370.865728356784, 5399.37907140676, 5420.403755586843, 5883.117532370179, 5887.264091988502, 5900.1739756434135, 5900.468957793819, 5916.378780228014, 5478.643888147258, 5632.943670563324, 5638.295213098363, 5648.85877853057, 5664.943350566524, 5607.046802043662, 5655.462731040627, 5679.346875109415, 5699.088145896637, 5703.857403564861, 5576.052071147915, 5660.490555849993, 5673.971630141823, 5686.943130568724, 5731.111677689882, 5801.564882633819, 5802.390748971382, 5853.414658534198, 5864.266966629171, 5866.941330586725, 4374.21264172452, 4376.3654270130655, 4433.578810013044, 4446.933296000562, 4450.8442204523335, 3923.431102490123, 3942.0933185366953, 3951.2887680217264, 3979.1444839359096, 3980.3233450313514, 5321.866953326198, 5509.228707980886, 5549.833504994856, 5559.444055594408, 5581.720913954286, 5591.41290164535, 5639.210510528529, 5659.773609055674, 5694.686792226385, 5700.201971723962, 5397.487238712316, 5398.676079435168, 5399.0, 5404.648697834628, 5406.945930540644, 4713.787879545429, 4744.525547445297, 4750.857474275777, 4777.140114779304, 4820.638452116035, 5930.11048342752, 5961.463468287875, 5983.132445795422, 5986.670733109634, 6006.6696331701305, 5783.624064435799, 5791.044477661138, 5815.04051831443, 5821.214136091573, 5822.70886455684, 5869.8553782012095, 5956.970215148896, 5957.880842383041, 5962.135490353961, 5981.222441082631, 5777.04678728022, 5778.682172480554, 5779.450952159538, 5790.94209057904, 5821.94178058214, 5848.883022339614, 5851.61964472325, 5863.032599621015, 5886.705664716833, 5896.9975104233245, 5482.095454250004, 5522.420145884625, 5533.280673512418, 5596.776128954959, 5670.0, 5513.173024046425, 5532.640378375393, 5552.944470555404, 5580.525655319181, 5628.746706398304, 5538.667679939216, 5561.805336813192, 5563.944360556343, 5565.387807341108, 5566.52684521804, 5534.252875861707, 5636.2954630671165, 5686.488216060575, 5710.229119068873, 5728.885422291614, 5613.775448982158, 5633.0705433603, 5650.180723794944, 5684.8010319638615, 5692.4876761090045], "value": 5313.703940601378, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.2716286734416, 621.7761605821903, 628.9308176100625, 642.9453496452803, 666.3869240298925, 37221.44167837481, 42521.78739106308, 42532.23540469875, 42582.57417425825, 42661.57338426615, 43718.56281437185, 44382.0, 44417.55582444175, 44429.0, 44486.77756611221, 8532.70135545256, 8639.52482613456, 8728.258098061673, 8750.649974001033, 8755.824883502326, 8506.0, 8553.101924297922, 8577.0, 8577.95711021444, 8578.270846977983, 8630.223279904807, 8659.913400865973, 8662.17709317617, 8665.826683466326, 8668.653253869837, 8546.957265213696, 8561.0, 8586.441881277728, 8590.098039705803, 8593.484390936565, 8518.70184543538, 8528.189821966904, 8559.0, 8580.785480362978, 8639.784005399852, 32958.50562241568, 40777.0, 41129.0, 41150.1769964599, 41184.0, 2953.394554116401, 3229.757768167397, 3539.6460353964653, 3895.14306852492, 4026.1947610477728, 29422.0, 29715.10854674363, 30665.0, 31070.378592428024, 31173.688263117307, 4140.730852494578, 4187.895302617429, 4288.142371525707, 4300.6989510734265, 4342.38786483484, 309365.45317273494, 310134.0, 310243.0, 310632.0, 311695.0, 32016.519752203734, 35066.824665876506, 35210.64789352125, 35334.64665353365, 35344.0, 35435.645643543234, 35577.0, 35749.821250893576, 35824.28351432957, 36033.0, 14416.42334306637, 14425.422983080769, 14470.348834302482, 14498.202598857164, 14644.19456929879, 13481.662958426117, 13561.321933903266, 13627.727445451035, 13652.590422287347, 13663.316834158253, 8094.190580941859, 8122.390820688472, 8166.959165204136, 8193.344532437392, 8208.46644968075, 3069.5549145374243, 3116.236522052112, 3147.1030756234363, 3177.602799650044, 3192.521121831744, 1033.2715435618022, 1052.7262911642874, 1065.0840277361463, 1112.1547623805966, 1146.3179408252242, 32489.350212995607, 32699.346013079605, 32966.67033329684, 33004.66995330016, 33163.3367332652, 1088.8856670049688, 1092.6612750047511, 1115.9497822598003, 1201.9939900300442, 1204.993830151833, 16485.505434836974, 17124.40064597733, 17169.0, 17211.311547538207, 17324.539621367152, 534783.0, 547714.0, 549744.0, 552278.0, 554195.0, 57784.4221557779, 58341.12488312679, 58471.70764146152, 58647.0, 58761.41238587645, 1347.3196036001953, 1369.7808350664045, 1382.7856682214274, 1398.6013986013936, 1398.664320563037, 30373.544396834506, 31220.43897805146, 31732.67916732863, 31858.522122167724, 32142.196445088124, 50477.49522504875, 50712.74643626758, 50830.74584627053, 50888.236676449145, 51084.0, 438285.0, 439846.0, 440223.0, 441181.0, 441736.0, 28229.858850705616, 28354.574681380207, 28531.14406567806, 28576.57135143016, 28666.283342916595, 44169.77915110404, 48103.27845082257, 48899.51100488949, 50170.49829501658, 50299.24551131809, 40805.183896321316, 41321.586784131774, 41773.66140636806, 42702.145957080065, 42834.357484637134, 40382.79808600938, 40950.795246023576, 41044.0, 41344.0, 41351.79324103481, 40330.596694033855, 41125.383119252634, 41510.0, 41544.37683434811, 43842.56157438512, 33545.49681754727, 36905.0, 37275.62724372721, 37431.81284093562, 37946.0, 27638.86180569084, 27658.585121222794, 27660.308492287048, 28037.0, 28116.43767124687], "value": 18494.41148005356, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.8832206177117, 388.80365415465184, 390.7362530292052, 394.92299001694664, 416.0, 17858.553536161588, 18597.349092781722, 19276.132574034167, 19304.0, 19345.70981435278, 18058.0, 18427.72358414625, 18524.536886577844, 18605.627887442242, 18807.811921880777, 5494.80768173114, 5507.476789704971, 5648.700012935184, 5651.604387692863, 5735.369109397963, 5572.192032155355, 5595.076812325961, 5598.1322894951145, 5601.915971260434, 5602.60781745278, 5394.487523685244, 5529.060059789846, 5575.526080283181, 5610.438956104398, 5612.971935140339, 5563.415841336642, 5575.637583557076, 5589.692566908819, 5607.523360514361, 5612.102063669814, 4880.463149053601, 5021.719461537321, 5027.019731152427, 5029.421616514074, 5047.520485553903, 21882.23412180582, 22245.0, 22360.888195558917, 22654.207102751323, 22730.88634556833, 2304.331743794298, 2405.434722840131, 2442.1818690738623, 2529.519391315644, 2546.7835234005133, 13933.651658708512, 13991.0, 14072.507462238875, 14138.08102473336, 14264.928675356558, 1887.4149013805763, 1889.3576184097335, 1970.4088773367932, 1986.145957238387, 1989.3634037108131, 77208.0, 79482.6025869867, 80720.99999999942, 81678.59160704158, 81868.59065704692, 10181.21828679978, 10300.939812037472, 10462.424566648755, 10529.788084766154, 10641.148708103334, 14506.782398264035, 14566.19885906264, 14566.635834104232, 14583.781243281359, 14616.26918654063, 7658.693652253847, 7990.121086680577, 8032.196780321921, 8104.675812967415, 8170.142135075732, 7653.425993050543, 7696.0, 7810.906473093772, 7834.647440865175, 7850.489718168301, 6378.521610879203, 6533.640649764214, 6622.966885165543, 6662.300458451889, 6670.365760388736, 1852.8888266704041, 1868.6921651760065, 1876.3151449720754, 1900.8859468431938, 1923.4806602217323, 967.2503809547657, 1006.0794373148633, 1027.664036752219, 1088.7931293054294, 1130.6438471881331, 18106.909465452587, 18415.355462558746, 18902.905485472485, 19035.904820475807, 19194.69994853843, 1017.9083882450615, 1033.1270076785104, 1039.2673165418362, 1076.6178006807627, 1076.7200527862813, 10489.685309440729, 10928.672139835817, 10979.341239525655, 10979.451027448597, 11038.779224415466, 462803.0, 472783.0, 474191.0, 477121.0, 479529.0, 75924.24075759172, 80896.0, 82985.17014829894, 83191.0, 83942.0, 1053.373242920461, 1054.1092776603757, 1057.6932689520106, 1059.4384975962753, 1065.3235195650818, 15650.843491565394, 16258.0, 16729.91635041817, 16804.831951680328, 16837.831621684116, 41347.793261033505, 42395.364069539595, 43362.0, 43430.131397372505, 44128.11743765043, 57440.71279643575, 57954.710226448595, 58552.4144758564, 58585.0, 58680.70659646674, 8142.145074767301, 8261.917380826115, 8284.757286406846, 8491.83016339682, 8576.44253123545, 9232.815343693223, 11023.897610238912, 11598.652040438801, 12610.369481525704, 12645.683857903627, 11122.833157502482, 11293.604723834625, 11446.198766086294, 11497.19519633651, 11527.8270825936, 9280.767980800534, 11190.32858028521, 11277.266977646756, 11302.321860688386, 11428.0, 11276.661700148681, 11302.265352752045, 11413.315201087962, 11475.598354057567, 11821.527138914347, 8233.752987410388, 8271.875921861056, 8283.83432331362, 8329.583520823813, 8414.915850841659, 10520.631777887736, 11001.22991390595, 11120.0, 11595.884041159481, 11631.59289424866], "value": 9171.630362862546, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.5223928342928, 1508.8264849542302, 1612.2583611538691, 1681.2938565802363, 1760.683077046131, 7748.380129589634, 8290.70982515612, 8576.271016963557, 8824.91175088249, 8842.336824738146, 8628.568571571428, 8756.474611523314, 8802.955985220065, 8836.293096552277, 8844.867326990101, 2215.1139544182374, 2266.3087758233733, 2270.1713874435877, 2277.453411181321, 2281.646344816556, 2246.618074927258, 2260.9773902261013, 2291.129370839087, 2298.6781850540856, 2306.400335912658, 2054.6917962305624, 2066.3904148276297, 2069.896505174735, 2201.1635578480236, 2259.164109279569, 2118.4641135177026, 2122.1829595605727, 2137.1237792505076, 2137.5190582119053, 2148.0870629982273, 2140.7645159032495, 2144.839137064711, 2162.9783702162936, 2163.891805409739, 2167.8916054197384, 8551.657933682707, 8642.395032347738, 8662.220400164015, 8669.523176225304, 8712.0, 4789.473157952622, 4940.407151141886, 4955.231939049453, 4959.70241785494, 4970.726610036447, 3122.3078187169313, 3187.2509960159346, 3230.6769323067506, 3231.434498962672, 3248.5127230915314, 1082.3830416662506, 1095.583678202278, 1120.9495572699248, 1123.4775829239443, 1133.3086817041599, 12223.633291001284, 12255.632331029994, 12259.816102758467, 12273.570425035081, 12300.8154877676, 4290.764007979591, 4382.23310920594, 4384.846530371422, 4424.778761061998, 4446.599806017474, 10226.079652831133, 10298.3820970742, 10328.277020608635, 10341.844872326921, 10344.741381465523, 4984.177610694195, 4992.226204938241, 5017.37282839645, 5022.84931452057, 5024.6733962293065, 4139.606737359946, 4517.503074661785, 4546.681732278775, 4621.260598304322, 4718.268668356411, 3806.7525610835205, 3837.347650899354, 3908.8241029153755, 3927.273454410943, 3932.2921874062945, 1189.8631657359342, 1207.4264724255909, 1224.1859163656247, 1232.4761976160096, 1241.845084071822, 809.4495742894889, 889.6308032166578, 957.1816097236901, 972.3776782858835, 995.3281534964016, 5877.882442351129, 5924.881502369928, 5980.431858973478, 6005.609635373687, 6075.969620151959, 432.414078923061, 432.6949500602131, 436.49366734587727, 448.7957979119493, 454.7453426081405, 4038.7980600969836, 4175.436316097349, 4204.51648060477, 4218.093109981369, 4236.809343579546, 10863.07663848566, 11127.499262533205, 11254.0, 11258.887411125948, 11261.831072533918, 11034.889651103385, 11082.722931926766, 11123.443827808576, 11139.832902506469, 11185.72035699114, 7839.412044096715, 8221.712240071689, 8310.0, 8359.874601880976, 8398.412111152284, 5894.646321220741, 5960.701964901651, 5985.221921150222, 6138.662373569497, 6205.0, 10123.392596444237, 10200.132988695746, 10399.636012739518, 10408.895911040792, 10423.166146708396, 10004.449755263531, 10371.27401081917, 10564.260501764802, 10627.04356607909, 10656.200784941315, 6978.511504194657, 7687.423443241667, 7737.11023232313, 7866.803329916798, 7944.920550794418, 8569.657213711382, 8609.69866054685, 8618.267447267053, 8641.395102343027, 8650.480971141751, 7592.4305677073335, 7619.1999840016, 7631.0, 7720.729774457867, 7906.288434040964, 7527.962360188164, 7570.0, 7619.733309334369, 7738.264864837832, 7792.220777922163, 6945.722171113301, 6973.930260697328, 6979.5114341997605, 7030.859382812213, 7051.083359163276, 4892.290617860462, 5012.874678133076, 5089.923651145162, 5122.385313762373, 5168.147255702917, 4986.301917731448, 5033.6476446648385, 5290.761915713725, 5375.569954403716, 5548.750306236309], "value": 4473.14141378514, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.9630892447368, 324.3998602585217, 330.47289573130865, 332.94839299908523, 336.89893032090396, 5625.1843482694985, 5670.610700378403, 5706.629069110505, 5715.542756579474, 5718.653823094447, 5580.944190558103, 5593.0, 5595.776168953247, 5616.157576363547, 5624.3531993820725, 4157.33482642778, 4259.424977628027, 4368.584984426474, 4378.737275763448, 4394.736315821045, 4378.6715996300245, 4388.517263101056, 4402.8679139625865, 4403.361512580674, 4409.316555933835, 4345.760983145926, 4370.6940514164025, 4370.956290437102, 4371.191329604034, 4388.451443569554, 4305.913881722364, 4333.198358303724, 4348.21732088224, 4352.216601011816, 4354.651627869763, 3780.206156707095, 3817.3701339278987, 3819.7899115548635, 3830.425436184567, 3837.194189220267, 5386.353637563518, 5419.945800541984, 5439.93921185369, 5481.150421684645, 5501.5323697485765, 4751.857444276643, 4973.204287314013, 4986.202207646796, 4996.725180115092, 5035.62232832539, 5832.795852145197, 5834.474897259267, 5856.853578660568, 5902.291724992985, 5938.198343223696, 4241.830326786956, 4251.27728286189, 4253.638440732541, 4262.552431994658, 4271.530131685512, 5923.644581325091, 6055.5646331258995, 6058.545609079337, 6086.817395478099, 6113.480354169857, 4307.289297265916, 4312.482502099768, 4349.630281426051, 4350.195213885441, 4387.100644367897, 4371.650267978554, 4398.868033958986, 4400.625946794495, 4408.55914408563, 4433.202023635777, 4693.577578017995, 4957.157283261854, 4975.228839529878, 4982.476839931827, 5047.873803154877, 5905.291365036223, 5919.3192782829665, 5932.584719069624, 5937.228160339128, 5943.167956486095, 1492.7984722062383, 1495.5961890289777, 1515.628670975618, 1521.193767303331, 1522.8933974621891, 970.7281961050917, 1002.0730823987782, 1005.1958433253368, 1027.5838285494387, 1034.534459493231, 5709.257796486513, 5728.713564321851, 5774.740136693859, 5779.653220806765, 5804.4195580442465, 6036.909446358308, 6093.66484843329, 6116.724747386378, 6120.265568131853, 6144.29650953579, 5562.638428502215, 5578.581606379456, 5700.914486282709, 5733.197352370671, 5759.424057594291, 3266.6406695263504, 3277.115178901683, 3287.4575695010535, 3300.3234336960863, 3301.372739179596, 6053.636781793107, 6209.5963762356205, 6218.31598524162, 6242.781502647476, 6250.562460627712, 6102.176206212193, 6124.448799608057, 6161.96919015411, 6169.691515424211, 6251.624902505864, 5977.193078934375, 6219.720112594944, 6220.200909590702, 6229.972054610938, 6256.624602523863, 5989.850253743517, 6095.664738439251, 6111.297200821962, 6123.234595675541, 6128.571000030133, 5969.850753731192, 5993.022302640205, 6023.728932198149, 6046.879062418639, 6057.7879774207695, 5895.7052147393315, 6129.478994285536, 6140.635855195693, 6154.723037463235, 6174.0, 4166.0834616384345, 4178.767263657168, 4194.895127621712, 4203.201391735561, 4232.555581663881, 5944.3164036136395, 5967.37342579023, 5999.940000599938, 6014.428629280212, 6065.484433823174, 5790.884182316246, 5819.912701309569, 5833.67914764692, 5854.385289544536, 5883.588148829712, 5718.485336319751, 5768.221290125947, 5787.681677507778, 5812.76748930055, 5819.79630712923, 5216.634835561475, 5731.197632331394, 5741.540676745767, 5779.2775903012125, 5789.1605717171615, 5924.526037917042, 5926.970365148147, 5943.316518600243, 5952.910706339495, 5968.4031596841705, 5663.3770285267765, 5860.472557469848, 5882.382349853204, 5903.439173278532, 5909.645421274738], "value": 4483.632970588208, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.9828254293642, 706.4489698035533, 708.4474110194047, 725.1479511573899, 758.1016495452889, 14427.567172984815, 14634.707305853877, 14641.853581464182, 14704.558863234106, 14794.334254958525, 14505.347259373328, 14706.11763294203, 14726.852731472682, 14751.77872331916, 14757.557273281818, 673.9629320387389, 770.1412924589071, 792.6829268292671, 795.5862951265339, 795.6658203554521, 804.9839003219932, 808.3815880851154, 809.0453265147124, 809.6397103289039, 817.0685418622775, 860.8708693695964, 862.6118246788939, 862.7153039496982, 864.4813112132733, 866.2550206822128, 849.838530679169, 850.3834719828106, 850.5917159763318, 854.4104567848227, 857.2456238510102, 619.6127420362274, 620.4632992461488, 622.5424313129846, 623.0747340199799, 624.7032659486707, 13761.793573096411, 13771.586852394445, 13786.586402407944, 13794.724105517833, 13810.0, 14735.705285894222, 15152.772708409382, 15174.620634484116, 15327.923360383238, 15491.147986860718, 12302.75394492105, 12317.876821231763, 12515.061370397256, 12532.937335313265, 12567.308798016105, 3798.2593394288124, 3929.8603405012514, 3931.429942658327, 3976.681865450757, 3988.561258261589, 69263.3073669262, 70435.64782176107, 70525.29474705238, 71642.0, 76266.23733762647, 11240.662780116609, 11307.830382544269, 11644.53421863133, 11948.223365481215, 12243.08176886737, 21320.0, 21364.78635213659, 21429.89285053565, 22117.557648847254, 24103.638445423334, 8097.797555061053, 8183.059700748641, 8286.917130828735, 8299.875501867476, 8407.70573029941, 4359.825606975685, 4365.934510982338, 4400.933985990213, 4429.601335879786, 4532.138893610204, 3195.680431956786, 3323.8670453181603, 3329.001299610156, 3333.983330083334, 3342.649021852719, 585.6866576381616, 590.3948452835878, 600.1088383750127, 605.0802779774717, 606.0787602843653, 579.4326101119311, 633.9666343859479, 654.4125678990313, 691.6714560583682, 726.1436514510561, 8668.78328041804, 8890.288776897833, 9016.18854303116, 9168.587413566405, 9257.722268331961, 667.6361383046251, 674.357938419949, 677.7322957431787, 683.7555648719382, 689.6379400814512, 4253.659707223414, 4431.7562534060935, 4481.843135490242, 4483.75339356332, 4522.66080043998, 70661.2933870665, 72614.63692681503, 72947.0, 115721.0, 115812.0, 99637.50181249193, 99686.0, 100190.49904750576, 101301.49349253354, 101699.0, 67977.66011169912, 88189.55905220562, 88366.55816720876, 88578.55710721534, 88579.0, 8282.213189746964, 8453.239208471266, 8618.439801412887, 8660.13398660129, 8901.955490222508, 51717.7414112927, 52014.47985520097, 52905.20642190447, 53009.20486192787, 53496.0, 67079.66460167668, 76658.0, 78671.21328786638, 79160.60419698094, 81304.5934770346, 10804.783904322027, 10951.671449856518, 11007.559697612005, 11129.888701113208, 11177.832332515181, 11872.584459543874, 12388.194767340094, 12495.000399968163, 12637.431315591004, 12791.936040319739, 11024.44877756125, 11168.776624467628, 12193.207441516273, 12263.69340766488, 12395.380230988594, 11188.720281993015, 11757.235779674294, 11761.588344407905, 11857.16999810005, 12216.0, 11333.26333788301, 11638.312444695302, 11818.586349477728, 11874.940625296818, 12195.512179513074, 9368.765780855532, 9568.1625740897, 9586.233101352014, 9649.324547281623, 9831.754206144904, 9805.0, 9845.45849978258, 9874.0, 9915.851262231217, 9948.204143668634], "value": 7159.261919976238, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 113.0, 112.0, 114.0, 113.0, 111.0, 111.0, 114.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 130.0, 159.0, 176.0, 127.0, 152.0, 161.0, 142.0, 194.0, 126.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 165.0, 165.0, 168.0, 176.0, 163.0, 162.0, 163.0, 161.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 169.0, 75.0, 77.0, 75.0, 75.0, 168.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 143.0, 84.0, 85.0, 85.0, 152.0, 86.0, 85.0, 146.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 119.0, 117.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 56.0, 58.0, 57.0, 56.0, 58.0, 60.0, 55.0, 57.0, 56.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 61.0, 61.0, 62.0, 60.0, 61.0, 62.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 79.0, 81.0, 85.0, 89.0, 80.0, 81.0, 105.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 136.0, 144.0, 133.0, 122.0, 127.0, 124.0, 136.0, 128.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 159.0, 158.0, 160.0, 160.0, 160.0, 157.0, 167.0, 166.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 65.0, 61.0, 62.0, 63.0, 62.0, 62.0], "value": 62.9, "unit": "score"}]}]} 10:18:05 INFO - Return code: 0 10:18:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:18:05 ERROR - # TBPL SUCCESS # 10:18:05 INFO - Running post-action listener: _resource_record_post_action 10:18:05 INFO - ##### 10:18:05 INFO - ##### Finished run-tests step (success) 10:18:05 INFO - ##### 10:18:05 INFO - Running post-run listener: _resource_record_post_run 10:18:05 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541392896; Read time: 4; Write time: 428220 10:18:05 INFO - TinderboxPrint: CPU usage
13.4% 10:18:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 10:18:05 INFO - TinderboxPrint: I/O write bytes / time
541,392,896 / 428,220 10:18:05 INFO - TinderboxPrint: CPU idle
8,228.5 (86.6%) 10:18:05 INFO - TinderboxPrint: CPU user
1,221.8 (12.9%) 10:18:05 INFO - TinderboxPrint: Swap in / out
0 / 0 10:18:05 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248467456; Read time: 0; Write time: 234404 10:18:05 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292925440; Read time: 4; Write time: 193816 10:18:05 INFO - Running post-run listener: _upload_blobber_files 10:18:05 INFO - Blob upload gear active. 10:18:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:18:05 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 10:18:05 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'] 10:18:05 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 10:18:06 INFO - (blobuploader) - INFO - Open directory for files ... 10:18:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:18:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:18:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:06 INFO - (blobuploader) - INFO - Done attempting. 10:18:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:18:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:18:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:07 INFO - (blobuploader) - INFO - Done attempting. 10:18:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:18:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:18:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:11 INFO - (blobuploader) - INFO - Done attempting. 10:18:11 INFO - (blobuploader) - INFO - Iteration through files over. 10:18:11 INFO - Return code: 0 10:18:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:18:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:18:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4910b621bb789e00cd8edf2e19cbc818083bfbf312534fe302985ba9759da6ee0971c0f16fb8b83d656b4c03c0316e14894cd7633ee8d3c9bd3923373d6ba4fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/15f40e37febf2042b11752657fe2f25ceceb146ffdf0452d09ebb3d6df3e286db00d326cb48bb7495c9220cac958af20dc7b3493f24a9578468cf2f49bd48592", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ece01eb0ac17791b2924e5a182f2f7f9c71cb4a319bd600b00e577aa2229ff5fa670f9fc165c5bcb7d825ef5caea3ca3573c3887043495c636ff353967c912f1"} 10:18:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:18:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:18:11 INFO - Contents: 10:18:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4910b621bb789e00cd8edf2e19cbc818083bfbf312534fe302985ba9759da6ee0971c0f16fb8b83d656b4c03c0316e14894cd7633ee8d3c9bd3923373d6ba4fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/15f40e37febf2042b11752657fe2f25ceceb146ffdf0452d09ebb3d6df3e286db00d326cb48bb7495c9220cac958af20dc7b3493f24a9578468cf2f49bd48592", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ece01eb0ac17791b2924e5a182f2f7f9c71cb4a319bd600b00e577aa2229ff5fa670f9fc165c5bcb7d825ef5caea3ca3573c3887043495c636ff353967c912f1"} 10:18:11 INFO - Running post-run listener: copy_logs_to_upload_dir 10:18:11 INFO - Copying logs to upload dir... 10:18:11 INFO - mkdir: /builds/slave/test/build/upload/logs 10:18:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.377187 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-08 10:18:11.078809) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 10:18:11.082737) ========= 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=41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446 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/4910b621bb789e00cd8edf2e19cbc818083bfbf312534fe302985ba9759da6ee0971c0f16fb8b83d656b4c03c0316e14894cd7633ee8d3c9bd3923373d6ba4fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/15f40e37febf2042b11752657fe2f25ceceb146ffdf0452d09ebb3d6df3e286db00d326cb48bb7495c9220cac958af20dc7b3493f24a9578468cf2f49bd48592", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ece01eb0ac17791b2924e5a182f2f7f9c71cb4a319bd600b00e577aa2229ff5fa670f9fc165c5bcb7d825ef5caea3ca3573c3887043495c636ff353967c912f1"} build_url:https://queue.taskcluster.net/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011446 build_url: 'https://queue.taskcluster.net/v1/task/QNiILmhyTqaPvgb1y4xOyw/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/4910b621bb789e00cd8edf2e19cbc818083bfbf312534fe302985ba9759da6ee0971c0f16fb8b83d656b4c03c0316e14894cd7633ee8d3c9bd3923373d6ba4fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/15f40e37febf2042b11752657fe2f25ceceb146ffdf0452d09ebb3d6df3e286db00d326cb48bb7495c9220cac958af20dc7b3493f24a9578468cf2f49bd48592", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ece01eb0ac17791b2924e5a182f2f7f9c71cb4a319bd600b00e577aa2229ff5fa670f9fc165c5bcb7d825ef5caea3ca3573c3887043495c636ff353967c912f1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 10:18:11.108732) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 10:18:11.109090) ========= 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=41bf3e9aed84707956354da8000001c5-1465405056.514307-649161446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 10:18:11.193651) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 10:18:11.194015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 10:18:11.194413) ========= ========= Total master_lag: 0.18 =========