builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1465405102.69 results: success (0) buildid: 20160608071315 builduid: 2f74231857e54e4d872f371e682b3ef8 revision: f22cca9ad502563f7e15a5a44c4bf9d04ad2e87f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 09:58:22.685678) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 09:58:22.686222) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 09:58:22.686555) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 09:58:22.701661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 09:58:22.701964) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 09:58:22-- 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.1M=0s 2016-06-08 09:58:22 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071376 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 09:58:22.787795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 09:58:22.788180) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017723 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 09:58:22.837967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 09:58:22.838377) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 09:58:23,050 truncating revision to first 12 chars 2016-06-08 09:58:23,050 Setting DEBUG logging. 2016-06-08 09:58:23,050 attempt 1/10 2016-06-08 09:58:23,050 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:58:24,569 unpacking tar archive at: mozilla-inbound-f22cca9ad502/testing/mozharness/ program finished with exit code 0 elapsedTime=1.872532 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 09:58:24.728624) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 09:58:24.729442) ========= script_repo_revision: f22cca9ad502563f7e15a5a44c4bf9d04ad2e87f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 09:58:24.730387) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 09:58:24.731093) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 09:58:24.742804) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-08 09:58:24.743119) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:58:25 INFO - MultiFileLogger online at 20160608 09:58:25 in /builds/slave/test 09:58:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:58:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:58:25 INFO - {'append_to_log': False, 09:58:25 INFO - 'base_work_dir': '/builds/slave/test', 09:58:25 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:58:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:58:25 INFO - 'branch': 'Mozilla-Inbound', 09:58:25 INFO - 'buildbot_json_path': 'buildprops.json', 09:58:25 INFO - 'config_files': ('talos/linux_config.py',), 09:58:25 INFO - 'default_actions': ('clobber', 09:58:25 INFO - 'read-buildbot-config', 09:58:25 INFO - 'download-and-extract', 09:58:25 INFO - 'populate-webroot', 09:58:25 INFO - 'create-virtualenv', 09:58:25 INFO - 'install', 09:58:25 INFO - 'run-tests'), 09:58:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:58:25 INFO - 'download_minidump_stackwalk': True, 09:58:25 INFO - 'download_symbols': 'ondemand', 09:58:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:58:25 INFO - 'tooltool.py': '/tools/tooltool.py', 09:58:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:58:25 INFO - '/tools/misc-python/virtualenv.py')}, 09:58:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:58:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:58:25 INFO - 'installer_path': 'installer.exe', 09:58:25 INFO - 'log_level': 'info', 09:58:25 INFO - 'log_name': 'talos', 09:58:25 INFO - 'log_to_console': True, 09:58:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:58:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:58:25 INFO - 'opt_config_files': (), 09:58:25 INFO - 'pip_index': False, 09:58:25 INFO - 'sps_profile': False, 09:58:25 INFO - 'sps_profile_interval': 0, 09:58:25 INFO - 'suite': 'dromaeojs', 09:58:25 INFO - 'system_bits': '32', 09:58:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:58:25 INFO - 'title': 'talos-linux64-ix-060', 09:58:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:58:25 INFO - 'use_talos_json': True, 09:58:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:58:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:58:25 INFO - 'work_dir': 'build'} 09:58:25 INFO - ##### 09:58:25 INFO - ##### Running clobber step. 09:58:25 INFO - ##### 09:58:25 INFO - Running pre-action listener: _resource_record_pre_action 09:58:25 INFO - Running main action method: clobber 09:58:25 INFO - rmtree: /builds/slave/test/build 09:58:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:58:25 INFO - Running post-action listener: _resource_record_post_action 09:58:25 INFO - ##### 09:58:25 INFO - ##### Finished clobber step (success) 09:58:25 INFO - ##### 09:58:25 INFO - ##### 09:58:25 INFO - ##### Running read-buildbot-config step. 09:58:25 INFO - ##### 09:58:25 INFO - Running pre-action listener: _resource_record_pre_action 09:58:25 INFO - Running main action method: read_buildbot_config 09:58:25 INFO - Using buildbot properties: 09:58:25 INFO - { 09:58:25 INFO - "project": "", 09:58:25 INFO - "product": "firefox", 09:58:25 INFO - "script_repo_revision": "production", 09:58:25 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 09:58:25 INFO - "repository": "", 09:58:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 09:58:25 INFO - "buildid": "20160608071315", 09:58:25 INFO - "pgo_build": "True", 09:58:25 INFO - "basedir": "/builds/slave/test", 09:58:25 INFO - "buildnumber": 1072, 09:58:25 INFO - "slavename": "talos-linux64-ix-060", 09:58:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:58:25 INFO - "platform": "ubuntu64_hw", 09:58:25 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:58:25 INFO - "branch": "mozilla-inbound", 09:58:25 INFO - "repo_path": "integration/mozilla-inbound", 09:58:25 INFO - "revision": "f22cca9ad502563f7e15a5a44c4bf9d04ad2e87f", 09:58:25 INFO - "stage_platform": "linux64-pgo", 09:58:25 INFO - "builduid": "2f74231857e54e4d872f371e682b3ef8", 09:58:25 INFO - "slavebuilddir": "test" 09:58:25 INFO - } 09:58:25 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:58:25 INFO - Running post-action listener: _resource_record_post_action 09:58:25 INFO - ##### 09:58:25 INFO - ##### Finished read-buildbot-config step (success) 09:58:25 INFO - ##### 09:58:25 INFO - ##### 09:58:25 INFO - ##### Running download-and-extract step. 09:58:25 INFO - ##### 09:58:25 INFO - Running pre-action listener: _resource_record_pre_action 09:58:25 INFO - Running main action method: download_and_extract 09:58:25 INFO - mkdir: /builds/slave/test/build/tests 09:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:25 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:58:25 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:58:25 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:58:25 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:58:25 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:58:26 INFO - Downloaded 1361 bytes. 09:58:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:58:26 INFO - Using the following test package requirements: 09:58:26 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:58:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:58:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:58:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:26 INFO - u'jsshell-linux-x86_64.zip'], 09:58:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:58:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:58:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:58:26 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:58:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:58:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:58:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:26 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:58:26 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:58:26 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:58:26 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:58:26 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:58:27 INFO - Downloaded 24450192 bytes. 09:58:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:58:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:58:28 INFO - Return code: 0 09:58:28 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:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:28 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:58:28 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:58:28 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:58:28 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:58:28 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:58:29 INFO - Downloaded 24450192 bytes. 09:58:29 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:58:29 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:58:31 INFO - Return code: 0 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 - 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:58:31 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:58:31 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:58:31 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:58:31 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:58:32 INFO - Downloaded 10833369 bytes. 09:58:32 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:58:32 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:58:32 INFO - Return code: 0 09:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:32 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:58:32 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:58:32 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:58:32 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:58:32 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:58:33 INFO - Downloaded 59270824 bytes. 09:58:33 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:58:33 INFO - mkdir: /builds/slave/test/properties 09:58:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:58:33 INFO - Writing to file /builds/slave/test/properties/build_url 09:58:33 INFO - Contents: 09:58:33 INFO - build_url:https://queue.taskcluster.net/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:58:34 INFO - Running post-action listener: _resource_record_post_action 09:58:34 INFO - Running post-action listener: set_extra_try_arguments 09:58:34 INFO - ##### 09:58:34 INFO - ##### Finished download-and-extract step (success) 09:58:34 INFO - ##### 09:58:34 INFO - ##### 09:58:34 INFO - ##### Running populate-webroot step. 09:58:34 INFO - ##### 09:58:34 INFO - Running pre-action listener: _resource_record_pre_action 09:58:34 INFO - Running main action method: populate_webroot 09:58:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:58:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:58:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:58:34 INFO - '--tppagecycles', 09:58:34 INFO - '7'], 09:58:34 INFO - 'tests': ['tsvgm']}}, 09:58:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:58:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:58:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:58:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:58:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:58:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:58:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:34 INFO - 'talos_options': ['--disable-e10s'], 09:58:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:34 INFO - 'talos_options': ['--disable-e10s'], 09:58:34 INFO - 'tests': ['damp', 'tps']}, 09:58:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:34 INFO - 'tests': ['damp', 'tps']}, 09:58:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:58:34 INFO - 'tests': ['dromaeo_dom']}, 09:58:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:58:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:58:34 INFO - 'tests': ['a11yr', 09:58:34 INFO - 'ts_paint', 09:58:34 INFO - 'tpaint', 09:58:34 INFO - 'sessionrestore', 09:58:34 INFO - 'sessionrestore_no_auto_restore', 09:58:34 INFO - 'tabpaint']}, 09:58:34 INFO - 'other-e10s': {'tests': ['a11yr', 09:58:34 INFO - 'ts_paint', 09:58:34 INFO - 'tpaint', 09:58:34 INFO - 'sessionrestore', 09:58:34 INFO - 'sessionrestore_no_auto_restore', 09:58:34 INFO - 'tabpaint']}, 09:58:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:58:34 INFO - 'ts_paint', 09:58:34 INFO - 'tpaint', 09:58:34 INFO - 'sessionrestore', 09:58:34 INFO - 'sessionrestore_no_auto_restore', 09:58:34 INFO - 'tabpaint']}, 09:58:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:58:34 INFO - 'ts_paint', 09:58:34 INFO - 'tpaint', 09:58:34 INFO - 'sessionrestore', 09:58:34 INFO - 'sessionrestore_no_auto_restore', 09:58:34 INFO - 'tabpaint']}, 09:58:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:58:34 INFO - 'tests': ['a11yr', 09:58:34 INFO - 'ts_paint', 09:58:34 INFO - 'tpaint', 09:58:34 INFO - 'sessionrestore', 09:58:34 INFO - 'sessionrestore_no_auto_restore', 09:58:34 INFO - 'tabpaint']}, 09:58:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:58:34 INFO - 'tests': ['a11yr', 09:58:34 INFO - 'ts_paint', 09:58:34 INFO - 'tpaint', 09:58:34 INFO - 'sessionrestore', 09:58:34 INFO - 'sessionrestore_no_auto_restore', 09:58:34 INFO - 'tabpaint']}, 09:58:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:58:34 INFO - 'tests': ['tsvgx', 09:58:34 INFO - 'tsvgr_opacity', 09:58:34 INFO - 'tart', 09:58:34 INFO - 'tscrollx', 09:58:34 INFO - 'cart']}, 09:58:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:58:34 INFO - 'tsvgr_opacity', 09:58:34 INFO - 'tart', 09:58:34 INFO - 'tscrollx', 09:58:34 INFO - 'cart']}, 09:58:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:34 INFO - 'talos_options': ['--disable-e10s'], 09:58:34 INFO - 'tests': ['tp5o']}, 09:58:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:34 INFO - 'tests': ['tp5o']}, 09:58:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:34 INFO - 'talos_options': ['--disable-e10s', 09:58:34 INFO - '--xperf_path', 09:58:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:34 INFO - 'tests': ['tp5n']}, 09:58:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:34 INFO - 'talos_options': ['--xperf_path', 09:58:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:34 INFO - 'tests': ['tp5n']}}, 09:58:34 INFO - 'talos.zip': {'path': '', 09:58:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:58:34 INFO - Running post-action listener: _resource_record_post_action 09:58:34 INFO - ##### 09:58:34 INFO - ##### Finished populate-webroot step (success) 09:58:34 INFO - ##### 09:58:34 INFO - ##### 09:58:34 INFO - ##### Running create-virtualenv step. 09:58:34 INFO - ##### 09:58:34 INFO - Running pre-action listener: _resource_record_pre_action 09:58:34 INFO - Running main action method: create_virtualenv 09:58:34 INFO - Creating virtualenv /builds/slave/test/build/venv 09:58:34 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:58:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:58:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:58:34 INFO - Using real prefix '/usr' 09:58:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:58:35 INFO - Installing distribute.............................................................................................................................................................................................done. 09:58:37 INFO - Installing pip.................done. 09:58:37 INFO - Return code: 0 09:58:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2920aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2858e20>, '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 0x285c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285c830>, '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': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', '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:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:58:37 INFO - Using env: {'DISPLAY': ':0', 09:58:37 INFO - 'HOME': '/home/cltbld', 09:58:37 INFO - 'LANG': 'en_US.UTF-8', 09:58:37 INFO - 'LANGUAGE': 'en_US:en', 09:58:37 INFO - 'LOGNAME': 'cltbld', 09:58:37 INFO - 'MAIL': '/var/mail/cltbld', 09:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:37 INFO - 'MOZ_NO_REMOTE': '1', 09:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:37 INFO - 'NO_EM_RESTART': '1', 09:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:37 INFO - 'PWD': '/builds/slave/test', 09:58:37 INFO - 'SHELL': '/bin/bash', 09:58:37 INFO - 'SHLVL': '1', 09:58:37 INFO - 'TERM': 'linux', 09:58:37 INFO - 'TMOUT': '86400', 09:58:37 INFO - 'USER': 'cltbld', 09:58:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', 09:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:37 INFO - '_': '/tools/buildbot/bin/python'} 09:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:37 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:58:37 INFO - Cleaning up... 09:58:37 INFO - Return code: 0 09:58:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2920aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2858e20>, '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 0x285c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285c830>, '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': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', '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:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:58:37 INFO - Using env: {'DISPLAY': ':0', 09:58:37 INFO - 'HOME': '/home/cltbld', 09:58:37 INFO - 'LANG': 'en_US.UTF-8', 09:58:37 INFO - 'LANGUAGE': 'en_US:en', 09:58:37 INFO - 'LOGNAME': 'cltbld', 09:58:37 INFO - 'MAIL': '/var/mail/cltbld', 09:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:37 INFO - 'MOZ_NO_REMOTE': '1', 09:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:37 INFO - 'NO_EM_RESTART': '1', 09:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:37 INFO - 'PWD': '/builds/slave/test', 09:58:37 INFO - 'SHELL': '/bin/bash', 09:58:37 INFO - 'SHLVL': '1', 09:58:37 INFO - 'TERM': 'linux', 09:58:37 INFO - 'TMOUT': '86400', 09:58:37 INFO - 'USER': 'cltbld', 09:58:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', 09:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:37 INFO - '_': '/tools/buildbot/bin/python'} 09:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:37 INFO - Downloading/unpacking psutil>=3.1.1 09:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:58:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:39 INFO - Installing collected packages: psutil 09:58:39 INFO - Running setup.py install for psutil 09:58:39 INFO - building 'psutil._psutil_linux' extension 09:58:39 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:58:39 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:58:39 INFO - building 'psutil._psutil_posix' extension 09:58:39 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:58:39 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:58:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:39 INFO - Successfully installed psutil 09:58:39 INFO - Cleaning up... 09:58:40 INFO - Return code: 0 09:58:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:58: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:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:40 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 0x7f2920aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2858e20>, '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 0x285c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285c830>, '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': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', '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:40 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:58:40 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:58:40 INFO - Using env: {'DISPLAY': ':0', 09:58:40 INFO - 'HOME': '/home/cltbld', 09:58:40 INFO - 'LANG': 'en_US.UTF-8', 09:58:40 INFO - 'LANGUAGE': 'en_US:en', 09:58:40 INFO - 'LOGNAME': 'cltbld', 09:58:40 INFO - 'MAIL': '/var/mail/cltbld', 09:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:40 INFO - 'MOZ_NO_REMOTE': '1', 09:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:40 INFO - 'NO_EM_RESTART': '1', 09:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:40 INFO - 'PWD': '/builds/slave/test', 09:58:40 INFO - 'SHELL': '/bin/bash', 09:58:40 INFO - 'SHLVL': '1', 09:58:40 INFO - 'TERM': 'linux', 09:58:40 INFO - 'TMOUT': '86400', 09:58:40 INFO - 'USER': 'cltbld', 09:58:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', 09:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:40 INFO - '_': '/tools/buildbot/bin/python'} 09:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:58:40 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:40 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:40 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:40 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:40 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:40 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:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:58:42 INFO - Installing collected packages: mozsystemmonitor 09:58:42 INFO - Running setup.py install for mozsystemmonitor 09:58:42 INFO - Successfully installed mozsystemmonitor 09:58:42 INFO - Cleaning up... 09:58:42 INFO - Return code: 0 09:58:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:58: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:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2920aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2858e20>, '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 0x285c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285c830>, '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': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', '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:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:58:42 INFO - Using env: {'DISPLAY': ':0', 09:58:42 INFO - 'HOME': '/home/cltbld', 09:58:42 INFO - 'LANG': 'en_US.UTF-8', 09:58:42 INFO - 'LANGUAGE': 'en_US:en', 09:58:42 INFO - 'LOGNAME': 'cltbld', 09:58:42 INFO - 'MAIL': '/var/mail/cltbld', 09:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:42 INFO - 'MOZ_NO_REMOTE': '1', 09:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:42 INFO - 'NO_EM_RESTART': '1', 09:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:42 INFO - 'PWD': '/builds/slave/test', 09:58:42 INFO - 'SHELL': '/bin/bash', 09:58:42 INFO - 'SHLVL': '1', 09:58:42 INFO - 'TERM': 'linux', 09:58:42 INFO - 'TMOUT': '86400', 09:58:42 INFO - 'USER': 'cltbld', 09:58:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', 09:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:42 INFO - '_': '/tools/buildbot/bin/python'} 09:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:42 INFO - Downloading/unpacking jsonschema==2.5.1 09:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:58:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:44 INFO - Downloading functools32-3.2.3-2.tar.gz 09:58:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:58:44 INFO - warning: no files found matching '*.txt' 09:58:44 INFO - no previously-included directories found matching 'build' 09:58:44 INFO - no previously-included directories found matching 'dist' 09:58:44 INFO - no previously-included directories found matching '.git*' 09:58:44 INFO - Installing collected packages: jsonschema, functools32 09:58:44 INFO - Running setup.py install for functools32 09:58:44 INFO - warning: no files found matching '*.txt' 09:58:44 INFO - no previously-included directories found matching 'build' 09:58:44 INFO - no previously-included directories found matching 'dist' 09:58:44 INFO - no previously-included directories found matching '.git*' 09:58:44 INFO - Successfully installed jsonschema functools32 09:58:44 INFO - Cleaning up... 09:58:44 INFO - Return code: 0 09:58:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:58:44 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:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:44 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:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:44 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 0x7f2920aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2858e20>, '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 0x285c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285c830>, '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': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', '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:44 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:58:44 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:58:44 INFO - Using env: {'DISPLAY': ':0', 09:58:44 INFO - 'HOME': '/home/cltbld', 09:58:44 INFO - 'LANG': 'en_US.UTF-8', 09:58:44 INFO - 'LANGUAGE': 'en_US:en', 09:58:44 INFO - 'LOGNAME': 'cltbld', 09:58:44 INFO - 'MAIL': '/var/mail/cltbld', 09:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:44 INFO - 'MOZ_NO_REMOTE': '1', 09:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:44 INFO - 'NO_EM_RESTART': '1', 09:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:44 INFO - 'PWD': '/builds/slave/test', 09:58:44 INFO - 'SHELL': '/bin/bash', 09:58:44 INFO - 'SHLVL': '1', 09:58:44 INFO - 'TERM': 'linux', 09:58:44 INFO - 'TMOUT': '86400', 09:58:44 INFO - 'USER': 'cltbld', 09:58:44 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', 09:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:44 INFO - '_': '/tools/buildbot/bin/python'} 09:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:45 INFO - Downloading/unpacking blobuploader==1.2.4 09:58:45 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:45 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:45 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:45 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:45 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:45 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:46 INFO - Downloading blobuploader-1.2.4.tar.gz 09:58:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:58:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:58:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:47 INFO - Downloading docopt-0.6.1.tar.gz 09:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:58:47 INFO - Installing collected packages: blobuploader, requests, docopt 09:58:47 INFO - Running setup.py install for blobuploader 09:58:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:58:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:58:47 INFO - Running setup.py install for requests 09:58:48 INFO - Running setup.py install for docopt 09:58:48 INFO - Successfully installed blobuploader requests docopt 09:58:48 INFO - Cleaning up... 09:58:48 INFO - Return code: 0 09:58:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:48 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 0x7f2920aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2858e20>, '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 0x285c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285c830>, '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': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', '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:48 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:48 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:48 INFO - Using env: {'DISPLAY': ':0', 09:58:48 INFO - 'HOME': '/home/cltbld', 09:58:48 INFO - 'LANG': 'en_US.UTF-8', 09:58:48 INFO - 'LANGUAGE': 'en_US:en', 09:58:48 INFO - 'LOGNAME': 'cltbld', 09:58:48 INFO - 'MAIL': '/var/mail/cltbld', 09:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:48 INFO - 'MOZ_NO_REMOTE': '1', 09:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:48 INFO - 'NO_EM_RESTART': '1', 09:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:48 INFO - 'PWD': '/builds/slave/test', 09:58:48 INFO - 'SHELL': '/bin/bash', 09:58:48 INFO - 'SHLVL': '1', 09:58:48 INFO - 'TERM': 'linux', 09:58:48 INFO - 'TMOUT': '86400', 09:58:48 INFO - 'USER': 'cltbld', 09:58:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', 09:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:48 INFO - '_': '/tools/buildbot/bin/python'} 09:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:48 INFO - Running setup.py (path:/tmp/pip-n8WT7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:48 INFO - Running setup.py (path:/tmp/pip-GLkYBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:48 INFO - Running setup.py (path:/tmp/pip-ZKc4Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:48 INFO - Running setup.py (path:/tmp/pip-RJoEWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:48 INFO - Running setup.py (path:/tmp/pip-Qro4dM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:48 INFO - Running setup.py (path:/tmp/pip-rxqv8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:49 INFO - Running setup.py (path:/tmp/pip-_tZWC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:49 INFO - Running setup.py (path:/tmp/pip-3iPP6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:49 INFO - Running setup.py (path:/tmp/pip-6HNmtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:49 INFO - Running setup.py (path:/tmp/pip-wB4Eze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:49 INFO - Running setup.py (path:/tmp/pip-21bXqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:49 INFO - Running setup.py (path:/tmp/pip-VwFRm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:49 INFO - Running setup.py (path:/tmp/pip-z0GWUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:49 INFO - Running setup.py (path:/tmp/pip-BNfSbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:49 INFO - Running setup.py (path:/tmp/pip-J0XTHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:49 INFO - Running setup.py (path:/tmp/pip-nyG12i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:49 INFO - Running setup.py (path:/tmp/pip-gS6YUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:58:49 INFO - Running setup.py install for manifestparser 09:58:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:58:49 INFO - Running setup.py install for mozcrash 09:58:50 INFO - Running setup.py install for mozdebug 09:58:50 INFO - Running setup.py install for mozdevice 09:58:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for mozfile 09:58:50 INFO - Running setup.py install for mozhttpd 09:58:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for mozinfo 09:58:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for mozInstall 09:58:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for mozleak 09:58:50 INFO - Running setup.py install for mozlog 09:58:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for moznetwork 09:58:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for mozprocess 09:58:51 INFO - Running setup.py install for mozprofile 09:58:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Running setup.py install for mozrunner 09:58:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Running setup.py install for mozscreenshot 09:58:51 INFO - Running setup.py install for moztest 09:58:51 INFO - Running setup.py install for mozversion 09:58:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:51 INFO - Cleaning up... 09:58:51 INFO - Return code: 0 09:58:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:51 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:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:51 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:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:51 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 0x7f2920aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2858e20>, '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 0x285c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285c830>, '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': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', '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:51 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:51 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:51 INFO - Using env: {'DISPLAY': ':0', 09:58:51 INFO - 'HOME': '/home/cltbld', 09:58:51 INFO - 'LANG': 'en_US.UTF-8', 09:58:51 INFO - 'LANGUAGE': 'en_US:en', 09:58:51 INFO - 'LOGNAME': 'cltbld', 09:58:51 INFO - 'MAIL': '/var/mail/cltbld', 09:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:51 INFO - 'MOZ_NO_REMOTE': '1', 09:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:51 INFO - 'NO_EM_RESTART': '1', 09:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:51 INFO - 'PWD': '/builds/slave/test', 09:58:51 INFO - 'SHELL': '/bin/bash', 09:58:51 INFO - 'SHLVL': '1', 09:58:51 INFO - 'TERM': 'linux', 09:58:51 INFO - 'TMOUT': '86400', 09:58:51 INFO - 'USER': 'cltbld', 09:58:51 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', 09:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:51 INFO - '_': '/tools/buildbot/bin/python'} 09:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:51 INFO - Running setup.py (path:/tmp/pip-zi53TF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:51 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:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:51 INFO - Running setup.py (path:/tmp/pip-TNmFTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:52 INFO - Running setup.py (path:/tmp/pip-CJhcT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:52 INFO - Running setup.py (path:/tmp/pip-xC98NI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:52 INFO - Running setup.py (path:/tmp/pip-AnHFYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:52 INFO - Running setup.py (path:/tmp/pip-IVSeQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:52 INFO - Running setup.py (path:/tmp/pip-u7a4f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:52 INFO - Running setup.py (path:/tmp/pip-mCqGZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:52 INFO - Running setup.py (path:/tmp/pip-m6mmV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:52 INFO - Running setup.py (path:/tmp/pip-OBgK0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:52 INFO - Running setup.py (path:/tmp/pip-fdymMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:52 INFO - Running setup.py (path:/tmp/pip-oORT8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:52 INFO - Running setup.py (path:/tmp/pip-4idof8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:52 INFO - Running setup.py (path:/tmp/pip-iUxbcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:52 INFO - Running setup.py (path:/tmp/pip-0VKcb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:52 INFO - Running setup.py (path:/tmp/pip-iA6MrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:53 INFO - Running setup.py (path:/tmp/pip-CMhy_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:53 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:53 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:53 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:53 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:53 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:53 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:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:54 INFO - Downloading blessings-1.6.tar.gz 09:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:58:55 INFO - Installing collected packages: blessings 09:58:55 INFO - Running setup.py install for blessings 09:58:55 INFO - Successfully installed blessings 09:58:55 INFO - Cleaning up... 09:58:55 INFO - Return code: 0 09:58:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:58:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:55 INFO - Reading from file tmpfile_stdout 09:58:55 INFO - Current package versions: 09:58:55 INFO - argparse == 1.2.1 09:58:55 INFO - blessings == 1.6 09:58:55 INFO - blobuploader == 1.2.4 09:58:55 INFO - docopt == 0.6.1 09:58:55 INFO - functools32 == 3.2.3-2 09:58:55 INFO - jsonschema == 2.5.1 09:58:55 INFO - manifestparser == 1.1 09:58:55 INFO - mozInstall == 1.12 09:58:55 INFO - mozcrash == 0.17 09:58:55 INFO - mozdebug == 0.1 09:58:55 INFO - mozdevice == 0.48 09:58:55 INFO - mozfile == 1.2 09:58:55 INFO - mozhttpd == 0.7 09:58:55 INFO - mozinfo == 0.9 09:58:55 INFO - mozleak == 0.1 09:58:55 INFO - mozlog == 3.2 09:58:55 INFO - moznetwork == 0.27 09:58:55 INFO - mozprocess == 0.22 09:58:55 INFO - mozprofile == 0.28 09:58:55 INFO - mozrunner == 6.11 09:58:55 INFO - mozscreenshot == 0.1 09:58:55 INFO - mozsystemmonitor == 0.3 09:58:55 INFO - moztest == 0.7 09:58:55 INFO - mozversion == 1.4 09:58:55 INFO - psutil == 3.1.1 09:58:55 INFO - requests == 1.2.3 09:58:55 INFO - wsgiref == 0.1.2 09:58:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58: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:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:55 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 0x7f2920aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2858e20>, '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 0x285c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285c830>, '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': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', '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:55 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:55 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:55 INFO - Using env: {'DISPLAY': ':0', 09:58:55 INFO - 'HOME': '/home/cltbld', 09:58:55 INFO - 'LANG': 'en_US.UTF-8', 09:58:55 INFO - 'LANGUAGE': 'en_US:en', 09:58:55 INFO - 'LOGNAME': 'cltbld', 09:58:55 INFO - 'MAIL': '/var/mail/cltbld', 09:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:55 INFO - 'MOZ_NO_REMOTE': '1', 09:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:55 INFO - 'NO_EM_RESTART': '1', 09:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:55 INFO - 'PWD': '/builds/slave/test', 09:58:55 INFO - 'SHELL': '/bin/bash', 09:58:55 INFO - 'SHLVL': '1', 09:58:55 INFO - 'TERM': 'linux', 09:58:55 INFO - 'TMOUT': '86400', 09:58:55 INFO - 'USER': 'cltbld', 09:58:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', 09:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:55 INFO - '_': '/tools/buildbot/bin/python'} 09:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:55 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:55 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:55 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:55 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:55 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:55 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:55 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:55 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:55 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:55 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:55 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:55 INFO - Cleaning up... 09:58:55 INFO - Return code: 0 09:58:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:58: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:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2920aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2858e20>, '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 0x285c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285c830>, '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': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', '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: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', 'jsonschema'] in /builds/slave/test/build 09:58: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 jsonschema 09:58:55 INFO - Using env: {'DISPLAY': ':0', 09:58:55 INFO - 'HOME': '/home/cltbld', 09:58:55 INFO - 'LANG': 'en_US.UTF-8', 09:58:55 INFO - 'LANGUAGE': 'en_US:en', 09:58:55 INFO - 'LOGNAME': 'cltbld', 09:58:55 INFO - 'MAIL': '/var/mail/cltbld', 09:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:55 INFO - 'MOZ_NO_REMOTE': '1', 09:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:55 INFO - 'NO_EM_RESTART': '1', 09:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:55 INFO - 'PWD': '/builds/slave/test', 09:58:55 INFO - 'SHELL': '/bin/bash', 09:58:55 INFO - 'SHLVL': '1', 09:58:55 INFO - 'TERM': 'linux', 09:58:55 INFO - 'TMOUT': '86400', 09:58:55 INFO - 'USER': 'cltbld', 09:58:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', 09:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:55 INFO - '_': '/tools/buildbot/bin/python'} 09:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:58:55 INFO - Cleaning up... 09:58:55 INFO - Return code: 0 09:58:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:58: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:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2920aecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x285e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2858e20>, '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 0x285c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285c830>, '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': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', '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: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', 'flake8'] in /builds/slave/test/build 09:58: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 flake8 09:58:55 INFO - Using env: {'DISPLAY': ':0', 09:58:55 INFO - 'HOME': '/home/cltbld', 09:58:55 INFO - 'LANG': 'en_US.UTF-8', 09:58:55 INFO - 'LANGUAGE': 'en_US:en', 09:58:55 INFO - 'LOGNAME': 'cltbld', 09:58:55 INFO - 'MAIL': '/var/mail/cltbld', 09:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:55 INFO - 'MOZ_NO_REMOTE': '1', 09:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:55 INFO - 'NO_EM_RESTART': '1', 09:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:55 INFO - 'PWD': '/builds/slave/test', 09:58:55 INFO - 'SHELL': '/bin/bash', 09:58:55 INFO - 'SHLVL': '1', 09:58:55 INFO - 'TERM': 'linux', 09:58:55 INFO - 'TMOUT': '86400', 09:58:55 INFO - 'USER': 'cltbld', 09:58:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', 09:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:55 INFO - '_': '/tools/buildbot/bin/python'} 09:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:56 INFO - Downloading/unpacking flake8 09:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:58:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:58: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:58: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:58: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:58: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:58: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:58: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:58:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:58:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:58:58 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:58 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:58 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:58 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:58 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:58 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:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:58:58 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:58 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:58 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:58 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:58 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:58 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:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:58:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:58:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:58:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:58:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:58:58 INFO - no previously-included directories found matching 'docs/_build' 09:58:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:58:58 INFO - Running setup.py install for pep8 09:58:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:58:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:58:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:58:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:58:58 INFO - no previously-included directories found matching 'docs/_build' 09:58:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:58:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:58:58 INFO - Cleaning up... 09:58:58 INFO - Return code: 0 09:58:58 INFO - Running post-action listener: _resource_record_post_action 09:58:58 INFO - Running post-action listener: _start_resource_monitoring 09:58:58 INFO - Starting resource monitoring. 09:58:58 INFO - ##### 09:58:58 INFO - ##### Finished create-virtualenv step (success) 09:58:58 INFO - ##### 09:58:58 INFO - ##### 09:58:58 INFO - ##### Running install step. 09:58:58 INFO - ##### 09:58:58 INFO - Running pre-action listener: _resource_record_pre_action 09:58:58 INFO - Running main action method: install 09:58:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:59 INFO - Reading from file tmpfile_stdout 09:58:59 INFO - Detecting whether we're running mozinstall >=1.0... 09:58:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:58:59 INFO - Reading from file tmpfile_stdout 09:58:59 INFO - Output received: 09:58:59 INFO - Usage: mozinstall [options] installer 09:58:59 INFO - Options: 09:58:59 INFO - -h, --help show this help message and exit 09:58:59 INFO - -d DEST, --destination=DEST 09:58:59 INFO - Directory to install application into. [default: 09:58:59 INFO - "/builds/slave/test"] 09:58:59 INFO - --app=APP Application being installed. [default: firefox] 09:58:59 INFO - mkdir: /builds/slave/test/build/application 09:58:59 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:59 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:59:16 INFO - Reading from file tmpfile_stdout 09:59:16 INFO - Output received: 09:59:16 INFO - /builds/slave/test/build/application/firefox/firefox 09:59:16 INFO - Running post-action listener: _resource_record_post_action 09:59:16 INFO - ##### 09:59:16 INFO - ##### Finished install step (success) 09:59:16 INFO - ##### 09:59:16 INFO - ##### 09:59:16 INFO - ##### Running run-tests step. 09:59:16 INFO - ##### 09:59:16 INFO - Running pre-action listener: _resource_record_pre_action 09:59:16 INFO - Running main action method: run_tests 09:59:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:59:16 INFO - Python 2.7.3 09:59:16 INFO - Return code: 0 09:59:16 INFO - grabbing minidump binary from tooltool 09:59:16 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:59:16 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 0x2858e20>, '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 0x285c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285c830>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:59:16 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:59:16 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:59:16 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:59:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:59:16 INFO - Return code: 0 09:59:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:59:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:59:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:59:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:59:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:59:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:59:17 INFO - Return code: 0 09:59:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:59:17 INFO - Using env: {'DISPLAY': ':0', 09:59:17 INFO - 'HOME': '/home/cltbld', 09:59:17 INFO - 'LANG': 'en_US.UTF-8', 09:59:17 INFO - 'LANGUAGE': 'en_US:en', 09:59:17 INFO - 'LOGNAME': 'cltbld', 09:59:17 INFO - 'MAIL': '/var/mail/cltbld', 09:59:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:59:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:17 INFO - 'MOZ_NO_REMOTE': '1', 09:59:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:17 INFO - 'NO_EM_RESTART': '1', 09:59:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:17 INFO - 'PWD': '/builds/slave/test', 09:59:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:59:17 INFO - 'SHELL': '/bin/bash', 09:59:17 INFO - 'SHLVL': '1', 09:59:17 INFO - 'TERM': 'linux', 09:59:17 INFO - 'TMOUT': '86400', 09:59:17 INFO - 'USER': 'cltbld', 09:59:17 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010', 09:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:17 INFO - '_': '/tools/buildbot/bin/python'} 09:59:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QNiILmhyTqaPvgb1y4xOyw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:59:17 INFO - mozversion application_buildid: 20160608071315 09:59:17 INFO - mozversion application_changeset: f22cca9ad502563f7e15a5a44c4bf9d04ad2e87f 09:59:17 INFO - mozversion application_display_name: Nightly 09:59:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:59:17 INFO - mozversion application_name: Firefox 09:59:17 INFO - mozversion application_remotingname: firefox 09:59:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:59:17 INFO - mozversion application_vendor: Mozilla 09:59:17 INFO - mozversion application_version: 50.0a1 09:59:17 INFO - mozversion platform_buildid: 20160608071315 09:59:17 INFO - mozversion platform_changeset: f22cca9ad502563f7e15a5a44c4bf9d04ad2e87f 09:59:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:59:17 INFO - mozversion platform_version: 50.0a1 09:59:17 INFO - using testdate: 1465405157 09:59:17 INFO - actual date: 1465405157 09:59:17 INFO - starting webserver on 'localhost:37627' 09:59:17 INFO - SUITE-START | Running 2 tests 09:59:17 INFO - TEST-START | dromaeo_css 09:59:17 INFO - operating with platform_type : linux_ 09:59:17 INFO - Initialising browser for dromaeo_css test... 09:59:17 INFO - TEST-INFO | started process 19134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4XXH3P/profile http://localhost:37627/getInfo.html) 09:59:21 INFO - PROCESS | 19134 | __metrics Screen width/height:1600/1200 09:59:21 INFO - PROCESS | 19134 | colorDepth:24 09:59:21 INFO - PROCESS | 19134 | Browser inner width/height: 1024/697 09:59:21 INFO - PROCESS | 19134 | __metrics 09:59:22 ERROR - PROCESS | 19134 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:59:22 INFO - PROCESS | 19134 | console.error: PushService: 09:59:22 INFO - PROCESS | 19134 | stateChangeProcessEnqueue: Error transitioning state 09:59:22 INFO - PROCESS | 19134 | UnknownError 09:59:23 INFO - TEST-INFO | 19134: exit 0 09:59:23 INFO - Browser initialized. 09:59:23 INFO - Running cycle 1/1 for dromaeo_css test... 09:59:23 INFO - TEST-INFO | started process 19219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4XXH3P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:34 INFO - PROCESS | 19219 | RSS: Main: 156438528 09:59:34 INFO - PROCESS | 19219 | 10:00:26 INFO - PROCESS | 19219 | 1465405226190 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:02:33 INFO - PROCESS | 19219 | Cycle 1(1): loaded http://localhost:37627/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37627/tests/dromaeo/cssquery-ext.html) 10:02:34 INFO - PROCESS | 19219 | RSS: Main: 246063104 10:02:34 INFO - PROCESS | 19219 | 10:05:37 INFO - PROCESS | 19219 | Cycle 1(1): loaded http://localhost:37627/tests/dromaeo/cssquery-ext.html (next: http://localhost:37627/tests/dromaeo/cssquery-jquery.html) 10:05:38 INFO - PROCESS | 19219 | RSS: Main: 249999360 10:05:38 INFO - PROCESS | 19219 | 10:08:40 INFO - PROCESS | 19219 | Cycle 1(1): loaded http://localhost:37627/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37627/tests/dromaeo/cssquery-mootools.html) 10:08:40 INFO - PROCESS | 19219 | RSS: Main: 238424064 10:08:40 INFO - PROCESS | 19219 | 10:11:42 INFO - PROCESS | 19219 | Cycle 1(1): loaded http://localhost:37627/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37627/tests/dromaeo/cssquery-prototype.html) 10:11:43 INFO - PROCESS | 19219 | RSS: Main: 237535232 10:11:43 INFO - PROCESS | 19219 | 10:14:45 INFO - PROCESS | 19219 | Cycle 1(1): loaded http://localhost:37627/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37627/tests/dromaeo/cssquery-yui.html) 10:14:46 INFO - PROCESS | 19219 | RSS: Main: 208302080 10:14:46 INFO - PROCESS | 19219 | 10:17:49 INFO - PROCESS | 19219 | Cycle 1(1): loaded http://localhost:37627/tests/dromaeo/cssquery-yui.html (next: http://localhost:37627/tests/dromaeo/cssquery-dojo.html) 10:17:49 INFO - PROCESS | 19219 | RSS: Main: 275718144 10:17:49 INFO - PROCESS | 19219 | 10:17:49 INFO - PROCESS | 19219 | __start_tp_report 10:17:49 INFO - PROCESS | 19219 | _x_x_mozilla_page_load 10:17:49 INFO - PROCESS | 19219 | _x_x_mozilla_page_load_details 10:17:49 INFO - PROCESS | 19219 | |i|pagename|runs| 10:17:49 INFO - PROCESS | 19219 | |0;dojo.html;3103.5189545620437;3110.7977981431204;3121.5317702344646;3152.527120931861;3190.601174853143;5112.412072611651;5173.198154286082;5206.973965130173;5298.4966428189355;5308.177232528955;5199.116150254456;5283.735813209343;5297.099493086175;5298.20526920962;5336.199570064492;4753.1681955657705;4830.541098595628;4865.221564549673;4873.244647079709;4936.33359496467;4871.391076115486;4873.098476781806;4893.1926232171645;4929.8028078876805;4934.21052631579;4731.90536189276;4774.40319960005;4797.208460603996;4851.708897466164;4879.365682461293;4756.3816703828625;4769.570738633505;4777.5222477752295;4825.734584597846;4892.486288939645;4778.976105119487;4808.711477311373;4821.566059054702;4832.661713680044;4860.562549370574;5096.413912400084;5116.590672746172;5179.015986962465;5180.6891586504935;5253.86865328366;5689.459501347365;5691.800786972478;5716.657000579937;5718.42815718429;5719.742611582489;5702.657840529581;5712.8857422851725;5754.597178197528;5765.913511297334;5767.942320576783;5188.273641690166;5263.26314315996;5291.444398338158;5296.232046353296;5340.412554618989;5845.678487683218;5849.034909239927;5854.765809367577;5855.677937713466;5858.47273745365;5485.917711234335;5635.971820140873;5645.463680950304;5647.745851436695;5647.774089036392;5598.356189038313;5621.5221706155435;5627.774889004476;5692.715364231772;5694.06048002075;5671.688057156896;5672.716364181774;5673.489385955284;5679.659220446786;5682.943170568242;5508.091164957817;5560.86097847549;5692.857678557986;5696;5698.601097923189;4295.78521073945;4327.545607711208;4332.155229730235;4350.282203436397;4370.2570563004365;3855.132595166121;3873.8837834865;3879.262940041383;3913.5695073541888;3920.7059470539825;5133.332666753298;5153.020926024044;5264.6314757966575;5266.236395722599;5268.025415298182;5630.4369563043365;5691.715414229272;5704.4295570443455;5710.400407957105;5763.971180144073;5354.625176237626;5362.249285100089;5363.544098751572;5364.678119312854;5367.302250707383;4606.56237657422;4705.623550115983;4728.976355118271;4758.643101767381;4796.664233503621;5914.526837852962;5927.73325200367;5932.080527518242;5935.910961335583;5964.31410387811;5705.315362156485;5743.195952566728;5743.9138412923;5744.195812586157;5745.425457454221;5664.688442135722;5768.192453056491;5788.9131663024245;5819.854503637443;5899.764009439746;5627.8593035174445;5630.127330263816;5634.943650563606;5637.57718171147;5639;5659.094544872801;5704.087346024616;5717.5425965921795;5724.198612194379;5727.255456790591;5354.518093371459;5487.149491828773;5553.666779993213;5578.776848925998;5607.046802043744;5579.860503487445;5583.106702927675;5589.049861523469;5589.860253493695;5592.412796656293;5285.63000589955;5467.398586155599;5496.80761173357;5528.419515950767;5570.387257401763;5454.481824226692;5457.263269458573;5462.0441422751655;5547.55619550443;5550.5282051026115;5384.326959130109;5438.18427235902;5439.836804895859;5444.972775136099;5488.643238189505 10:17:49 INFO - PROCESS | 19219 | |1;ext.html;597.4712379544102;613.9600925939815;618.3816183816184;630.8864404407208;642.5277421095496;33215.66784332159;42926.57073429265;44189;44242.557574424245;44280.77859610701;45964.770176149155;46409.53590464094;46459;46525;46550.76724616381;7802.8439431211345;8707.216350528452;8903.910960890405;8908.153725396078;10218.693439196799;10113.949430252838;10547.101521726087;10547.208959328043;10547.683569492927;10556.947215263914;10515.894841051568;10558.366498010144;10580.312279701795;10612.310199836986;10615.681529554087;7815.96092019542;8172.305354044914;8182.01815782104;10214.08073273409;10504.422256775873;10042.4476653784;10066.396016239049;10183.134433573156;10193.439360835151;10193.694189174263;41644;42150.15699685989;42160;42170.78914605438;42216.57783422157;3575.302815950891;3594.02961200477;3778.678812300958;3854.209886973164;3896.7856767877756;32336.355484706444;32766.836165819255;32977.83511082453;33641;34455.655443445496;4396.120775844844;4517.819287228507;4519.209138400766;4520.50274469808;4570.680052396334;246615;247891;248441;353894;355174;31209;32315.19212019718;32346.191345216557;58776;59168.70415647894;37045.81477092597;37219.4417083744;37380.81309593435;37457.314420850584;37457.81271093627;14888.776668349983;14950.925245373703;15011.849881501264;15031.849681503263;15034.323455444532;13044.282564459047;13065.412056457482;13079.673008174681;13115.08194426381;13135.474581016844;8266.008079030555;8374.701921202224;8397.496150231005;8410.49537027768;8483.660653573912;3214.260720034405;3234.498652708834;3297.50537419389;3298.472244440926;3313.237955270253;1037.2381421205127;1066.168388656849;1090.7055095124272;1134.2570616246371;1176.3294921894437;31403.842980785408;31689.207769805478;31820.522692159637;31952.360952780815;33032.50451243233;1119.0698228139493;1136.3466007045981;1170.145793570698;1218.7196944702591;1241.0878004666563;16706.331746729993;17002.319907203822;17080.743788843178;17156.31374745021;17317.393891213746;153298;153549.232253838;153937.23031384996;155504;155979;58854.41145588575;60297;60297.397026030056;60334;60360.396396036354;1274.6877015131352;1360.5034162530605;1383.7924311353377;1389.7984792205275;1419.964500887486;31582.526262105628;34049.65950340564;34054.65945340515;34124;34352.141196470286;44920.77539612281;44931.77534112309;45370;45414.772926135156;45462.772686136355;417259;417539;420223;421358;421895;25418.364540886625;27129.72870271351;28270.293242669097;28371.43257134887;29778.10665680033;47422.288665670734;47613.52386476091;48030.27954580754;48775.756121219165;49265;41362.79318603388;41970;42189.15621687488;42317.576824231364;42968.78515607402;40413.59586404216;40488.3926741105;40538.79730601328;41096.589034110475;41662;41280.38079428871;41751.58248417477;41906.790466047474;42122.157556849306;42710;35350;36740.26519469649;37150.814245928595;37240;37465.81267093647;28121.296967575974;28176.436471270048;28258.15225543237;28459.715402846534;28585.85707071451 10:17:49 INFO - PROCESS | 19219 | |2;jquery.html;380.767731683673;382.27749553344165;383.4937881995765;397.9761214327141;407.81240629310514;17024;18757.624847503077;19328.710069348937;19334;19345.61308773824;18362.816371836278;18554.72167917482;18937.841022746405;19132.61734765304;19173.32893348733;5583.35791383991;5593.8321850344555;5674.858128546778;5712.000399930016;5770.307563092414;5431.402545719968;5528.9723551382185;5536.252605898192;5540.196671482632;5597.804076857311;5511.641743286694;5590.580706447013;5592.5805564582615;5593.916091258634;5625.1843482694985;5425.782968681248;5521.1442226455165;5546.251256080418;5546.944530554703;5629.099344104964;4914.287428322909;4961.652684312099;5025.39695236574;5037.949620503785;5045.344105266292;22194.667079993815;22339.55320893573;22473.213437529772;22766.430839229153;22889;2215.900284487202;2283.828712846543;2328.2665960222475;2330.34750269923;2474.6906636670415;10779.407132607703;13541.255230962293;13875.514356997557;14052.156870587694;14375.137491750529;1915.2339064374362;1920.7407000054955;1920.7791104022938;1962.4505138561226;1963.6563601369846;57295;68075.65962170158;69358.14492985493;72274.63862680705;76470.61764691197;9830.262730295257;10322.535485903003;10449.529771160316;10644.148468122532;10713.571457141627;13061.281629510468;13258.337083145803;14162.079464834753;14236.715265694835;14881.958262921491;7593.164751877289;7724.300653856143;7734.265244801735;7993.840123197503;8184.836303273901;7091.680874360666;7133.92866071343;7201.783946481614;7250.854982900418;7297.4891757577525;6466.976928408791;6541.411272985359;6592.472602191813;6687;6730.764423245163;1814.945551633453;1897.1747289928649;1919.395390452003;1934;1941.7087436884299;961.7162936933621;962.6005207838668;977.0913050862766;1077.42357838556;1087.4019289390963;18591.628167436575;18716.625667486573;19244.71132933007;19282;19432.62270304683;993.4585650820176;1000.4347543637966;1002.1481740520645;1020.8723909511311;1092.7705181911729;10651.988061134334;11194.608188713355;11264.887351126548;11317.377544234982;11346.149038821955;447864.3247486322;450482;453040;454926;458682;75120;75636.62181689167;76011.23988760152;76752.61623691846;79446.20553794503;1008.1531513528671;1014.9035841595037;1031.6904928521415;1038.3250886923408;1038.8649475568127;16952.15239238058;16979.40572080021;17268.827311727226;17311.13444327804;17560;36637.63362366342;37954.81022594869;38068.61931380651;38637.85786862764;39442.21115577615;48998.265026023924;49079.75460122676;49217.26174107463;49269;49303.50696492989;7916.960415197887;8239.093699693149;8239.505629662239;8270.2556769891;8298.70954516589;12809.039322050698;12845.293508857103;12900.741985160432;12908.548200812926;13100.868991309964;11014.3942083183;11305.886941130813;11454.885451145716;11547.307161570332;11607.620784679384;11351.489182986621;11356.0915126788;11373.658790236306;11396.202265841312;11567.190296679151;11402.087832973177;11468.197226194086;11616.186866919235;11734;11836.763264734485;7140;7460.3658689012045;7576.545407275581;8233.83532329362;8285;8821.250193733347;11015.724606884893;11520.884791152317;11628.709282268012;11701.2979221247 10:17:49 INFO - PROCESS | 19219 | |3;mootools.html;1297.0725930959363;1415.2499175437015;1468.4933697874233;1569.9529014129573;1741.669082874253;8420.452670576416;8658.13418658134;8728.563571821407;8908.643654253838;8933.821323573524;8470.068292487822;8675.739727808175;8685.782855428617;8714.825703485927;8758.12418758124;1978.0801927103894;1981.9603607927834;2040.2757021257462;2250.2349201271604;2282.543491301738;2290.3014580552926;2297.908083676651;2299.034405549673;2300.2409204962323;2301.413139649387;2264.6036943534896;2276.9886150569305;2290.198430549303;2291.0606651272983;2294.4952110535737;1885.81141885811;2100.47488127968;2104.2740254612136;2161.211157927361;2166.938200281866;2204.2836078274463;2222.7777222277805;2238.5746708125403;2243.83320673249;2244.9663255051187;8686.826263474695;8727.650893964234;8731.738047858575;8743.344249181273;8768.780780480476;4932.260160975847;5009.5491405773655;5035.672681275742;5043.974780126113;5050.545450909436;3010.3527741535454;3148.7638427117827;3201.055688571854;3203.3593281343824;3209.326041531281;1035.316690983947;1045.231754660324;1078.9298695584762;1083.626148978609;1097.7969075721016;12609.684757881127;12659.240445573296;12689.365531723377;12701.74596508074;12716.173448725804;4288.463942007249;4401.6478681705385;4454.37638730578;4496.977515112403;4504.481984571817;10432.634857779942;10436.686899393031;10440.843387349196;10460.63387781424;10505;5062.7468626568525;5117.74411279442;5123.8719032023755;5124.692518448905;5130.743462826844;4226.112516371596;4642.396488456479;4786.44955830084;4798.2802579612635;4849.612031037508;3830.597787232356;3885.8445662173194;3911.941320880189;3944.2505923874373;3985.183037477368;1179.728662407651;1185.6146752305535;1189.5895915908998;1192.5587532612815;1212.3938030984507;1004.829179039565;1012.7518757904213;1013.3312014070825;1021.5556233038652;1034.131329683055;5722.4277572242445;5816.331121920949;5845.240118784531;5849.970750146222;6036.366181550961;433.70074648492437;450.0795872440866;463.91881420751236;464.6027646362379;465.6763549333249;4134.3178375568295;4266.232078225887;4278.4010238566625;4336.891577710519;4338.9566104338555;10602.36385816838;10943.835842462211;10969.725756856142;11000.174986876016;11065.225434219527;10847.837282440769;10885.510152043018;10923.508442120125;10944.945275273572;10951.288166269167;7916.683332666629;8120.837583248302;8190.2628763410385;8214.794630134174;8217.630206640595;6116.785912493041;6173.506119510339;6191.84520386994;6253.593516421418;6310.52671049664;9892.752681183028;10087.991200879853;10093.243006774375;10104;10118.8482172766;9971.40171589707;10097.343672661253;10287.331323463952;10319.742006449898;10418.843717344398;7707.807304817425;8108.9594552026865;8201.876971845308;8338.499690018618;8390.916090839013;8445.408821382443;8555.486670799772;8596.871046934177;8620.61207245688;8633.8704919425;7594.392448604209;7695.538267703956;7705.22947705225;7870.527768333918;7886.802829929297;7503.212162723054;7592.202818703957;7652.464327497244;7658.502197357154;7764.417668674759;7108.644567771694;7291.453141014551;7318.597477138808;7323.12122545298;7328.633568321669;5018.7741551631;5080.161773307363;5086.694798312114;5196.870078248074;5205.843824685266;5127.5897928166405;5266.920996185137;5282.577393808563;5317.175837745156;5330.440303768203 10:17:49 INFO - PROCESS | 19219 | |4;prototype.html;313.213833278471;328.1026392815649;328.65983706863403;330.2915246795624;332.3900642321341;4968.900621987558;5256.973715131424;5267.367915850094;5295;5331.333583302087;5276.947230527693;5320.14877619581;5321.920171197435;5328.786848526054;5340.62615616907;4150.3359462486005;4151.356539736345;4159.812808423613;4217.85237516687;4231;3903.7852918089493;4087.7751723655188;4245.363195520666;4249.8950272929105;4270.508891477489;4035.9798201008953;4054.331035379159;4060.1879624075304;4082.2243773683053;4090.4273401723635;4079.714419990602;4080.8979775505554;4085.9172319335253;4095.7747323897174;4098.631123198927;3578.5526809148855;3586.37238483267;3596.2627661329366;3602.819859007039;3636.236390358028;5071.644984851062;5074.644774865761;5079.87300317495;5081.872953176163;5115.948840511584;4631.675782695213;4641.883952901171;4670.556297151765;4679.953200467986;4689.601383882374;5505.201745746845;5507.284053073075;5526.2592283430595;5539.50144486994;5549.528290095347;3756.6431189037;3914.8629797956933;3927.528696556403;3934.331163702149;3950.920981580381;5419.647722898038;5593.748281327391;5741.971290143564;5747.827565173052;5765.4811067004175;4026.8187931543152;4028.7179897407486;4036.2936486114813;4046.1705350403095;4048.574899635496;3901.239258344652;3988.840446382112;4037.313656678372;4073.7555746655294;4082.3872721458292;4626.21354369758;4643.582077613031;4659.254519276899;4664.527800265864;4665.440147182292;5579.776808927679;5594.188842617879;5601.747921343549;5604.06659702402;5637.252451739973;1345.421468768439;1380.827396575428;1392.6978275312615;1395.8045873577707;1405.7539930512119;878.503645440337;888.3159966825638;899.7840518275698;901.5176880368971;903.4488961733338;4701.506341834127;4708.670393072452;4720.386349774507;4783.6651434399255;4829.2997515360075;5081.618878584121;5095.847124586268;5114.795408183705;5130.640855140179;5133.8716532087;4446.599806017474;4745.928811067837;4779;4785.880352991203;4788.952110478851;2714.280715610365;2719.2522056434245;2733.523897095586;2734.904278350248;2748.9966162350997;5209.374875014947;5212.713300768418;5212.7914883405;5237.476252374732;5241.554467870274;4878.780304923698;5062.977288505391;5178.472350656565;5183.248428977852;5198.480151984847;5171.663841850268;5228.764705588258;5258.763355649005;5278.703763862732;5320.255164277004;5153.7165455900285;5157.742112894265;5202.271681964452;5405.216243644571;5545.445455454423;5649.4633009864;5652.576056795675;5661.207430959586;5665.830025099253;5689.374168841341;5831.912521312269;5840.488589906381;5841.1530328101335;5844.386339434298;5848;3983.5618082011533;4024.7987600619267;4078.143589846047;4091.284025295502;4113.753174809521;5699.800506982236;5716;5729.4843464088435;5730.054541000688;5730.255066841284;5453.127499600045;5568.663520754909;5612.691301978431;5624.971875140762;5626.1842032905815;5458.426865179258;5479.479449452455;5495.890082198413;5502.174673798962;5580.609357345109;5402.594805389533;5410.891782164414;5413.269208656781;5413.593980451403;5448.727563621724;5242.475752424727;5476.288082549243;5500.50495455411;5547.639403438763;5578.6611213309325;5351.277577526984;5396.406395296436;5445.754941027584;5458.836234912959;5478.835634930799 10:17:49 INFO - PROCESS | 19219 | |5;yui.html;654.9410553050227;656.2944834303125;741.3216906530524;797.3541431440534;820.6102101501788;14359.64100897478;15369.615759606015;15378.384864605403;15387.153706546136;15398;13060.934695326534;13264.668383290398;13302.068855180141;13319.53381631643;13352.532661356854;666.9199696036458;677.292229620047;785.5326080981806;807.5921659561913;810.3841080778592;800.7077416742906;807.386386346378;808.3210103513048;812.1796985045088;815.1685281013363;707.7487491940365;862.2239984014375;864.256739204287;864.6022829498438;864.8010957479752;829.0921441022072;844.2907957315823;847.478800537668;848.8854004709347;853.0786750309651;623.3423737956454;623.7941479311817;624.2945471617089;625.3059104394118;626.2547568393643;14398.352074156688;14526.128432294096;14555.490557830532;14559.490417835324;14598.489052883204;14036.368363423568;14149.292535373294;14211.78682319766;14283.357248923823;14462.27688615565;12179.451924663412;12324.876751232463;12345.69135771604;12446.937765311206;12573.497060117676;4382.298832186835;4419.447569053868;4437.534058923831;4506.278995360759;4646.605038571725;76366;77096;78405;78609.99999999943;79376.20623793745;11569.479373428216;11736.295822250693;11759.941200294115;11813.527458901548;11819.881801181878;22333.664995025087;22404.775952240594;22537.661935070988;22579.88710056472;22586.661200082013;8118.228768267123;8150;8164.836703265902;8166.510009399455;8211.137830527829;4743.454502732161;4804.0872234275375;4817.638677099161;4885.267209918541;4904.117258893433;3289.802611843249;3294.1270563300745;3295.406826771204;3321.136504508845;3374.3757404880175;591.5947575910515;609.768288050538;613.5275837605019;613.8219916224334;616.1220261127875;648.9156409666713;656.7537173559915;674.7570874485182;680.7447207297264;704.4892452971554;8849.955750221208;8904.465732056098;9105.317101217302;9146.86279705805;9343.112404321579;584.7222569279559;612.773273888664;684.305429988562;691.3155975584135;733.6148522025873;4743.786529606107;4822.879428014257;4843.321934929113;4915.9508404916205;5002.874928126753;73974;75633;114481;116996.41501792436;117430.41284793521;65706.67146664236;88363;98344.50827745815;99166;101712;72585.6370718143;87917.56041219753;88184.55907720549;88950.55524722335;89051.55474222587;8994.955025224832;9006.819863602823;9057.411268267542;9084.591193396182;9142;51336.48663513317;51627;51633.225501616755;52789.736051319494;53316.813947933835;69207.65396172987;76848;78420.60789696015;79753.60123199347;79884;11988;12136.817947730968;12168.939155304166;12268.570600028956;12741.745165096832;13864.168149911038;14047.719045618825;14051.36768845384;14076.225807580682;14200.360983755962;12608.74782504363;12711.61865144047;12715.364231788188;12827.294498802283;12861.765189775733;12036.157468977437;12413.75172496527;12889.8066529004;12955;13908.374123164684;12487.93756031214;12581.245125292511;13083.280419576633;13104.868951310746;13661.658458538615;9828.459434731158;9996.150327222267;10008.249381296286;10042.246831487522;10068.68838829709;10247.282690211614;10964.396958167059;10976.506057227285;10993.285436446926;11049.613263535737 10:17:49 INFO - PROCESS | 19219 | __end_tp_report 10:17:49 INFO - PROCESS | 19219 | __start_cc_report 10:17:49 INFO - PROCESS | 19219 | _x_x_mozilla_cycle_collect,796 10:17:49 INFO - PROCESS | 19219 | __end_cc_report 10:17:49 INFO - PROCESS | 19219 | __startTimestamp1465406269347__endTimestamp 10:17:49 INFO - PROCESS | 19219 | 10:17:49 INFO - PROCESS | 19219 | ------- Summary: start ------- 10:17:49 INFO - PROCESS | 19219 | Number of tests: 6 10:17:49 INFO - PROCESS | 19219 | 10:17:49 INFO - PROCESS | 19219 | [#0] dojo.html Cycles:165 Average:5262.43 Median:5457.26 stddev:597.46 (10.9%) stddev-sans-first:574.79 10:17:49 INFO - PROCESS | 19219 | Values: 3103.5 3110.8 3121.5 3152.5 3190.6 5112.4 5173.2 5207.0 5298.5 5308.2 5199.1 5283.7 5297.1 5298.2 5336.2 4753.2 4830.5 4865.2 4873.2 4936.3 4871.4 4873.1 4893.2 4929.8 4934.2 4731.9 4774.4 4797.2 4851.7 4879.4 4756.4 4769.6 4777.5 4825.7 4892.5 4779.0 4808.7 4821.6 4832.7 4860.6 5096.4 5116.6 5179.0 5180.7 5253.9 5689.5 5691.8 5716.7 5718.4 5719.7 5702.7 5712.9 5754.6 5765.9 5767.9 5188.3 5263.3 5291.4 5296.2 5340.4 5845.7 5849.0 5854.8 5855.7 5858.5 5485.9 5636.0 5645.5 5647.7 5647.8 5598.4 5621.5 5627.8 5692.7 5694.1 5671.7 5672.7 5673.5 5679.7 5682.9 5508.1 5560.9 5692.9 5696.0 5698.6 4295.8 4327.5 4332.2 4350.3 4370.3 3855.1 3873.9 3879.3 3913.6 3920.7 5133.3 5153.0 5264.6 5266.2 5268.0 5630.4 5691.7 5704.4 5710.4 5764.0 5354.6 5362.2 5363.5 5364.7 5367.3 4606.6 4705.6 4729.0 4758.6 4796.7 5914.5 5927.7 5932.1 5935.9 5964.3 5705.3 5743.2 5743.9 5744.2 5745.4 5664.7 5768.2 5788.9 5819.9 5899.8 5627.9 5630.1 5634.9 5637.6 5639.0 5659.1 5704.1 5717.5 5724.2 5727.3 5354.5 5487.1 5553.7 5578.8 5607.0 5579.9 5583.1 5589.0 5589.9 5592.4 5285.6 5467.4 5496.8 5528.4 5570.4 5454.5 5457.3 5462.0 5547.6 5550.5 5384.3 5438.2 5439.8 5445.0 5488.6 10:17:49 INFO - PROCESS | 19219 | 10:17:49 INFO - PROCESS | 19219 | [#1] ext.html Cycles:180 Average:46203.79 Median:194622.00 stddev:81867.20 (42.1%) stddev-sans-first:82025.25 10:17:49 INFO - PROCESS | 19219 | Values: 597.5 614.0 618.4 630.9 642.5 33215.7 42926.6 44189.0 44242.6 44280.8 45964.8 46409.5 46459.0 46525.0 46550.8 7802.8 8707.2 8903.9 8908.2 10218.7 10113.9 10547.1 10547.2 10547.7 10556.9 10515.9 10558.4 10580.3 10612.3 10615.7 7816.0 8172.3 8182.0 10214.1 10504.4 10042.4 10066.4 10183.1 10193.4 10193.7 41644.0 42150.2 42160.0 42170.8 42216.6 3575.3 3594.0 3778.7 3854.2 3896.8 32336.4 32766.8 32977.8 33641.0 34455.7 4396.1 4517.8 4519.2 4520.5 4570.7 246615.0 247891.0 248441.0 353894.0 355174.0 31209.0 32315.2 32346.2 58776.0 59168.7 37045.8 37219.4 37380.8 37457.3 37457.8 14888.8 14950.9 15011.8 15031.8 15034.3 13044.3 13065.4 13079.7 13115.1 13135.5 8266.0 8374.7 8397.5 8410.5 8483.7 3214.3 3234.5 3297.5 3298.5 3313.2 1037.2 1066.2 1090.7 1134.3 1176.3 31403.8 31689.2 31820.5 31952.4 33032.5 1119.1 1136.3 1170.1 1218.7 1241.1 16706.3 17002.3 17080.7 17156.3 17317.4 153298.0 153549.2 153937.2 155504.0 155979.0 58854.4 60297.0 60297.4 60334.0 60360.4 1274.7 1360.5 1383.8 1389.8 1420.0 31582.5 34049.7 34054.7 34124.0 34352.1 44920.8 44931.8 45370.0 45414.8 45462.8 417259.0 417539.0 420223.0 421358.0 421895.0 25418.4 27129.7 28270.3 28371.4 29778.1 47422.3 47613.5 48030.3 48775.8 49265.0 41362.8 41970.0 42189.2 42317.6 42968.8 40413.6 40488.4 40538.8 41096.6 41662.0 41280.4 41751.6 41906.8 42122.2 42710.0 35350.0 36740.3 37150.8 37240.0 37465.8 28121.3 28176.4 28258.2 28459.7 28585.9 10:17:49 INFO - PROCESS | 19219 | 10:17:49 INFO - PROCESS | 19219 | [#2] jquery.html Cycles:180 Average:26765.25 Median:12608.63 stddev:74283.87 (589.2%) stddev-sans-first:74465.83 10:17:49 INFO - PROCESS | 19219 | Values: 380.8 382.3 383.5 398.0 407.8 17024.0 18757.6 19328.7 19334.0 19345.6 18362.8 18554.7 18937.8 19132.6 19173.3 5583.4 5593.8 5674.9 5712.0 5770.3 5431.4 5529.0 5536.3 5540.2 5597.8 5511.6 5590.6 5592.6 5593.9 5625.2 5425.8 5521.1 5546.3 5546.9 5629.1 4914.3 4961.7 5025.4 5037.9 5045.3 22194.7 22339.6 22473.2 22766.4 22889.0 2215.9 2283.8 2328.3 2330.3 2474.7 10779.4 13541.3 13875.5 14052.2 14375.1 1915.2 1920.7 1920.8 1962.5 1963.7 57295.0 68075.7 69358.1 72274.6 76470.6 9830.3 10322.5 10449.5 10644.1 10713.6 13061.3 13258.3 14162.1 14236.7 14882.0 7593.2 7724.3 7734.3 7993.8 8184.8 7091.7 7133.9 7201.8 7250.9 7297.5 6467.0 6541.4 6592.5 6687.0 6730.8 1814.9 1897.2 1919.4 1934.0 1941.7 961.7 962.6 977.1 1077.4 1087.4 18591.6 18716.6 19244.7 19282.0 19432.6 993.5 1000.4 1002.1 1020.9 1092.8 10652.0 11194.6 11264.9 11317.4 11346.1 447864.3 450482.0 453040.0 454926.0 458682.0 75120.0 75636.6 76011.2 76752.6 79446.2 1008.2 1014.9 1031.7 1038.3 1038.9 16952.2 16979.4 17268.8 17311.1 17560.0 36637.6 37954.8 38068.6 38637.9 39442.2 48998.3 49079.8 49217.3 49269.0 49303.5 7917.0 8239.1 8239.5 8270.3 8298.7 12809.0 12845.3 12900.7 12908.5 13100.9 11014.4 11305.9 11454.9 11547.3 11607.6 11351.5 11356.1 11373.7 11396.2 11567.2 11402.1 11468.2 11616.2 11734.0 11836.8 7140.0 7460.4 7576.5 8233.8 8285.0 8821.3 11015.7 11520.9 11628.7 11701.3 10:17:49 INFO - PROCESS | 19219 | 10:17:49 INFO - PROCESS | 19219 | [#3] mootools.html Cycles:180 Average:5780.61 Median:4370.30 stddev:3380.32 (77.3%) stddev-sans-first:3373.01 10:17:49 INFO - PROCESS | 19219 | Values: 1297.1 1415.2 1468.5 1570.0 1741.7 8420.5 8658.1 8728.6 8908.6 8933.8 8470.1 8675.7 8685.8 8714.8 8758.1 1978.1 1982.0 2040.3 2250.2 2282.5 2290.3 2297.9 2299.0 2300.2 2301.4 2264.6 2277.0 2290.2 2291.1 2294.5 1885.8 2100.5 2104.3 2161.2 2166.9 2204.3 2222.8 2238.6 2243.8 2245.0 8686.8 8727.7 8731.7 8743.3 8768.8 4932.3 5009.5 5035.7 5044.0 5050.5 3010.4 3148.8 3201.1 3203.4 3209.3 1035.3 1045.2 1078.9 1083.6 1097.8 12609.7 12659.2 12689.4 12701.7 12716.2 4288.5 4401.6 4454.4 4497.0 4504.5 10432.6 10436.7 10440.8 10460.6 10505.0 5062.7 5117.7 5123.9 5124.7 5130.7 4226.1 4642.4 4786.4 4798.3 4849.6 3830.6 3885.8 3911.9 3944.3 3985.2 1179.7 1185.6 1189.6 1192.6 1212.4 1004.8 1012.8 1013.3 1021.6 1034.1 5722.4 5816.3 5845.2 5850.0 6036.4 433.7 450.1 463.9 464.6 465.7 4134.3 4266.2 4278.4 4336.9 4339.0 10602.4 10943.8 10969.7 11000.2 11065.2 10847.8 10885.5 10923.5 10944.9 10951.3 7916.7 8120.8 8190.3 8214.8 8217.6 6116.8 6173.5 6191.8 6253.6 6310.5 9892.8 10088.0 10093.2 10104.0 10118.8 9971.4 10097.3 10287.3 10319.7 10418.8 7707.8 8109.0 8201.9 8338.5 8390.9 8445.4 8555.5 8596.9 8620.6 8633.9 7594.4 7695.5 7705.2 7870.5 7886.8 7503.2 7592.2 7652.5 7658.5 7764.4 7108.6 7291.5 7318.6 7323.1 7328.6 5018.8 5080.2 5086.7 5196.9 5205.8 5127.6 5266.9 5282.6 5317.2 5330.4 10:17:49 INFO - PROCESS | 19219 | 10:17:49 INFO - PROCESS | 19219 | [#4] prototype.html Cycles:180 Average:4533.64 Median:5123.29 stddev:1326.18 (25.9%) stddev-sans-first:1291.52 10:17:49 INFO - PROCESS | 19219 | Values: 313.2 328.1 328.7 330.3 332.4 4968.9 5257.0 5267.4 5295.0 5331.3 5276.9 5320.1 5321.9 5328.8 5340.6 4150.3 4151.4 4159.8 4217.9 4231.0 3903.8 4087.8 4245.4 4249.9 4270.5 4036.0 4054.3 4060.2 4082.2 4090.4 4079.7 4080.9 4085.9 4095.8 4098.6 3578.6 3586.4 3596.3 3602.8 3636.2 5071.6 5074.6 5079.9 5081.9 5115.9 4631.7 4641.9 4670.6 4680.0 4689.6 5505.2 5507.3 5526.3 5539.5 5549.5 3756.6 3914.9 3927.5 3934.3 3950.9 5419.6 5593.7 5742.0 5747.8 5765.5 4026.8 4028.7 4036.3 4046.2 4048.6 3901.2 3988.8 4037.3 4073.8 4082.4 4626.2 4643.6 4659.3 4664.5 4665.4 5579.8 5594.2 5601.7 5604.1 5637.3 1345.4 1380.8 1392.7 1395.8 1405.8 878.5 888.3 899.8 901.5 903.4 4701.5 4708.7 4720.4 4783.7 4829.3 5081.6 5095.8 5114.8 5130.6 5133.9 4446.6 4745.9 4779.0 4785.9 4789.0 2714.3 2719.3 2733.5 2734.9 2749.0 5209.4 5212.7 5212.8 5237.5 5241.6 4878.8 5063.0 5178.5 5183.2 5198.5 5171.7 5228.8 5258.8 5278.7 5320.3 5153.7 5157.7 5202.3 5405.2 5545.4 5649.5 5652.6 5661.2 5665.8 5689.4 5831.9 5840.5 5841.2 5844.4 5848.0 3983.6 4024.8 4078.1 4091.3 4113.8 5699.8 5716.0 5729.5 5730.1 5730.3 5453.1 5568.7 5612.7 5625.0 5626.2 5458.4 5479.5 5495.9 5502.2 5580.6 5402.6 5410.9 5413.3 5413.6 5448.7 5242.5 5476.3 5500.5 5547.6 5578.7 5351.3 5396.4 5445.8 5458.8 5478.8 10:17:49 INFO - PROCESS | 19219 | 10:17:49 INFO - PROCESS | 19219 | [#5] yui.html Cycles:180 Average:20068.36 Median:4959.41 stddev:28600.93 (576.7%) stddev-sans-first:28644.02 10:17:49 INFO - PROCESS | 19219 | Values: 654.9 656.3 741.3 797.4 820.6 14359.6 15369.6 15378.4 15387.2 15398.0 13060.9 13264.7 13302.1 13319.5 13352.5 666.9 677.3 785.5 807.6 810.4 800.7 807.4 808.3 812.2 815.2 707.7 862.2 864.3 864.6 864.8 829.1 844.3 847.5 848.9 853.1 623.3 623.8 624.3 625.3 626.3 14398.4 14526.1 14555.5 14559.5 14598.5 14036.4 14149.3 14211.8 14283.4 14462.3 12179.5 12324.9 12345.7 12446.9 12573.5 4382.3 4419.4 4437.5 4506.3 4646.6 76366.0 77096.0 78405.0 78610.0 79376.2 11569.5 11736.3 11759.9 11813.5 11819.9 22333.7 22404.8 22537.7 22579.9 22586.7 8118.2 8150.0 8164.8 8166.5 8211.1 4743.5 4804.1 4817.6 4885.3 4904.1 3289.8 3294.1 3295.4 3321.1 3374.4 591.6 609.8 613.5 613.8 616.1 648.9 656.8 674.8 680.7 704.5 8850.0 8904.5 9105.3 9146.9 9343.1 584.7 612.8 684.3 691.3 733.6 4743.8 4822.9 4843.3 4916.0 5002.9 73974.0 75633.0 114481.0 116996.4 117430.4 65706.7 88363.0 98344.5 99166.0 101712.0 72585.6 87917.6 88184.6 88950.6 89051.6 8995.0 9006.8 9057.4 9084.6 9142.0 51336.5 51627.0 51633.2 52789.7 53316.8 69207.7 76848.0 78420.6 79753.6 79884.0 11988.0 12136.8 12168.9 12268.6 12741.7 13864.2 14047.7 14051.4 14076.2 14200.4 12608.7 12711.6 12715.4 12827.3 12861.8 12036.2 12413.8 12889.8 12955.0 13908.4 12487.9 12581.2 13083.3 13104.9 13661.7 9828.5 9996.2 10008.2 10042.2 10068.7 10247.3 10964.4 10976.5 10993.3 11049.6 10:17:49 INFO - PROCESS | 19219 | -------- Summary: end -------- 10:17:49 INFO - PROCESS | 19219 | 10:17:50 INFO - TEST-INFO | 19219: exit 0 10:17:50 INFO - TEST-OK | dromaeo_css | took 1112815ms 10:17:50 INFO - TEST-START | kraken 10:17:50 INFO - operating with platform_type : linux_ 10:17:50 INFO - Initialising browser for kraken test... 10:17:50 INFO - TEST-INFO | started process 19402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEfpl52/profile http://localhost:37627/getInfo.html) 10:17:54 INFO - PROCESS | 19402 | __metrics Screen width/height:1600/1200 10:17:54 INFO - PROCESS | 19402 | colorDepth:24 10:17:54 INFO - PROCESS | 19402 | Browser inner width/height: 1024/697 10:17:54 INFO - PROCESS | 19402 | __metrics 10:17:54 ERROR - PROCESS | 19402 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:17:55 INFO - PROCESS | 19402 | console.error: PushService: 10:17:55 INFO - PROCESS | 19402 | stateChangeProcessEnqueue: Error transitioning state 10:17:55 INFO - PROCESS | 19402 | UnknownError 10:17:55 INFO - TEST-INFO | 19402: exit 0 10:17:55 INFO - Browser initialized. 10:17:55 INFO - Running cycle 1/1 for kraken test... 10:17:55 INFO - TEST-INFO | started process 19485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEfpl52/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:07 INFO - PROCESS | 19485 | RSS: Main: 155942912 10:18:07 INFO - PROCESS | 19485 | 10:18:10 INFO - PROCESS | 19485 | Cycle 1(1): loaded http://localhost:37627/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37627/tests/kraken/driver.html?testName=audio-beat-detection) 10:18:11 INFO - PROCESS | 19485 | RSS: Main: 214982656 10:18:11 INFO - PROCESS | 19485 | 10:18:13 INFO - PROCESS | 19485 | Cycle 1(1): loaded http://localhost:37627/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37627/tests/kraken/driver.html?testName=audio-dft) 10:18:14 INFO - PROCESS | 19485 | RSS: Main: 201809920 10:18:14 INFO - PROCESS | 19485 | 10:18:17 INFO - PROCESS | 19485 | Cycle 1(1): loaded http://localhost:37627/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37627/tests/kraken/driver.html?testName=audio-fft) 10:18:18 INFO - PROCESS | 19485 | RSS: Main: 269549568 10:18:18 INFO - PROCESS | 19485 | 10:18:20 INFO - PROCESS | 19485 | Cycle 1(1): loaded http://localhost:37627/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37627/tests/kraken/driver.html?testName=audio-oscillator) 10:18:20 INFO - PROCESS | 19485 | RSS: Main: 180166656 10:18:20 INFO - PROCESS | 19485 | 10:18:22 INFO - PROCESS | 19485 | Cycle 1(1): loaded http://localhost:37627/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37627/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:18:23 INFO - PROCESS | 19485 | RSS: Main: 184094720 10:18:23 INFO - PROCESS | 19485 | 10:18:26 INFO - PROCESS | 19485 | Cycle 1(1): loaded http://localhost:37627/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37627/tests/kraken/driver.html?testName=imaging-darkroom) 10:18:27 INFO - PROCESS | 19485 | RSS: Main: 218353664 10:18:27 INFO - PROCESS | 19485 | 10:18:30 INFO - PROCESS | 19485 | Cycle 1(1): loaded http://localhost:37627/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37627/tests/kraken/driver.html?testName=imaging-desaturate) 10:18:31 INFO - PROCESS | 19485 | RSS: Main: 220618752 10:18:31 INFO - PROCESS | 19485 | 10:18:33 INFO - PROCESS | 19485 | Cycle 1(1): loaded http://localhost:37627/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37627/tests/kraken/driver.html?testName=json-parse-financial) 10:18:34 INFO - PROCESS | 19485 | RSS: Main: 220774400 10:18:34 INFO - PROCESS | 19485 | 10:18:36 INFO - PROCESS | 19485 | Cycle 1(1): loaded http://localhost:37627/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37627/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:18:36 INFO - PROCESS | 19485 | RSS: Main: 208138240 10:18:36 INFO - PROCESS | 19485 | 10:18:38 INFO - PROCESS | 19485 | Cycle 1(1): loaded http://localhost:37627/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37627/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:18:38 INFO - PROCESS | 19485 | RSS: Main: 209686528 10:18:38 INFO - PROCESS | 19485 | 10:18:40 INFO - PROCESS | 19485 | Cycle 1(1): loaded http://localhost:37627/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37627/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:18:41 INFO - PROCESS | 19485 | RSS: Main: 216444928 10:18:41 INFO - PROCESS | 19485 | 10:18:44 INFO - PROCESS | 19485 | Cycle 1(1): loaded http://localhost:37627/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37627/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:18:44 INFO - PROCESS | 19485 | RSS: Main: 220532736 10:18:44 INFO - PROCESS | 19485 | 10:18:47 INFO - PROCESS | 19485 | Cycle 1(1): loaded http://localhost:37627/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37627/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:18:48 INFO - PROCESS | 19485 | RSS: Main: 220889088 10:18:48 INFO - PROCESS | 19485 | 10:18:49 INFO - PROCESS | 19485 | Cycle 1(1): loaded http://localhost:37627/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37627/tests/kraken/driver.html?testName=ai-astar) 10:18:50 INFO - PROCESS | 19485 | RSS: Main: 263753728 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - PROCESS | 19485 | __start_tp_report 10:18:50 INFO - PROCESS | 19485 | _x_x_mozilla_page_load 10:18:50 INFO - PROCESS | 19485 | _x_x_mozilla_page_load_details 10:18:50 INFO - PROCESS | 19485 | |i|pagename|runs| 10:18:50 INFO - PROCESS | 19485 | |0;ai-astar;112;108;114;112;110;111;109;111;112;110 10:18:50 INFO - PROCESS | 19485 | |1;audio-beat-detection;152;124;126;185;127;127;162;125;174;131 10:18:50 INFO - PROCESS | 19485 | |2;audio-dft;160;160;160;160;160;161;161;161;162;161 10:18:50 INFO - PROCESS | 19485 | |3;audio-fft;75;74;75;120;75;74;73;74;102;75 10:18:50 INFO - PROCESS | 19485 | |4;audio-oscillator;85;85;122;85;85;86;112;87;86;132 10:18:50 INFO - PROCESS | 19485 | |5;imaging-gaussian-blur;117;117;118;117;116;117;117;118;117;116 10:18:50 INFO - PROCESS | 19485 | |6;imaging-darkroom;145;146;145;145;145;145;145;146;146;145 10:18:50 INFO - PROCESS | 19485 | |7;imaging-desaturate;97;95;95;96;95;96;95;95;96;95 10:18:50 INFO - PROCESS | 19485 | |8;json-parse-financial;56;56;55;57;56;55;56;56;55;56 10:18:50 INFO - PROCESS | 19485 | |9;json-stringify-tinderbox;61;61;61;61;60;60;67;62;61;61 10:18:50 INFO - PROCESS | 19485 | |10;stanford-crypto-aes;80;79;80;79;79;80;81;81;112;81 10:18:50 INFO - PROCESS | 19485 | |11;stanford-crypto-ccm;134;121;136;124;126;122;129;126;128;132 10:18:50 INFO - PROCESS | 19485 | |12;stanford-crypto-pbkdf2;162;163;157;161;158;156;161;160;156;164 10:18:50 INFO - PROCESS | 19485 | |13;stanford-crypto-sha256-iterative;64;62;70;62;67;61;62;61;62;63 10:18:50 INFO - PROCESS | 19485 | __end_tp_report 10:18:50 INFO - PROCESS | 19485 | __start_cc_report 10:18:50 INFO - PROCESS | 19485 | _x_x_mozilla_cycle_collect,1609 10:18:50 INFO - PROCESS | 19485 | __end_cc_report 10:18:50 INFO - PROCESS | 19485 | __startTimestamp1465406330059__endTimestamp 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - PROCESS | 19485 | ------- Summary: start ------- 10:18:50 INFO - PROCESS | 19485 | Number of tests: 14 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - PROCESS | 19485 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:1.73 (1.6%) stddev-sans-first:1.79 10:18:50 INFO - PROCESS | 19485 | Values: 112.0 108.0 114.0 112.0 110.0 111.0 109.0 111.0 112.0 110.0 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - PROCESS | 19485 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:141.50 stddev:23.08 (16.3%) stddev-sans-first:24.27 10:18:50 INFO - PROCESS | 19485 | Values: 152.0 124.0 126.0 185.0 127.0 127.0 162.0 125.0 174.0 131.0 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - PROCESS | 19485 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 10:18:50 INFO - PROCESS | 19485 | Values: 160.0 160.0 160.0 160.0 160.0 161.0 161.0 161.0 162.0 161.0 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - PROCESS | 19485 | [#3] audio-fft Cycles:10 Average:81.70 Median:74.50 stddev:16.03 (21.5%) stddev-sans-first:16.82 10:18:50 INFO - PROCESS | 19485 | Values: 75.0 74.0 75.0 120.0 75.0 74.0 73.0 74.0 102.0 75.0 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - PROCESS | 19485 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:85.00 stddev:18.23 (21.4%) stddev-sans-first:18.85 10:18:50 INFO - PROCESS | 19485 | Values: 85.0 85.0 122.0 85.0 85.0 86.0 112.0 87.0 86.0 132.0 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - PROCESS | 19485 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:18:50 INFO - PROCESS | 19485 | Values: 117.0 117.0 118.0 117.0 116.0 117.0 117.0 118.0 117.0 116.0 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - PROCESS | 19485 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 10:18:50 INFO - PROCESS | 19485 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 145.0 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - PROCESS | 19485 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.50 10:18:50 INFO - PROCESS | 19485 | Values: 97.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - PROCESS | 19485 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 10:18:50 INFO - PROCESS | 19485 | Values: 56.0 56.0 55.0 57.0 56.0 55.0 56.0 56.0 55.0 56.0 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - PROCESS | 19485 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.00 stddev:2.01 (3.3%) stddev-sans-first:2.13 10:18:50 INFO - PROCESS | 19485 | Values: 61.0 61.0 61.0 61.0 60.0 60.0 67.0 62.0 61.0 61.0 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - PROCESS | 19485 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:80.00 stddev:10.15 (12.7%) stddev-sans-first:10.70 10:18:50 INFO - PROCESS | 19485 | Values: 80.0 79.0 80.0 79.0 79.0 80.0 81.0 81.0 112.0 81.0 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - PROCESS | 19485 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:128.50 stddev:5.01 (3.9%) stddev-sans-first:4.78 10:18:50 INFO - PROCESS | 19485 | Values: 134.0 121.0 136.0 124.0 126.0 122.0 129.0 126.0 128.0 132.0 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - PROCESS | 19485 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:161.00 stddev:2.90 (1.8%) stddev-sans-first:2.96 10:18:50 INFO - PROCESS | 19485 | Values: 162.0 163.0 157.0 161.0 158.0 156.0 161.0 160.0 156.0 164.0 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - PROCESS | 19485 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:62.50 stddev:2.91 (4.7%) stddev-sans-first:3.08 10:18:50 INFO - PROCESS | 19485 | Values: 64.0 62.0 70.0 62.0 67.0 61.0 62.0 61.0 62.0 63.0 10:18:50 INFO - PROCESS | 19485 | -------- Summary: end -------- 10:18:50 INFO - PROCESS | 19485 | 10:18:50 INFO - TEST-INFO | 19485: exit 0 10:18:51 INFO - TEST-OK | kraken | took 60897ms 10:18:51 INFO - SUITE-END | took 1173s 10:18:51 INFO - Completed test suite (00:19:33) 10:18:51 INFO - javascript benchmark 10:18:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.5189545620437, 3110.7977981431204, 3121.5317702344646, 3152.527120931861, 3190.601174853143, 5112.412072611651, 5173.198154286082, 5206.973965130173, 5298.4966428189355, 5308.177232528955, 5199.116150254456, 5283.735813209343, 5297.099493086175, 5298.20526920962, 5336.199570064492, 4753.1681955657705, 4830.541098595628, 4865.221564549673, 4873.244647079709, 4936.33359496467, 4871.391076115486, 4873.098476781806, 4893.1926232171645, 4929.8028078876805, 4934.21052631579, 4731.90536189276, 4774.40319960005, 4797.208460603996, 4851.708897466164, 4879.365682461293, 4756.3816703828625, 4769.570738633505, 4777.5222477752295, 4825.734584597846, 4892.486288939645, 4778.976105119487, 4808.711477311373, 4821.566059054702, 4832.661713680044, 4860.562549370574, 5096.413912400084, 5116.590672746172, 5179.015986962465, 5180.6891586504935, 5253.86865328366, 5689.459501347365, 5691.800786972478, 5716.657000579937, 5718.42815718429, 5719.742611582489, 5702.657840529581, 5712.8857422851725, 5754.597178197528, 5765.913511297334, 5767.942320576783, 5188.273641690166, 5263.26314315996, 5291.444398338158, 5296.232046353296, 5340.412554618989, 5845.678487683218, 5849.034909239927, 5854.765809367577, 5855.677937713466, 5858.47273745365, 5485.917711234335, 5635.971820140873, 5645.463680950304, 5647.745851436695, 5647.774089036392, 5598.356189038313, 5621.5221706155435, 5627.774889004476, 5692.715364231772, 5694.06048002075, 5671.688057156896, 5672.716364181774, 5673.489385955284, 5679.659220446786, 5682.943170568242, 5508.091164957817, 5560.86097847549, 5692.857678557986, 5696.0, 5698.601097923189, 4295.78521073945, 4327.545607711208, 4332.155229730235, 4350.282203436397, 4370.2570563004365, 3855.132595166121, 3873.8837834865, 3879.262940041383, 3913.5695073541888, 3920.7059470539825, 5133.332666753298, 5153.020926024044, 5264.6314757966575, 5266.236395722599, 5268.025415298182, 5630.4369563043365, 5691.715414229272, 5704.4295570443455, 5710.400407957105, 5763.971180144073, 5354.625176237626, 5362.249285100089, 5363.544098751572, 5364.678119312854, 5367.302250707383, 4606.56237657422, 4705.623550115983, 4728.976355118271, 4758.643101767381, 4796.664233503621, 5914.526837852962, 5927.73325200367, 5932.080527518242, 5935.910961335583, 5964.31410387811, 5705.315362156485, 5743.195952566728, 5743.9138412923, 5744.195812586157, 5745.425457454221, 5664.688442135722, 5768.192453056491, 5788.9131663024245, 5819.854503637443, 5899.764009439746, 5627.8593035174445, 5630.127330263816, 5634.943650563606, 5637.57718171147, 5639.0, 5659.094544872801, 5704.087346024616, 5717.5425965921795, 5724.198612194379, 5727.255456790591, 5354.518093371459, 5487.149491828773, 5553.666779993213, 5578.776848925998, 5607.046802043744, 5579.860503487445, 5583.106702927675, 5589.049861523469, 5589.860253493695, 5592.412796656293, 5285.63000589955, 5467.398586155599, 5496.80761173357, 5528.419515950767, 5570.387257401763, 5454.481824226692, 5457.263269458573, 5462.0441422751655, 5547.55619550443, 5550.5282051026115, 5384.326959130109, 5438.18427235902, 5439.836804895859, 5444.972775136099, 5488.643238189505], "value": 5222.777157409791, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.4712379544102, 613.9600925939815, 618.3816183816184, 630.8864404407208, 642.5277421095496, 33215.66784332159, 42926.57073429265, 44189.0, 44242.557574424245, 44280.77859610701, 45964.770176149155, 46409.53590464094, 46459.0, 46525.0, 46550.76724616381, 7802.8439431211345, 8707.216350528452, 8903.910960890405, 8908.153725396078, 10218.693439196799, 10113.949430252838, 10547.101521726087, 10547.208959328043, 10547.683569492927, 10556.947215263914, 10515.894841051568, 10558.366498010144, 10580.312279701795, 10612.310199836986, 10615.681529554087, 7815.96092019542, 8172.305354044914, 8182.01815782104, 10214.08073273409, 10504.422256775873, 10042.4476653784, 10066.396016239049, 10183.134433573156, 10193.439360835151, 10193.694189174263, 41644.0, 42150.15699685989, 42160.0, 42170.78914605438, 42216.57783422157, 3575.302815950891, 3594.02961200477, 3778.678812300958, 3854.209886973164, 3896.7856767877756, 32336.355484706444, 32766.836165819255, 32977.83511082453, 33641.0, 34455.655443445496, 4396.120775844844, 4517.819287228507, 4519.209138400766, 4520.50274469808, 4570.680052396334, 246615.0, 247891.0, 248441.0, 353894.0, 355174.0, 31209.0, 32315.19212019718, 32346.191345216557, 58776.0, 59168.70415647894, 37045.81477092597, 37219.4417083744, 37380.81309593435, 37457.314420850584, 37457.81271093627, 14888.776668349983, 14950.925245373703, 15011.849881501264, 15031.849681503263, 15034.323455444532, 13044.282564459047, 13065.412056457482, 13079.673008174681, 13115.08194426381, 13135.474581016844, 8266.008079030555, 8374.701921202224, 8397.496150231005, 8410.49537027768, 8483.660653573912, 3214.260720034405, 3234.498652708834, 3297.50537419389, 3298.472244440926, 3313.237955270253, 1037.2381421205127, 1066.168388656849, 1090.7055095124272, 1134.2570616246371, 1176.3294921894437, 31403.842980785408, 31689.207769805478, 31820.522692159637, 31952.360952780815, 33032.50451243233, 1119.0698228139493, 1136.3466007045981, 1170.145793570698, 1218.7196944702591, 1241.0878004666563, 16706.331746729993, 17002.319907203822, 17080.743788843178, 17156.31374745021, 17317.393891213746, 153298.0, 153549.232253838, 153937.23031384996, 155504.0, 155979.0, 58854.41145588575, 60297.0, 60297.397026030056, 60334.0, 60360.396396036354, 1274.6877015131352, 1360.5034162530605, 1383.7924311353377, 1389.7984792205275, 1419.964500887486, 31582.526262105628, 34049.65950340564, 34054.65945340515, 34124.0, 34352.141196470286, 44920.77539612281, 44931.77534112309, 45370.0, 45414.772926135156, 45462.772686136355, 417259.0, 417539.0, 420223.0, 421358.0, 421895.0, 25418.364540886625, 27129.72870271351, 28270.293242669097, 28371.43257134887, 29778.10665680033, 47422.288665670734, 47613.52386476091, 48030.27954580754, 48775.756121219165, 49265.0, 41362.79318603388, 41970.0, 42189.15621687488, 42317.576824231364, 42968.78515607402, 40413.59586404216, 40488.3926741105, 40538.79730601328, 41096.589034110475, 41662.0, 41280.38079428871, 41751.58248417477, 41906.790466047474, 42122.157556849306, 42710.0, 35350.0, 36740.26519469649, 37150.814245928595, 37240.0, 37465.81267093647, 28121.296967575974, 28176.436471270048, 28258.15225543237, 28459.715402846534, 28585.85707071451], "value": 18436.06649143057, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.767731683673, 382.27749553344165, 383.4937881995765, 397.9761214327141, 407.81240629310514, 17024.0, 18757.624847503077, 19328.710069348937, 19334.0, 19345.61308773824, 18362.816371836278, 18554.72167917482, 18937.841022746405, 19132.61734765304, 19173.32893348733, 5583.35791383991, 5593.8321850344555, 5674.858128546778, 5712.000399930016, 5770.307563092414, 5431.402545719968, 5528.9723551382185, 5536.252605898192, 5540.196671482632, 5597.804076857311, 5511.641743286694, 5590.580706447013, 5592.5805564582615, 5593.916091258634, 5625.1843482694985, 5425.782968681248, 5521.1442226455165, 5546.251256080418, 5546.944530554703, 5629.099344104964, 4914.287428322909, 4961.652684312099, 5025.39695236574, 5037.949620503785, 5045.344105266292, 22194.667079993815, 22339.55320893573, 22473.213437529772, 22766.430839229153, 22889.0, 2215.900284487202, 2283.828712846543, 2328.2665960222475, 2330.34750269923, 2474.6906636670415, 10779.407132607703, 13541.255230962293, 13875.514356997557, 14052.156870587694, 14375.137491750529, 1915.2339064374362, 1920.7407000054955, 1920.7791104022938, 1962.4505138561226, 1963.6563601369846, 57295.0, 68075.65962170158, 69358.14492985493, 72274.63862680705, 76470.61764691197, 9830.262730295257, 10322.535485903003, 10449.529771160316, 10644.148468122532, 10713.571457141627, 13061.281629510468, 13258.337083145803, 14162.079464834753, 14236.715265694835, 14881.958262921491, 7593.164751877289, 7724.300653856143, 7734.265244801735, 7993.840123197503, 8184.836303273901, 7091.680874360666, 7133.92866071343, 7201.783946481614, 7250.854982900418, 7297.4891757577525, 6466.976928408791, 6541.411272985359, 6592.472602191813, 6687.0, 6730.764423245163, 1814.945551633453, 1897.1747289928649, 1919.395390452003, 1934.0, 1941.7087436884299, 961.7162936933621, 962.6005207838668, 977.0913050862766, 1077.42357838556, 1087.4019289390963, 18591.628167436575, 18716.625667486573, 19244.71132933007, 19282.0, 19432.62270304683, 993.4585650820176, 1000.4347543637966, 1002.1481740520645, 1020.8723909511311, 1092.7705181911729, 10651.988061134334, 11194.608188713355, 11264.887351126548, 11317.377544234982, 11346.149038821955, 447864.3247486322, 450482.0, 453040.0, 454926.0, 458682.0, 75120.0, 75636.62181689167, 76011.23988760152, 76752.61623691846, 79446.20553794503, 1008.1531513528671, 1014.9035841595037, 1031.6904928521415, 1038.3250886923408, 1038.8649475568127, 16952.15239238058, 16979.40572080021, 17268.827311727226, 17311.13444327804, 17560.0, 36637.63362366342, 37954.81022594869, 38068.61931380651, 38637.85786862764, 39442.21115577615, 48998.265026023924, 49079.75460122676, 49217.26174107463, 49269.0, 49303.50696492989, 7916.960415197887, 8239.093699693149, 8239.505629662239, 8270.2556769891, 8298.70954516589, 12809.039322050698, 12845.293508857103, 12900.741985160432, 12908.548200812926, 13100.868991309964, 11014.3942083183, 11305.886941130813, 11454.885451145716, 11547.307161570332, 11607.620784679384, 11351.489182986621, 11356.0915126788, 11373.658790236306, 11396.202265841312, 11567.190296679151, 11402.087832973177, 11468.197226194086, 11616.186866919235, 11734.0, 11836.763264734485, 7140.0, 7460.3658689012045, 7576.545407275581, 8233.83532329362, 8285.0, 8821.250193733347, 11015.724606884893, 11520.884791152317, 11628.709282268012, 11701.2979221247], "value": 8992.356384163348, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.0725930959363, 1415.2499175437015, 1468.4933697874233, 1569.9529014129573, 1741.669082874253, 8420.452670576416, 8658.13418658134, 8728.563571821407, 8908.643654253838, 8933.821323573524, 8470.068292487822, 8675.739727808175, 8685.782855428617, 8714.825703485927, 8758.12418758124, 1978.0801927103894, 1981.9603607927834, 2040.2757021257462, 2250.2349201271604, 2282.543491301738, 2290.3014580552926, 2297.908083676651, 2299.034405549673, 2300.2409204962323, 2301.413139649387, 2264.6036943534896, 2276.9886150569305, 2290.198430549303, 2291.0606651272983, 2294.4952110535737, 1885.81141885811, 2100.47488127968, 2104.2740254612136, 2161.211157927361, 2166.938200281866, 2204.2836078274463, 2222.7777222277805, 2238.5746708125403, 2243.83320673249, 2244.9663255051187, 8686.826263474695, 8727.650893964234, 8731.738047858575, 8743.344249181273, 8768.780780480476, 4932.260160975847, 5009.5491405773655, 5035.672681275742, 5043.974780126113, 5050.545450909436, 3010.3527741535454, 3148.7638427117827, 3201.055688571854, 3203.3593281343824, 3209.326041531281, 1035.316690983947, 1045.231754660324, 1078.9298695584762, 1083.626148978609, 1097.7969075721016, 12609.684757881127, 12659.240445573296, 12689.365531723377, 12701.74596508074, 12716.173448725804, 4288.463942007249, 4401.6478681705385, 4454.37638730578, 4496.977515112403, 4504.481984571817, 10432.634857779942, 10436.686899393031, 10440.843387349196, 10460.63387781424, 10505.0, 5062.7468626568525, 5117.74411279442, 5123.8719032023755, 5124.692518448905, 5130.743462826844, 4226.112516371596, 4642.396488456479, 4786.44955830084, 4798.2802579612635, 4849.612031037508, 3830.597787232356, 3885.8445662173194, 3911.941320880189, 3944.2505923874373, 3985.183037477368, 1179.728662407651, 1185.6146752305535, 1189.5895915908998, 1192.5587532612815, 1212.3938030984507, 1004.829179039565, 1012.7518757904213, 1013.3312014070825, 1021.5556233038652, 1034.131329683055, 5722.4277572242445, 5816.331121920949, 5845.240118784531, 5849.970750146222, 6036.366181550961, 433.70074648492437, 450.0795872440866, 463.91881420751236, 464.6027646362379, 465.6763549333249, 4134.3178375568295, 4266.232078225887, 4278.4010238566625, 4336.891577710519, 4338.9566104338555, 10602.36385816838, 10943.835842462211, 10969.725756856142, 11000.174986876016, 11065.225434219527, 10847.837282440769, 10885.510152043018, 10923.508442120125, 10944.945275273572, 10951.288166269167, 7916.683332666629, 8120.837583248302, 8190.2628763410385, 8214.794630134174, 8217.630206640595, 6116.785912493041, 6173.506119510339, 6191.84520386994, 6253.593516421418, 6310.52671049664, 9892.752681183028, 10087.991200879853, 10093.243006774375, 10104.0, 10118.8482172766, 9971.40171589707, 10097.343672661253, 10287.331323463952, 10319.742006449898, 10418.843717344398, 7707.807304817425, 8108.9594552026865, 8201.876971845308, 8338.499690018618, 8390.916090839013, 8445.408821382443, 8555.486670799772, 8596.871046934177, 8620.61207245688, 8633.8704919425, 7594.392448604209, 7695.538267703956, 7705.22947705225, 7870.527768333918, 7886.802829929297, 7503.212162723054, 7592.202818703957, 7652.464327497244, 7658.502197357154, 7764.417668674759, 7108.644567771694, 7291.453141014551, 7318.597477138808, 7323.12122545298, 7328.633568321669, 5018.7741551631, 5080.161773307363, 5086.694798312114, 5196.870078248074, 5205.843824685266, 5127.5897928166405, 5266.920996185137, 5282.577393808563, 5317.175837745156, 5330.440303768203], "value": 4499.38909964864, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.213833278471, 328.1026392815649, 328.65983706863403, 330.2915246795624, 332.3900642321341, 4968.900621987558, 5256.973715131424, 5267.367915850094, 5295.0, 5331.333583302087, 5276.947230527693, 5320.14877619581, 5321.920171197435, 5328.786848526054, 5340.62615616907, 4150.3359462486005, 4151.356539736345, 4159.812808423613, 4217.85237516687, 4231.0, 3903.7852918089493, 4087.7751723655188, 4245.363195520666, 4249.8950272929105, 4270.508891477489, 4035.9798201008953, 4054.331035379159, 4060.1879624075304, 4082.2243773683053, 4090.4273401723635, 4079.714419990602, 4080.8979775505554, 4085.9172319335253, 4095.7747323897174, 4098.631123198927, 3578.5526809148855, 3586.37238483267, 3596.2627661329366, 3602.819859007039, 3636.236390358028, 5071.644984851062, 5074.644774865761, 5079.87300317495, 5081.872953176163, 5115.948840511584, 4631.675782695213, 4641.883952901171, 4670.556297151765, 4679.953200467986, 4689.601383882374, 5505.201745746845, 5507.284053073075, 5526.2592283430595, 5539.50144486994, 5549.528290095347, 3756.6431189037, 3914.8629797956933, 3927.528696556403, 3934.331163702149, 3950.920981580381, 5419.647722898038, 5593.748281327391, 5741.971290143564, 5747.827565173052, 5765.4811067004175, 4026.8187931543152, 4028.7179897407486, 4036.2936486114813, 4046.1705350403095, 4048.574899635496, 3901.239258344652, 3988.840446382112, 4037.313656678372, 4073.7555746655294, 4082.3872721458292, 4626.21354369758, 4643.582077613031, 4659.254519276899, 4664.527800265864, 4665.440147182292, 5579.776808927679, 5594.188842617879, 5601.747921343549, 5604.06659702402, 5637.252451739973, 1345.421468768439, 1380.827396575428, 1392.6978275312615, 1395.8045873577707, 1405.7539930512119, 878.503645440337, 888.3159966825638, 899.7840518275698, 901.5176880368971, 903.4488961733338, 4701.506341834127, 4708.670393072452, 4720.386349774507, 4783.6651434399255, 4829.2997515360075, 5081.618878584121, 5095.847124586268, 5114.795408183705, 5130.640855140179, 5133.8716532087, 4446.599806017474, 4745.928811067837, 4779.0, 4785.880352991203, 4788.952110478851, 2714.280715610365, 2719.2522056434245, 2733.523897095586, 2734.904278350248, 2748.9966162350997, 5209.374875014947, 5212.713300768418, 5212.7914883405, 5237.476252374732, 5241.554467870274, 4878.780304923698, 5062.977288505391, 5178.472350656565, 5183.248428977852, 5198.480151984847, 5171.663841850268, 5228.764705588258, 5258.763355649005, 5278.703763862732, 5320.255164277004, 5153.7165455900285, 5157.742112894265, 5202.271681964452, 5405.216243644571, 5545.445455454423, 5649.4633009864, 5652.576056795675, 5661.207430959586, 5665.830025099253, 5689.374168841341, 5831.912521312269, 5840.488589906381, 5841.1530328101335, 5844.386339434298, 5848.0, 3983.5618082011533, 4024.7987600619267, 4078.143589846047, 4091.284025295502, 4113.753174809521, 5699.800506982236, 5716.0, 5729.4843464088435, 5730.054541000688, 5730.255066841284, 5453.127499600045, 5568.663520754909, 5612.691301978431, 5624.971875140762, 5626.1842032905815, 5458.426865179258, 5479.479449452455, 5495.890082198413, 5502.174673798962, 5580.609357345109, 5402.594805389533, 5410.891782164414, 5413.269208656781, 5413.593980451403, 5448.727563621724, 5242.475752424727, 5476.288082549243, 5500.50495455411, 5547.639403438763, 5578.6611213309325, 5351.277577526984, 5396.406395296436, 5445.754941027584, 5458.836234912959, 5478.835634930799], "value": 4109.63954863755, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.9410553050227, 656.2944834303125, 741.3216906530524, 797.3541431440534, 820.6102101501788, 14359.64100897478, 15369.615759606015, 15378.384864605403, 15387.153706546136, 15398.0, 13060.934695326534, 13264.668383290398, 13302.068855180141, 13319.53381631643, 13352.532661356854, 666.9199696036458, 677.292229620047, 785.5326080981806, 807.5921659561913, 810.3841080778592, 800.7077416742906, 807.386386346378, 808.3210103513048, 812.1796985045088, 815.1685281013363, 707.7487491940365, 862.2239984014375, 864.256739204287, 864.6022829498438, 864.8010957479752, 829.0921441022072, 844.2907957315823, 847.478800537668, 848.8854004709347, 853.0786750309651, 623.3423737956454, 623.7941479311817, 624.2945471617089, 625.3059104394118, 626.2547568393643, 14398.352074156688, 14526.128432294096, 14555.490557830532, 14559.490417835324, 14598.489052883204, 14036.368363423568, 14149.292535373294, 14211.78682319766, 14283.357248923823, 14462.27688615565, 12179.451924663412, 12324.876751232463, 12345.69135771604, 12446.937765311206, 12573.497060117676, 4382.298832186835, 4419.447569053868, 4437.534058923831, 4506.278995360759, 4646.605038571725, 76366.0, 77096.0, 78405.0, 78609.99999999943, 79376.20623793745, 11569.479373428216, 11736.295822250693, 11759.941200294115, 11813.527458901548, 11819.881801181878, 22333.664995025087, 22404.775952240594, 22537.661935070988, 22579.88710056472, 22586.661200082013, 8118.228768267123, 8150.0, 8164.836703265902, 8166.510009399455, 8211.137830527829, 4743.454502732161, 4804.0872234275375, 4817.638677099161, 4885.267209918541, 4904.117258893433, 3289.802611843249, 3294.1270563300745, 3295.406826771204, 3321.136504508845, 3374.3757404880175, 591.5947575910515, 609.768288050538, 613.5275837605019, 613.8219916224334, 616.1220261127875, 648.9156409666713, 656.7537173559915, 674.7570874485182, 680.7447207297264, 704.4892452971554, 8849.955750221208, 8904.465732056098, 9105.317101217302, 9146.86279705805, 9343.112404321579, 584.7222569279559, 612.773273888664, 684.305429988562, 691.3155975584135, 733.6148522025873, 4743.786529606107, 4822.879428014257, 4843.321934929113, 4915.9508404916205, 5002.874928126753, 73974.0, 75633.0, 114481.0, 116996.41501792436, 117430.41284793521, 65706.67146664236, 88363.0, 98344.50827745815, 99166.0, 101712.0, 72585.6370718143, 87917.56041219753, 88184.55907720549, 88950.55524722335, 89051.55474222587, 8994.955025224832, 9006.819863602823, 9057.411268267542, 9084.591193396182, 9142.0, 51336.48663513317, 51627.0, 51633.225501616755, 52789.736051319494, 53316.813947933835, 69207.65396172987, 76848.0, 78420.60789696015, 79753.60123199347, 79884.0, 11988.0, 12136.817947730968, 12168.939155304166, 12268.570600028956, 12741.745165096832, 13864.168149911038, 14047.719045618825, 14051.36768845384, 14076.225807580682, 14200.360983755962, 12608.74782504363, 12711.61865144047, 12715.364231788188, 12827.294498802283, 12861.765189775733, 12036.157468977437, 12413.75172496527, 12889.8066529004, 12955.0, 13908.374123164684, 12487.93756031214, 12581.245125292511, 13083.280419576633, 13104.868951310746, 13661.658458538615, 9828.459434731158, 9996.150327222267, 10008.249381296286, 10042.246831487522, 10068.68838829709, 10247.282690211614, 10964.396958167059, 10976.506057227285, 10993.285436446926, 11049.613263535737], "value": 7361.678669791678, "unit": "score"}], "name": "dromaeo_css", "value": 7002.238699528284, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 114.0, 112.0, 110.0, 111.0, 109.0, 111.0, 112.0, 110.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 126.0, 185.0, 127.0, 127.0, 162.0, 125.0, 174.0, 131.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 162.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 120.0, 75.0, 74.0, 73.0, 74.0, 102.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 122.0, 85.0, 85.0, 86.0, 112.0, 87.0, 86.0, 132.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 57.0, 56.0, 55.0, 56.0, 56.0, 55.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 60.0, 60.0, 67.0, 62.0, 61.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 79.0, 79.0, 80.0, 81.0, 81.0, 112.0, 81.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 121.0, 136.0, 124.0, 126.0, 122.0, 129.0, 126.0, 128.0, 132.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 157.0, 161.0, 158.0, 156.0, 161.0, 160.0, 156.0, 164.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 70.0, 62.0, 67.0, 61.0, 62.0, 61.0, 62.0, 63.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1502.3, "alertThreshold": 2.0}]} 10:18:51 INFO - Return code: 0 10:18:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:18:51 ERROR - # TBPL SUCCESS # 10:18:51 INFO - Running post-action listener: _resource_record_post_action 10:18:51 INFO - ##### 10:18:51 INFO - ##### Finished run-tests step (success) 10:18:51 INFO - ##### 10:18:51 INFO - Running post-run listener: _resource_record_post_run 10:18:51 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 548966400; Read time: 16; Write time: 479556 10:18:51 INFO - TinderboxPrint: CPU usage
13.2% 10:18:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:18:51 INFO - TinderboxPrint: I/O write bytes / time
548,966,400 / 479,556 10:18:51 INFO - TinderboxPrint: CPU idle
8,258.2 (86.8%) 10:18:51 INFO - TinderboxPrint: CPU user
1,211.5 (12.7%) 10:18:51 INFO - TinderboxPrint: Swap in / out
0 / 0 10:18:51 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255754240; Read time: 0; Write time: 302656 10:18:51 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293212160; Read time: 16; Write time: 176900 10:18:51 INFO - Running post-run listener: _upload_blobber_files 10:18:51 INFO - Blob upload gear active. 10:18:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:18:51 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:51 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:51 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:52 INFO - (blobuploader) - INFO - Open directory for files ... 10:18:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:18:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:18:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:53 INFO - (blobuploader) - INFO - Done attempting. 10:18:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:18:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:18:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:54 INFO - (blobuploader) - INFO - Done attempting. 10:18:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:18:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:18:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:58 INFO - (blobuploader) - INFO - Done attempting. 10:18:58 INFO - (blobuploader) - INFO - Iteration through files over. 10:18:58 INFO - Return code: 0 10:18:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:18:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:18:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/51dd63727375d481158a38b4fabe145825f59965285b27e2fad50b470f9de03747fbd8952c59526f593cb035f28aeca9c1515bdb6157c6cdfbeb675575182813", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/230dfabdc19ca63a5f4e3b3358be7f2d4a25489b18cb8f5e879284012462af31569f11cd43e1cdfbb09c83b1017844414f767ab10a5699f486b5fc454afdcb24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e43bd82cfb288fa4e73f5b45fa430543097f5ba2a977ebf9b08c69a09f0f5a106d46655744f09046fd78f38101f5a958c9529fd30de5a4ff3d08e926aeea4a2b"} 10:18:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:18:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:18:58 INFO - Contents: 10:18:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/51dd63727375d481158a38b4fabe145825f59965285b27e2fad50b470f9de03747fbd8952c59526f593cb035f28aeca9c1515bdb6157c6cdfbeb675575182813", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/230dfabdc19ca63a5f4e3b3358be7f2d4a25489b18cb8f5e879284012462af31569f11cd43e1cdfbb09c83b1017844414f767ab10a5699f486b5fc454afdcb24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e43bd82cfb288fa4e73f5b45fa430543097f5ba2a977ebf9b08c69a09f0f5a106d46655744f09046fd78f38101f5a958c9529fd30de5a4ff3d08e926aeea4a2b"} 10:18:58 INFO - Running post-run listener: copy_logs_to_upload_dir 10:18:58 INFO - Copying logs to upload dir... 10:18:58 INFO - mkdir: /builds/slave/test/build/upload/logs 10:18:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.243987 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-08 10:18:58.011727) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 10:18:58.015052) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/51dd63727375d481158a38b4fabe145825f59965285b27e2fad50b470f9de03747fbd8952c59526f593cb035f28aeca9c1515bdb6157c6cdfbeb675575182813", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/230dfabdc19ca63a5f4e3b3358be7f2d4a25489b18cb8f5e879284012462af31569f11cd43e1cdfbb09c83b1017844414f767ab10a5699f486b5fc454afdcb24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e43bd82cfb288fa4e73f5b45fa430543097f5ba2a977ebf9b08c69a09f0f5a106d46655744f09046fd78f38101f5a958c9529fd30de5a4ff3d08e926aeea4a2b"} 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.011405 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/51dd63727375d481158a38b4fabe145825f59965285b27e2fad50b470f9de03747fbd8952c59526f593cb035f28aeca9c1515bdb6157c6cdfbeb675575182813", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/230dfabdc19ca63a5f4e3b3358be7f2d4a25489b18cb8f5e879284012462af31569f11cd43e1cdfbb09c83b1017844414f767ab10a5699f486b5fc454afdcb24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e43bd82cfb288fa4e73f5b45fa430543097f5ba2a977ebf9b08c69a09f0f5a106d46655744f09046fd78f38101f5a958c9529fd30de5a4ff3d08e926aeea4a2b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 10:18:58.045264) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 10:18:58.045639) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465405102.170727-532010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 10:18:58.132817) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 10:18:58.133746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 10:18:58.134373) ========= ========= Total master_lag: 0.19 =========