builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1464077172.1 results: success (0) buildid: 20160523223126 builduid: 8c5b4a72d305404cab364d3aa16dff3a revision: feb13c8b708aade4acf07e520682c2a9f9328544 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 01:06:12.102715) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 01:06:12.103226) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 01:06:12.103555) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 01:06:12.131904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:06:12.132242) ========= 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=a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 01:06:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.2M=0s 2016-05-24 01:06:12 (50.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074364 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:06:12.220172) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:06:12.220472) ========= 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=a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016923 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:06:12.272960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:06:12.273309) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev feb13c8b708aade4acf07e520682c2a9f9328544 --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 feb13c8b708aade4acf07e520682c2a9f9328544 --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=a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 01:06:12,364 truncating revision to first 12 chars 2016-05-24 01:06:12,364 Setting DEBUG logging. 2016-05-24 01:06:12,364 attempt 1/10 2016-05-24 01:06:12,364 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/feb13c8b708a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 01:06:12,628 unpacking tar archive at: mozilla-inbound-feb13c8b708a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559193 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:06:12.850128) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 01:06:12.850558) ========= script_repo_revision: feb13c8b708aade4acf07e520682c2a9f9328544 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 01:06:12.851136) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 01:06:12.851515) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 01:06:12.861479) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-24 01:06:12.862035) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:06:13 INFO - MultiFileLogger online at 20160524 01:06:13 in /builds/slave/test 01:06:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:06:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:06:13 INFO - {'append_to_log': False, 01:06:13 INFO - 'base_work_dir': '/builds/slave/test', 01:06:13 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:06:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:06:13 INFO - 'branch': 'Mozilla-Inbound', 01:06:13 INFO - 'buildbot_json_path': 'buildprops.json', 01:06:13 INFO - 'config_files': ('talos/linux_config.py',), 01:06:13 INFO - 'default_actions': ('clobber', 01:06:13 INFO - 'read-buildbot-config', 01:06:13 INFO - 'download-and-extract', 01:06:13 INFO - 'populate-webroot', 01:06:13 INFO - 'create-virtualenv', 01:06:13 INFO - 'install', 01:06:13 INFO - 'run-tests'), 01:06:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:06:13 INFO - 'download_minidump_stackwalk': True, 01:06:13 INFO - 'download_symbols': 'ondemand', 01:06:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:06:13 INFO - 'tooltool.py': '/tools/tooltool.py', 01:06:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:06:13 INFO - '/tools/misc-python/virtualenv.py')}, 01:06:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:06:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:06:13 INFO - 'installer_path': 'installer.exe', 01:06:13 INFO - 'log_level': 'info', 01:06:13 INFO - 'log_name': 'talos', 01:06:13 INFO - 'log_to_console': True, 01:06:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:06:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:06:13 INFO - 'opt_config_files': (), 01:06:13 INFO - 'pip_index': False, 01:06:13 INFO - 'sps_profile': False, 01:06:13 INFO - 'sps_profile_interval': 0, 01:06:13 INFO - 'suite': 'dromaeojs-e10s', 01:06:13 INFO - 'system_bits': '32', 01:06:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:06:13 INFO - 'title': 'talos-linux64-ix-002', 01:06:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:06:13 INFO - 'use_talos_json': True, 01:06:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:06:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:06:13 INFO - 'work_dir': 'build'} 01:06:13 INFO - ##### 01:06:13 INFO - ##### Running clobber step. 01:06:13 INFO - ##### 01:06:13 INFO - Running pre-action listener: _resource_record_pre_action 01:06:13 INFO - Running main action method: clobber 01:06:13 INFO - rmtree: /builds/slave/test/build 01:06:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:06:14 INFO - Running post-action listener: _resource_record_post_action 01:06:14 INFO - ##### 01:06:14 INFO - ##### Finished clobber step (success) 01:06:14 INFO - ##### 01:06:14 INFO - ##### 01:06:14 INFO - ##### Running read-buildbot-config step. 01:06:14 INFO - ##### 01:06:14 INFO - Running pre-action listener: _resource_record_pre_action 01:06:14 INFO - Running main action method: read_buildbot_config 01:06:14 INFO - Using buildbot properties: 01:06:14 INFO - { 01:06:14 INFO - "project": "", 01:06:14 INFO - "product": "firefox", 01:06:14 INFO - "script_repo_revision": "production", 01:06:14 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 01:06:14 INFO - "repository": "", 01:06:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 01:06:14 INFO - "buildid": "20160523223126", 01:06:14 INFO - "pgo_build": "True", 01:06:14 INFO - "basedir": "/builds/slave/test", 01:06:14 INFO - "buildnumber": 1063, 01:06:14 INFO - "slavename": "talos-linux64-ix-002", 01:06:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:06:14 INFO - "platform": "ubuntu64_hw", 01:06:14 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:06:14 INFO - "branch": "mozilla-inbound", 01:06:14 INFO - "repo_path": "integration/mozilla-inbound", 01:06:14 INFO - "revision": "feb13c8b708aade4acf07e520682c2a9f9328544", 01:06:14 INFO - "stage_platform": "linux64-pgo", 01:06:14 INFO - "builduid": "8c5b4a72d305404cab364d3aa16dff3a", 01:06:14 INFO - "slavebuilddir": "test" 01:06:14 INFO - } 01:06:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:06:14 INFO - Running post-action listener: _resource_record_post_action 01:06:14 INFO - ##### 01:06:14 INFO - ##### Finished read-buildbot-config step (success) 01:06:14 INFO - ##### 01:06:14 INFO - ##### 01:06:14 INFO - ##### Running download-and-extract step. 01:06:14 INFO - ##### 01:06:14 INFO - Running pre-action listener: _resource_record_pre_action 01:06:14 INFO - Running main action method: download_and_extract 01:06:14 INFO - mkdir: /builds/slave/test/build/tests 01:06:14 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')]} 01:06:14 INFO - https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:06:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:06:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:06:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:06:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:06:17 INFO - Downloaded 1361 bytes. 01:06:17 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:06:17 INFO - Using the following test package requirements: 01:06:17 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:06:17 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:06:17 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:06:17 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:17 INFO - u'jsshell-linux-x86_64.zip'], 01:06:17 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:06:17 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:06:17 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:06:17 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:06:17 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:06:17 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:06:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:06:17 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:06:17 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')]} 01:06:17 INFO - https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:06:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:06:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:06:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:06:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:06:34 INFO - Downloaded 24417402 bytes. 01:06:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:06:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:06:36 INFO - Return code: 0 01:06:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:36 INFO - https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:06:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:06:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:06:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:06:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:06:37 INFO - Downloaded 24417402 bytes. 01:06:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:06:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:06:39 INFO - Return code: 0 01:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:39 INFO - https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:06:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:06:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:06:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:06:39 INFO - Downloaded 10840359 bytes. 01:06:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:06:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:06:40 INFO - Return code: 0 01:06: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')]} 01:06:40 INFO - https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:06:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:06:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:06:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:06:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:06:41 INFO - Downloaded 58602475 bytes. 01:06:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:06:41 INFO - mkdir: /builds/slave/test/properties 01:06:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:06:41 INFO - Writing to file /builds/slave/test/properties/build_url 01:06:41 INFO - Contents: 01:06:41 INFO - build_url:https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:06:42 INFO - Running post-action listener: _resource_record_post_action 01:06:42 INFO - Running post-action listener: set_extra_try_arguments 01:06:42 INFO - ##### 01:06:42 INFO - ##### Finished download-and-extract step (success) 01:06:42 INFO - ##### 01:06:42 INFO - ##### 01:06:42 INFO - ##### Running populate-webroot step. 01:06:42 INFO - ##### 01:06:42 INFO - Running pre-action listener: _resource_record_pre_action 01:06:42 INFO - Running main action method: populate_webroot 01:06:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:06:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:06:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:06:42 INFO - '--tppagecycles', 01:06:42 INFO - '7'], 01:06:42 INFO - 'tests': ['tsvgm']}}, 01:06:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:06:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:06:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:06:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:06:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:06:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:06:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:42 INFO - 'talos_options': ['--disable-e10s'], 01:06:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:06:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:06:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:42 INFO - 'talos_options': ['--disable-e10s'], 01:06:42 INFO - 'tests': ['damp', 'tps']}, 01:06:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:42 INFO - 'tests': ['damp', 'tps']}, 01:06:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:06:42 INFO - 'tests': ['dromaeo_dom']}, 01:06:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:06:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:06:42 INFO - 'tests': ['a11yr', 01:06:42 INFO - 'ts_paint', 01:06:42 INFO - 'tpaint', 01:06:42 INFO - 'sessionrestore', 01:06:42 INFO - 'sessionrestore_no_auto_restore', 01:06:42 INFO - 'tabpaint']}, 01:06:42 INFO - 'other-e10s': {'tests': ['a11yr', 01:06:42 INFO - 'ts_paint', 01:06:42 INFO - 'tpaint', 01:06:42 INFO - 'sessionrestore', 01:06:42 INFO - 'sessionrestore_no_auto_restore', 01:06:42 INFO - 'tabpaint']}, 01:06:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:06:42 INFO - 'ts_paint', 01:06:42 INFO - 'tpaint', 01:06:42 INFO - 'sessionrestore', 01:06:42 INFO - 'sessionrestore_no_auto_restore', 01:06:42 INFO - 'tabpaint']}, 01:06:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:06:42 INFO - 'ts_paint', 01:06:42 INFO - 'tpaint', 01:06:42 INFO - 'sessionrestore', 01:06:42 INFO - 'sessionrestore_no_auto_restore', 01:06:42 INFO - 'tabpaint']}, 01:06:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:06:42 INFO - 'tests': ['a11yr', 01:06:42 INFO - 'ts_paint', 01:06:42 INFO - 'tpaint', 01:06:42 INFO - 'sessionrestore', 01:06:42 INFO - 'sessionrestore_no_auto_restore', 01:06:42 INFO - 'tabpaint']}, 01:06:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:06:42 INFO - 'tests': ['a11yr', 01:06:42 INFO - 'ts_paint', 01:06:42 INFO - 'tpaint', 01:06:42 INFO - 'sessionrestore', 01:06:42 INFO - 'sessionrestore_no_auto_restore', 01:06:42 INFO - 'tabpaint']}, 01:06:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:06:42 INFO - 'tests': ['tsvgx', 01:06:42 INFO - 'tsvgr_opacity', 01:06:42 INFO - 'tart', 01:06:42 INFO - 'tscrollx', 01:06:42 INFO - 'cart']}, 01:06:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:06:42 INFO - 'tsvgr_opacity', 01:06:42 INFO - 'tart', 01:06:42 INFO - 'tscrollx', 01:06:42 INFO - 'cart']}, 01:06:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:42 INFO - 'talos_options': ['--disable-e10s'], 01:06:42 INFO - 'tests': ['tp5o']}, 01:06:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:42 INFO - 'tests': ['tp5o']}, 01:06:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:42 INFO - 'talos_options': ['--disable-e10s', 01:06:42 INFO - '--xperf_path', 01:06:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:06:42 INFO - 'tests': ['tp5n']}, 01:06:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:06:42 INFO - 'talos_options': ['--xperf_path', 01:06:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:06:42 INFO - 'tests': ['tp5n']}}, 01:06:42 INFO - 'talos.zip': {'path': '', 01:06:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:06:42 INFO - Running post-action listener: _resource_record_post_action 01:06:42 INFO - ##### 01:06:42 INFO - ##### Finished populate-webroot step (success) 01:06:42 INFO - ##### 01:06:42 INFO - ##### 01:06:42 INFO - ##### Running create-virtualenv step. 01:06:42 INFO - ##### 01:06:42 INFO - Running pre-action listener: _resource_record_pre_action 01:06:42 INFO - Running main action method: create_virtualenv 01:06:42 INFO - Creating virtualenv /builds/slave/test/build/venv 01:06:42 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 01:06:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:06:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:06:42 INFO - Using real prefix '/usr' 01:06:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:06:42 INFO - Installing distribute.............................................................................................................................................................................................done. 01:06:44 INFO - Installing pip.................done. 01:06:44 INFO - Return code: 0 01:06:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:06: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')]} 01:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06: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')]} 01:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5632267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25839c0>, '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 0x25848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2584d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', '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 01:06: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', 'pip>=1.5'] in /builds/slave/test/build 01:06: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 pip>=1.5 01:06:44 INFO - Using env: {'DISPLAY': ':0', 01:06:44 INFO - 'HOME': '/home/cltbld', 01:06:44 INFO - 'LANG': 'en_US.UTF-8', 01:06:44 INFO - 'LANGUAGE': 'en_US:en', 01:06:44 INFO - 'LOGNAME': 'cltbld', 01:06:44 INFO - 'MAIL': '/var/mail/cltbld', 01:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:44 INFO - 'MOZ_NO_REMOTE': '1', 01:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:44 INFO - 'NO_EM_RESTART': '1', 01:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:44 INFO - 'PWD': '/builds/slave/test', 01:06:44 INFO - 'SHELL': '/bin/bash', 01:06:44 INFO - 'SHLVL': '1', 01:06:44 INFO - 'TERM': 'linux', 01:06:44 INFO - 'TMOUT': '86400', 01:06:44 INFO - 'USER': 'cltbld', 01:06:44 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', 01:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:44 INFO - '_': '/tools/buildbot/bin/python'} 01:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:45 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 01:06:45 INFO - Cleaning up... 01:06:45 INFO - Return code: 0 01:06:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5632267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25839c0>, '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 0x25848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2584d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', '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 01:06:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:06:45 INFO - Using env: {'DISPLAY': ':0', 01:06:45 INFO - 'HOME': '/home/cltbld', 01:06:45 INFO - 'LANG': 'en_US.UTF-8', 01:06:45 INFO - 'LANGUAGE': 'en_US:en', 01:06:45 INFO - 'LOGNAME': 'cltbld', 01:06:45 INFO - 'MAIL': '/var/mail/cltbld', 01:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:45 INFO - 'MOZ_NO_REMOTE': '1', 01:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:45 INFO - 'NO_EM_RESTART': '1', 01:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:45 INFO - 'PWD': '/builds/slave/test', 01:06:45 INFO - 'SHELL': '/bin/bash', 01:06:45 INFO - 'SHLVL': '1', 01:06:45 INFO - 'TERM': 'linux', 01:06:45 INFO - 'TMOUT': '86400', 01:06:45 INFO - 'USER': 'cltbld', 01:06:45 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', 01:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:45 INFO - '_': '/tools/buildbot/bin/python'} 01:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:45 INFO - Downloading/unpacking psutil>=3.1.1 01:06: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 01:06: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 01:06: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 01:06: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 01:06: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 01:06: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 01:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:06:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:06:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:06:47 INFO - Installing collected packages: psutil 01:06:47 INFO - Running setup.py install for psutil 01:06:47 INFO - building 'psutil._psutil_linux' extension 01:06:47 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 01:06:47 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 01:06:47 INFO - building 'psutil._psutil_posix' extension 01:06:47 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 01:06:47 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 01:06:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:06:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:06:47 INFO - Successfully installed psutil 01:06:47 INFO - Cleaning up... 01:06:47 INFO - Return code: 0 01:06:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:47 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 0x7f5632267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25839c0>, '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 0x25848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2584d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', '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 01:06:47 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 01:06:47 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 01:06:47 INFO - Using env: {'DISPLAY': ':0', 01:06:47 INFO - 'HOME': '/home/cltbld', 01:06:47 INFO - 'LANG': 'en_US.UTF-8', 01:06:47 INFO - 'LANGUAGE': 'en_US:en', 01:06:47 INFO - 'LOGNAME': 'cltbld', 01:06:47 INFO - 'MAIL': '/var/mail/cltbld', 01:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:47 INFO - 'MOZ_NO_REMOTE': '1', 01:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:47 INFO - 'NO_EM_RESTART': '1', 01:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:47 INFO - 'PWD': '/builds/slave/test', 01:06:47 INFO - 'SHELL': '/bin/bash', 01:06:47 INFO - 'SHLVL': '1', 01:06:47 INFO - 'TERM': 'linux', 01:06:47 INFO - 'TMOUT': '86400', 01:06:47 INFO - 'USER': 'cltbld', 01:06:47 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', 01:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:47 INFO - '_': '/tools/buildbot/bin/python'} 01:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:06:49 INFO - Installing collected packages: mozsystemmonitor 01:06:49 INFO - Running setup.py install for mozsystemmonitor 01:06:50 INFO - Successfully installed mozsystemmonitor 01:06:50 INFO - Cleaning up... 01:06:50 INFO - Return code: 0 01:06:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:06:50 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')]} 01:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:50 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')]} 01:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:50 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 0x7f5632267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25839c0>, '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 0x25848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2584d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', '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 01:06:50 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 01:06:50 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 01:06:50 INFO - Using env: {'DISPLAY': ':0', 01:06:50 INFO - 'HOME': '/home/cltbld', 01:06:50 INFO - 'LANG': 'en_US.UTF-8', 01:06:50 INFO - 'LANGUAGE': 'en_US:en', 01:06:50 INFO - 'LOGNAME': 'cltbld', 01:06:50 INFO - 'MAIL': '/var/mail/cltbld', 01:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:50 INFO - 'MOZ_NO_REMOTE': '1', 01:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:50 INFO - 'NO_EM_RESTART': '1', 01:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:50 INFO - 'PWD': '/builds/slave/test', 01:06:50 INFO - 'SHELL': '/bin/bash', 01:06:50 INFO - 'SHLVL': '1', 01:06:50 INFO - 'TERM': 'linux', 01:06:50 INFO - 'TMOUT': '86400', 01:06:50 INFO - 'USER': 'cltbld', 01:06:50 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', 01:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:50 INFO - '_': '/tools/buildbot/bin/python'} 01:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:50 INFO - Downloading/unpacking blobuploader==1.2.4 01:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:52 INFO - Downloading blobuploader-1.2.4.tar.gz 01:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:06:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:06:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:06:52 INFO - Downloading docopt-0.6.1.tar.gz 01:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:06:53 INFO - Installing collected packages: blobuploader, requests, docopt 01:06:53 INFO - Running setup.py install for blobuploader 01:06:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:06:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:06:53 INFO - Running setup.py install for requests 01:06:53 INFO - Running setup.py install for docopt 01:06:53 INFO - Successfully installed blobuploader requests docopt 01:06:53 INFO - Cleaning up... 01:06:53 INFO - Return code: 0 01:06:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:53 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 0x7f5632267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25839c0>, '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 0x25848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2584d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', '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 01:06:53 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 01:06:53 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 01:06:53 INFO - Using env: {'DISPLAY': ':0', 01:06:53 INFO - 'HOME': '/home/cltbld', 01:06:53 INFO - 'LANG': 'en_US.UTF-8', 01:06:53 INFO - 'LANGUAGE': 'en_US:en', 01:06:53 INFO - 'LOGNAME': 'cltbld', 01:06:53 INFO - 'MAIL': '/var/mail/cltbld', 01:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:53 INFO - 'MOZ_NO_REMOTE': '1', 01:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:53 INFO - 'NO_EM_RESTART': '1', 01:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:53 INFO - 'PWD': '/builds/slave/test', 01:06:53 INFO - 'SHELL': '/bin/bash', 01:06:53 INFO - 'SHLVL': '1', 01:06:53 INFO - 'TERM': 'linux', 01:06:53 INFO - 'TMOUT': '86400', 01:06:53 INFO - 'USER': 'cltbld', 01:06:53 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', 01:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:53 INFO - '_': '/tools/buildbot/bin/python'} 01:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:06:53 INFO - Running setup.py (path:/tmp/pip-sts5jP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:06:53 INFO - Running setup.py (path:/tmp/pip-5MhxLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:06:53 INFO - Running setup.py (path:/tmp/pip-lyn8mC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:06:54 INFO - Running setup.py (path:/tmp/pip-xeR4hG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:06:54 INFO - Running setup.py (path:/tmp/pip-dA3TuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:06:54 INFO - Running setup.py (path:/tmp/pip-zGE5q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:06:54 INFO - Running setup.py (path:/tmp/pip-7DHp96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:06:54 INFO - Running setup.py (path:/tmp/pip-qCYn0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:06:54 INFO - Running setup.py (path:/tmp/pip-HiEXOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:06:54 INFO - Running setup.py (path:/tmp/pip-ie0J30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:06:54 INFO - Running setup.py (path:/tmp/pip-Nou1ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:06:54 INFO - Running setup.py (path:/tmp/pip-l8y7sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:06:54 INFO - Running setup.py (path:/tmp/pip-3BJNuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:06:54 INFO - Running setup.py (path:/tmp/pip-pTUgYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:54 INFO - Running setup.py (path:/tmp/pip-GHAgX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:06:54 INFO - Running setup.py (path:/tmp/pip-SQy9Wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:06:54 INFO - Running setup.py (path:/tmp/pip-p5EKTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:06:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:06:55 INFO - Running setup.py install for manifestparser 01:06:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:06:55 INFO - Running setup.py install for mozcrash 01:06:55 INFO - Running setup.py install for mozdebug 01:06:55 INFO - Running setup.py install for mozdevice 01:06:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:06:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:06:55 INFO - Running setup.py install for mozfile 01:06:55 INFO - Running setup.py install for mozhttpd 01:06:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:06:55 INFO - Running setup.py install for mozinfo 01:06:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:06:55 INFO - Running setup.py install for mozInstall 01:06:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:06:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:06:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:06:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:06:55 INFO - Running setup.py install for mozleak 01:06:55 INFO - Running setup.py install for mozlog 01:06:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:06:56 INFO - Running setup.py install for moznetwork 01:06:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:06:56 INFO - Running setup.py install for mozprocess 01:06:56 INFO - Running setup.py install for mozprofile 01:06:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:06:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:06:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:06:56 INFO - Running setup.py install for mozrunner 01:06:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:06:56 INFO - Running setup.py install for mozscreenshot 01:06:56 INFO - Running setup.py install for moztest 01:06:56 INFO - Running setup.py install for mozversion 01:06:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:06:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:06:56 INFO - Cleaning up... 01:06:56 INFO - Return code: 0 01:06:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:06:56 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 0x7f5632267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25839c0>, '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 0x25848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2584d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', '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 01:06:56 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 01:06:56 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 01:06:56 INFO - Using env: {'DISPLAY': ':0', 01:06:56 INFO - 'HOME': '/home/cltbld', 01:06:56 INFO - 'LANG': 'en_US.UTF-8', 01:06:56 INFO - 'LANGUAGE': 'en_US:en', 01:06:56 INFO - 'LOGNAME': 'cltbld', 01:06:56 INFO - 'MAIL': '/var/mail/cltbld', 01:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:06:56 INFO - 'MOZ_NO_REMOTE': '1', 01:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:06:56 INFO - 'NO_EM_RESTART': '1', 01:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:06:56 INFO - 'PWD': '/builds/slave/test', 01:06:56 INFO - 'SHELL': '/bin/bash', 01:06:56 INFO - 'SHLVL': '1', 01:06:56 INFO - 'TERM': 'linux', 01:06:56 INFO - 'TMOUT': '86400', 01:06:56 INFO - 'USER': 'cltbld', 01:06:56 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', 01:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:06:56 INFO - '_': '/tools/buildbot/bin/python'} 01:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:06:57 INFO - Running setup.py (path:/tmp/pip-LjgTa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:06:57 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)) 01:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:06:57 INFO - Running setup.py (path:/tmp/pip-NZhmdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:06:57 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)) 01:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:06:57 INFO - Running setup.py (path:/tmp/pip-xHmImd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:06:57 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)) 01:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:06:57 INFO - Running setup.py (path:/tmp/pip-SpPlAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:06:57 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)) 01:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:06:57 INFO - Running setup.py (path:/tmp/pip-3C4k5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:06:57 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)) 01:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:06:57 INFO - Running setup.py (path:/tmp/pip-kZYc1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:06:57 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)) 01:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:06:57 INFO - Running setup.py (path:/tmp/pip-q6Jz7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:06:57 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)) 01:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:06:57 INFO - Running setup.py (path:/tmp/pip-MXzh8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:06:57 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)) 01:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:06:57 INFO - Running setup.py (path:/tmp/pip-TqdGen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:06:57 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)) 01:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:06:57 INFO - Running setup.py (path:/tmp/pip-5vAhQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:06:57 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)) 01:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:06:57 INFO - Running setup.py (path:/tmp/pip-6v4jwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:06:57 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)) 01:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:06:57 INFO - Running setup.py (path:/tmp/pip-UAhSvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:06:57 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)) 01:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:06:57 INFO - Running setup.py (path:/tmp/pip-Kdrs93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:06:58 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)) 01:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:06:58 INFO - Running setup.py (path:/tmp/pip-mEgsoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:06:58 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)) 01:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:58 INFO - Running setup.py (path:/tmp/pip-knsf2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:06:58 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)) 01:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:06:58 INFO - Running setup.py (path:/tmp/pip-3id3mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:06:58 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)) 01:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:06:58 INFO - Running setup.py (path:/tmp/pip-75J0ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:06:58 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)) 01:06:58 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)) 01:06:58 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)) 01:06:58 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)) 01:06:58 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)) 01:06:58 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)) 01:06:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:06: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 01:06: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 01:06: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 01:06: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 01:06: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 01:06: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 01:07:00 INFO - Downloading blessings-1.6.tar.gz 01:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:07:00 INFO - Installing collected packages: blessings 01:07:00 INFO - Running setup.py install for blessings 01:07:00 INFO - Successfully installed blessings 01:07:00 INFO - Cleaning up... 01:07:00 INFO - Return code: 0 01:07:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:07:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:07:01 INFO - Reading from file tmpfile_stdout 01:07:01 INFO - Current package versions: 01:07:01 INFO - argparse == 1.2.1 01:07:01 INFO - blessings == 1.6 01:07:01 INFO - blobuploader == 1.2.4 01:07:01 INFO - docopt == 0.6.1 01:07:01 INFO - manifestparser == 1.1 01:07:01 INFO - mozInstall == 1.12 01:07:01 INFO - mozcrash == 0.17 01:07:01 INFO - mozdebug == 0.1 01:07:01 INFO - mozdevice == 0.48 01:07:01 INFO - mozfile == 1.2 01:07:01 INFO - mozhttpd == 0.7 01:07:01 INFO - mozinfo == 0.9 01:07:01 INFO - mozleak == 0.1 01:07:01 INFO - mozlog == 3.2 01:07:01 INFO - moznetwork == 0.27 01:07:01 INFO - mozprocess == 0.22 01:07:01 INFO - mozprofile == 0.28 01:07:01 INFO - mozrunner == 6.11 01:07:01 INFO - mozscreenshot == 0.1 01:07:01 INFO - mozsystemmonitor == 0.3 01:07:01 INFO - moztest == 0.7 01:07:01 INFO - mozversion == 1.4 01:07:01 INFO - psutil == 3.1.1 01:07:01 INFO - requests == 1.2.3 01:07:01 INFO - wsgiref == 0.1.2 01:07:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:01 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 0x7f5632267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25839c0>, '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 0x25848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2584d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', '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 01:07:01 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 01:07:01 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 01:07:01 INFO - Using env: {'DISPLAY': ':0', 01:07:01 INFO - 'HOME': '/home/cltbld', 01:07:01 INFO - 'LANG': 'en_US.UTF-8', 01:07:01 INFO - 'LANGUAGE': 'en_US:en', 01:07:01 INFO - 'LOGNAME': 'cltbld', 01:07:01 INFO - 'MAIL': '/var/mail/cltbld', 01:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:01 INFO - 'MOZ_NO_REMOTE': '1', 01:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:01 INFO - 'NO_EM_RESTART': '1', 01:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:01 INFO - 'PWD': '/builds/slave/test', 01:07:01 INFO - 'SHELL': '/bin/bash', 01:07:01 INFO - 'SHLVL': '1', 01:07:01 INFO - 'TERM': 'linux', 01:07:01 INFO - 'TMOUT': '86400', 01:07:01 INFO - 'USER': 'cltbld', 01:07:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', 01:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:01 INFO - '_': '/tools/buildbot/bin/python'} 01:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:01 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)) 01:07:01 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)) 01:07:01 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)) 01:07:01 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)) 01:07:01 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)) 01:07:01 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)) 01:07:01 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)) 01:07:01 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)) 01:07:01 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)) 01:07:01 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)) 01:07:01 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)) 01:07:01 INFO - Cleaning up... 01:07:01 INFO - Return code: 0 01:07:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5632267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25839c0>, '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 0x25848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2584d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', '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 01:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:07:01 INFO - Using env: {'DISPLAY': ':0', 01:07:01 INFO - 'HOME': '/home/cltbld', 01:07:01 INFO - 'LANG': 'en_US.UTF-8', 01:07:01 INFO - 'LANGUAGE': 'en_US:en', 01:07:01 INFO - 'LOGNAME': 'cltbld', 01:07:01 INFO - 'MAIL': '/var/mail/cltbld', 01:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:01 INFO - 'MOZ_NO_REMOTE': '1', 01:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:01 INFO - 'NO_EM_RESTART': '1', 01:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:01 INFO - 'PWD': '/builds/slave/test', 01:07:01 INFO - 'SHELL': '/bin/bash', 01:07:01 INFO - 'SHLVL': '1', 01:07:01 INFO - 'TERM': 'linux', 01:07:01 INFO - 'TMOUT': '86400', 01:07:01 INFO - 'USER': 'cltbld', 01:07:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', 01:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:01 INFO - '_': '/tools/buildbot/bin/python'} 01:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:01 INFO - Downloading/unpacking jsonschema 01:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:07:03 INFO - Downloading/unpacking functools32 (from jsonschema) 01:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:03 INFO - Downloading functools32-3.2.3-2.tar.gz 01:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:07:03 INFO - warning: no files found matching '*.txt' 01:07:03 INFO - no previously-included directories found matching 'build' 01:07:03 INFO - no previously-included directories found matching 'dist' 01:07:03 INFO - no previously-included directories found matching '.git*' 01:07:03 INFO - Installing collected packages: jsonschema, functools32 01:07:03 INFO - Running setup.py install for functools32 01:07:03 INFO - warning: no files found matching '*.txt' 01:07:03 INFO - no previously-included directories found matching 'build' 01:07:03 INFO - no previously-included directories found matching 'dist' 01:07:03 INFO - no previously-included directories found matching '.git*' 01:07:03 INFO - Successfully installed jsonschema functools32 01:07:03 INFO - Cleaning up... 01:07:03 INFO - Return code: 0 01:07:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:07:03 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 0x7f5632267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25839c0>, '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 0x25848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2584d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', '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 01:07:03 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 01:07:03 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 01:07:03 INFO - Using env: {'DISPLAY': ':0', 01:07:03 INFO - 'HOME': '/home/cltbld', 01:07:03 INFO - 'LANG': 'en_US.UTF-8', 01:07:03 INFO - 'LANGUAGE': 'en_US:en', 01:07:03 INFO - 'LOGNAME': 'cltbld', 01:07:03 INFO - 'MAIL': '/var/mail/cltbld', 01:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:03 INFO - 'MOZ_NO_REMOTE': '1', 01:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:03 INFO - 'NO_EM_RESTART': '1', 01:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:03 INFO - 'PWD': '/builds/slave/test', 01:07:03 INFO - 'SHELL': '/bin/bash', 01:07:03 INFO - 'SHLVL': '1', 01:07:03 INFO - 'TERM': 'linux', 01:07:03 INFO - 'TMOUT': '86400', 01:07:03 INFO - 'USER': 'cltbld', 01:07:03 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', 01:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:03 INFO - '_': '/tools/buildbot/bin/python'} 01:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:07:04 INFO - Downloading/unpacking flake8 01:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:07:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:07:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:07:06 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 01:07:06 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 01:07:06 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 01:07:06 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 01:07:06 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 01:07:06 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 01:07:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:07:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:07:06 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 01:07:06 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 01:07:06 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 01:07:06 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 01:07:06 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 01:07:06 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 01:07:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:07:06 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 01:07:06 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 01:07:06 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 01:07:06 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 01:07:06 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 01:07:06 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 01:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:07:06 INFO - no previously-included directories found matching 'docs/_build' 01:07:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:07:06 INFO - Running setup.py install for pep8 01:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:07:06 INFO - no previously-included directories found matching 'docs/_build' 01:07:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:07:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:07:06 INFO - Cleaning up... 01:07:07 INFO - Return code: 0 01:07:07 INFO - Running post-action listener: _resource_record_post_action 01:07:07 INFO - Running post-action listener: _start_resource_monitoring 01:07:07 INFO - Starting resource monitoring. 01:07:07 INFO - ##### 01:07:07 INFO - ##### Finished create-virtualenv step (success) 01:07:07 INFO - ##### 01:07:07 INFO - ##### 01:07:07 INFO - ##### Running install step. 01:07:07 INFO - ##### 01:07:07 INFO - Running pre-action listener: _resource_record_pre_action 01:07:07 INFO - Running main action method: install 01:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:07:07 INFO - Reading from file tmpfile_stdout 01:07:07 INFO - Detecting whether we're running mozinstall >=1.0... 01:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:07:07 INFO - Reading from file tmpfile_stdout 01:07:07 INFO - Output received: 01:07:07 INFO - Usage: mozinstall [options] installer 01:07:07 INFO - Options: 01:07:07 INFO - -h, --help show this help message and exit 01:07:07 INFO - -d DEST, --destination=DEST 01:07:07 INFO - Directory to install application into. [default: 01:07:07 INFO - "/builds/slave/test"] 01:07:07 INFO - --app=APP Application being installed. [default: firefox] 01:07:07 INFO - mkdir: /builds/slave/test/build/application 01:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:07:23 INFO - Reading from file tmpfile_stdout 01:07:23 INFO - Output received: 01:07:23 INFO - /builds/slave/test/build/application/firefox/firefox 01:07:23 INFO - Running post-action listener: _resource_record_post_action 01:07:23 INFO - ##### 01:07:23 INFO - ##### Finished install step (success) 01:07:23 INFO - ##### 01:07:23 INFO - ##### 01:07:23 INFO - ##### Running run-tests step. 01:07:23 INFO - ##### 01:07:23 INFO - Running pre-action listener: _resource_record_pre_action 01:07:23 INFO - Running main action method: run_tests 01:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:07:23 INFO - Python 2.7.3 01:07:23 INFO - Return code: 0 01:07:23 INFO - grabbing minidump binary from tooltool 01:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:23 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 0x25839c0>, '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 0x25848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2584d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:07:23 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 01:07:23 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 01:07:23 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 01:07:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:07:24 INFO - Return code: 0 01:07:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:07:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:07:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:07:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:07:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:07:24 INFO - Return code: 0 01:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:07:24 INFO - Using env: {'DISPLAY': ':0', 01:07:24 INFO - 'HOME': '/home/cltbld', 01:07:24 INFO - 'LANG': 'en_US.UTF-8', 01:07:24 INFO - 'LANGUAGE': 'en_US:en', 01:07:24 INFO - 'LOGNAME': 'cltbld', 01:07:24 INFO - 'MAIL': '/var/mail/cltbld', 01:07:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:07:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:07:24 INFO - 'MOZ_NO_REMOTE': '1', 01:07:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:07:24 INFO - 'NO_EM_RESTART': '1', 01:07:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:07:24 INFO - 'PWD': '/builds/slave/test', 01:07:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:07:24 INFO - 'SHELL': '/bin/bash', 01:07:24 INFO - 'SHLVL': '1', 01:07:24 INFO - 'TERM': 'linux', 01:07:24 INFO - 'TMOUT': '86400', 01:07:24 INFO - 'USER': 'cltbld', 01:07:24 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468', 01:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:07:24 INFO - '_': '/tools/buildbot/bin/python'} 01:07:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:07:25 INFO - mozversion application_buildid: 20160523223126 01:07:25 INFO - mozversion application_changeset: feb13c8b708aade4acf07e520682c2a9f9328544 01:07:25 INFO - mozversion application_display_name: Nightly 01:07:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:07:25 INFO - mozversion application_name: Firefox 01:07:25 INFO - mozversion application_remotingname: firefox 01:07:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:07:25 INFO - mozversion application_vendor: Mozilla 01:07:25 INFO - mozversion application_version: 49.0a1 01:07:25 INFO - mozversion platform_buildid: 20160523223126 01:07:25 INFO - mozversion platform_changeset: feb13c8b708aade4acf07e520682c2a9f9328544 01:07:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:07:25 INFO - mozversion platform_version: 49.0a1 01:07:25 INFO - using testdate: 1464077245 01:07:25 INFO - actual date: 1464077245 01:07:25 INFO - starting webserver on 'localhost:50123' 01:07:25 INFO - SUITE-START | Running 2 tests 01:07:25 INFO - TEST-START | dromaeo_css 01:07:25 INFO - operating with platform_type : linux_ 01:07:25 INFO - Initialising browser for dromaeo_css test... 01:07:25 INFO - TEST-INFO | started process 26122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOS2PeL/profile http://localhost:50123/getInfo.html) 01:07:28 INFO - PROCESS | 26122 | 01:07:28 INFO - PROCESS | 26122 | (process:26189): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:07:29 INFO - PROCESS | 26122 | __metrics Screen width/height:1600/1200 01:07:29 INFO - PROCESS | 26122 | colorDepth:24 01:07:29 INFO - PROCESS | 26122 | Browser inner width/height: 1024/697 01:07:29 INFO - PROCESS | 26122 | __metrics 01:07:30 ERROR - PROCESS | 26122 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 01:07:31 INFO - TEST-INFO | 26122: exit 0 01:07:31 INFO - Browser initialized. 01:07:31 INFO - Running cycle 1/1 for dromaeo_css test... 01:07:31 INFO - TEST-INFO | started process 26240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOS2PeL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:07:32 INFO - PROCESS | 26240 | 01:07:32 INFO - PROCESS | 26240 | (process:26300): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:07:42 INFO - PROCESS | 26240 | RSS: Main: 163852288 01:07:42 INFO - PROCESS | 26240 | 01:08:32 INFO - PROCESS | 26240 | 1464077312557 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] 01:10:40 INFO - PROCESS | 26240 | Cycle 1(1): loaded http://localhost:50123/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50123/tests/dromaeo/cssquery-ext.html) 01:10:41 INFO - PROCESS | 26240 | RSS: Main: 168198144 01:10:41 INFO - PROCESS | 26240 | 01:13:42 INFO - PROCESS | 26240 | Cycle 1(1): loaded http://localhost:50123/tests/dromaeo/cssquery-ext.html (next: http://localhost:50123/tests/dromaeo/cssquery-jquery.html) 01:13:43 INFO - PROCESS | 26240 | RSS: Main: 167669760 01:13:43 INFO - PROCESS | 26240 | 01:16:45 INFO - PROCESS | 26240 | Cycle 1(1): loaded http://localhost:50123/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50123/tests/dromaeo/cssquery-mootools.html) 01:16:46 INFO - PROCESS | 26240 | RSS: Main: 168484864 01:16:46 INFO - PROCESS | 26240 | 01:19:47 INFO - PROCESS | 26240 | Cycle 1(1): loaded http://localhost:50123/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50123/tests/dromaeo/cssquery-prototype.html) 01:19:48 INFO - PROCESS | 26240 | RSS: Main: 166273024 01:19:48 INFO - PROCESS | 26240 | 01:22:50 INFO - PROCESS | 26240 | Cycle 1(1): loaded http://localhost:50123/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50123/tests/dromaeo/cssquery-yui.html) 01:22:51 INFO - PROCESS | 26240 | RSS: Main: 167284736 01:22:51 INFO - PROCESS | 26240 | 01:25:54 INFO - PROCESS | 26240 | Cycle 1(1): loaded http://localhost:50123/tests/dromaeo/cssquery-yui.html (next: http://localhost:50123/tests/dromaeo/cssquery-dojo.html) 01:25:54 INFO - PROCESS | 26240 | RSS: Main: 169353216 01:25:54 INFO - PROCESS | 26240 | 01:25:54 INFO - PROCESS | 26240 | __start_tp_report 01:25:54 INFO - PROCESS | 26240 | _x_x_mozilla_page_load 01:25:54 INFO - PROCESS | 26240 | _x_x_mozilla_page_load_details 01:25:54 INFO - PROCESS | 26240 | |i|pagename|runs| 01:25:54 INFO - PROCESS | 26240 | |0;dojo.html;3152.4483215437294;3176.8570414331352;3184.72929800967;3186.537951996962;3222.4682927316994;5440.564754819615;5486.999999999995;5500.449955004503;5583.218349431073;5583.804566840161;5404.567634589233;5440.836774896759;5483.670979741219;5528.944710552903;5552.5280351170095;4981.775820088095;5017.122003649347;5129.743512824362;5156.381234251895;5217.243499692542;687.8485569473592;4999.7500124993785;5075.7715902784275;5098.694078355292;5163.1480805667015;4955.132851750929;4983.875403114933;5005.54950054495;5016.573591244749;5037.4710655381205;4894.706317620954;4984.601231901475;4987.62592805541;5013.097642424362;5054.9241761373605;4980.402351717781;5001.24981252815;5017.774200161001;5030.798768049273;5035.571976381975;5418.349798024223;5482.068048431776;5518.19986102017;5529.529989950859;5579.748911298961;5839.328477225131;5863.355030946593;5997.370276120988;6013.278406591194;6026.96986515069;5881.47066763989;5908.172855800191;5930.614510056833;5946.554008449383;6006.549508786815;5528.281323427969;5531.197976293455;5535.39110697827;5535.806246781383;5548.4174161712845;5893.057110862242;6045.093236014633;6083.148359229712;6120.908186377208;6126.877462450726;5929.644221346733;5930.051191809376;5937.168796368512;5946.197263369476;5948.494377977834;6027.276726792726;6030.33666296707;6036.728347224385;6055.697215139226;6061.454469097803;5680.68756218412;5756.251687280626;5765.596408251382;5805.187273781674;5840.8247752567495;5734.225879506297;5826.184334193216;5829.446202610745;5844.795432159854;5892.322382925932;4353.82584696615;4385.122975404932;4387.934180987288;4390.517043125254;4426.535213802569;3828.73198876076;3878.4764056851964;3914.080191155076;3929.528456585228;3964.0486283291802;5639.379668236491;5643.943560564342;5652.3217213934595;5665.093585026459;5677.858053548612;5956.404359564009;6051.0923361496125;6073.210482637229;6073.39266073398;6074.726637301332;5312.415634280226;5535.197396377584;5606.6916319602;5609.523190528769;5628.831135065954;4949.727764972889;4985.626078044161;4985.925211121836;5027.095122877917;5027.924581131286;5899.085641725539;6211.751529938842;6236.34518375564;6248.843778905563;6272.937270627235;5864.560157988168;5870.677112758839;5890.7349169288345;5931.199288096224;5942.58401911862;6035.36628653985;6057.21256236704;6076.088586712029;6097.115918191748;6120.8775824484155;5639.436056394492;5835.095560188178;5847.853803654943;5867.031939729897;5888.205092312483;6017.458428741435;6073.423024812636;6079.696015199134;6094.199305899851;6122.6938653068055;5807.0998995155815;5849.181114644039;5859.179714839841;5859.2090067842;5890.9116363253725;5599.748011339418;5661.575381846295;5668.659880407189;5856.033754430471;5865.853353666193;5469.644473109235;5703.828885133453;5727.36998930109;5732.168835518743;5749.396313387034;5923.940760592339;5930;5945.494632956247;5965.373635768182;5965.940340596539;5538.944610553843;5688.630239034615;5711.600187986967;5810.564207684525;5826.038703613856 01:25:54 INFO - PROCESS | 26240 | |1;ext.html;597.3638075449646;610.0513701194641;627.1095045036049;628.4281304013349;641.3105911145518;42584.78707606462;43612.345814812805;43646.56353436465;43746.56253437464;47750.044999100086;44991.10017799642;45610.543894561044;45671.0865782685;45674.31488527675;45686.314705279445;8808.471491710501;9001.684941027066;9002.549872506348;9004.774880628003;9024.368294219406;8868.33487488441;8992.955035224815;9000.504972226525;9003.414778039407;9016.68441604544;8957.910420895772;9016.41393309436;9025.729228123135;9028.052054534277;9030.367874248805;8847.601857916408;8868.778280542974;8904.332175086862;8920.643174273022;8959.28325733943;8856;8923.955380223122;8969.820603587958;8973.910260897374;8995.415298005608;41561.792191038854;41867;41870;41935.370969435484;42126.36810447846;3474.4267195912644;3551.3607550640872;4012.277789997799;4164.208800327928;4198.538160802309;32127.83936080328;32352.838235808907;32847.178820529676;33048.33903321944;33117;4173.916521669549;4247.787610619456;4257.638100761439;4268.722533035374;4329.567043295645;355370.45462499553;355523;356040;358689;359742;57406.42593574095;58202.70898645564;58438.41561584415;58564.12153817696;58589.70705146447;59694.70152649296;60884;60956.695216523636;61020.38979610147;61243.38756612466;16215.432459863849;16358.672826543403;16503.587410314838;16574.419895303847;16606.169691515377;12237.75524489523;12371.876281237252;12380.876191237972;12473.625791226277;12503.937480312541;15494.30275637599;16503.09232992197;16570.502884913472;16636.50090497287;17030.914845425694;5846.269216347957;6042.879142417127;6084.5436592255755;6100.69496525172;6120.17377654011;1004.352192835617;1068.7435015596202;1074.3768614203743;1172.73613436976;1235.2773627428055;32842.50736238958;33984.32031359359;34062.31875362528;34221.48667769985;37232.25535489275;1191.6127258640977;1197.6646538969103;1214.40494157862;1240.231056744824;1241.714405686697;17007.659846802995;17491.47525574235;18105.63788724218;18359.54101147482;19178.90410547966;532411;534956;536924;537314.9402758962;538362;58544.70727646335;58973.11540326899;59189.704051479464;59460.70269648624;59842.70078649666;1386.230641993683;1395.4766962389103;1407.5355132806149;1427.8929080319017;1432.0047566940875;32343.838280808446;33870.153246169044;33976.66023339735;34170.31659366749;34176.14559636029;57046.42953570411;57308;57395.426045739005;57601.423985761285;57957.13064304123;476925;477221;477452;479412.426440818;481458;27816;28007.719922800512;28247.858760706065;28635.28411789722;28936;48835.755821220664;49371.75314123406;49977.75011124921;50080;50485;40998;42882;43404.13191736084;43542.346864797684;43703.12593748171;41448;41692.58307416887;42199.7890010548;42259.154816904105;42708.359374608786;41281;41515.37726934159;42102;42246.78876605597;42356.788216058725;36235;37329;37455.2508949814;37992.430113547765;38143.61856381401;28463.28841778972;28786.136415907557;28918.855405722836;29005.41989160163;29010.27474313159 01:25:54 INFO - PROCESS | 26240 | |2;jquery.html;382.6938449240608;390.81826950468025;397.6083557695671;399.6722687396335;399.9200159968007;14051.578452646438;17913.283468661255;18601;19188.0405979701;19194.520136996583;15506;17377.47867563975;18227.726584101216;18252.908735456305;18315.358962436316;5453.318335208109;5705.172749951254;5747.568932330071;5769.134629805541;5783.421657834225;5568.972155139219;5671.404502527237;5699.145128230757;5723.914141287884;5734.713264336788;5634.577406694494;5658.660480371171;5662.377138514781;5672.773089076432;5685.1756495308155;5556.833295001156;5596.160575913605;5635.464630860061;5660.886782264352;5708.885822283531;5053.267276244961;5076.466970968069;5095.8980820383385;5105.82129625465;5127.410347809975;21756.34730958074;21827.23604673829;22250.221242256604;22553.097876084936;22579.661305080437;2337.9298621041394;2404.2066118181133;2427.7450867658818;2525.368657835541;2702.148823120711;14265.714685706227;14296.356663950044;14468.131912085308;14655.560333190022;14861.628459288604;1907.9618407631908;1963.4698631369592;2013.1242909334487;2024.068928292987;2043.8467114966288;81826.59086704587;82686.58656706738;83899.58050209771;84212;84873.57563212144;9249.352545321897;9271.165595096474;9700.126988571063;10149.543270552844;10454.425006624557;14583.85416145825;14604.904632152631;14744.852551474349;14746;14772.852271477148;7162.556298486113;7477.887831682529;7699.384049276045;7769.650365733555;7902.565358905201;7781.45529812919;7861.292483676497;7904.881426778603;7978.162292959272;8058.717944871902;6400;6437;6489.643069631121;6638.634875081821;6664.36757480802;1861.1717785585286;1887.160213704888;1902.6384986852454;1927.9132439040277;1943.426689126711;1063.0546100635818;1076.6985244131656;1093.8906109388997;1103.2883789955595;1136.7385501334738;18515.72226416605;18844.15201315944;19292.903535482514;19553.706694399596;19628.3130090449;1016.9288149829441;1036.2797855490512;1064.387976913278;1101.4823033174396;1114.9777004459866;10748.193885458622;11222.494987725571;11347.37589432589;11350.09199264057;11373.260738052;478796;490679;490741;490953;491103;81607.591962041;83838;84149.57925210334;84909.57545212358;85099;987.2052997337213;996.5764550066193;1002.4035698759227;1011.185995273797;1020.3010937507831;15703.842961570695;17211.741823872402;17343.653126937643;17541.473755787345;17940.820591793916;28932.566011510266;31387.529187061755;42233.36649950192;42463.787681061396;43164.568354316056;54759.72620137033;56423.43576564346;56515;56749.71625141848;57705.422945770006;8570.48577085377;8588;8588.742337729627;8716.43343182691;9020.413673111227;12982.870171298166;12986.805197921849;13343.799843002169;13364.465421383426;13377;11151.052160566118;11477.426128693365;11831.940840295743;11994.76010479768;12310.138290319592;10835.349879007284;11161.218714690218;11472.31166130035;11673.182877198515;11931.642050738492;11329.71675708114;12145.514179432723;12393.132480726623;12459.190152640049;12556.811647825107;8445.831083378174;8580.184882436159;8599.355048371272;8742.025518341206;8788.121187881161;9043.593038313424;9763.560639771085;9964.202863770735;9969.252306077218;10458.424786636808 01:25:54 INFO - PROCESS | 26240 | |3;mootools.html;1469.2727100085456;1544.7991761071062;1666.5833541614597;1794.5423916901188;1807.8644101692375;7628.160902300742;8298.585070746454;8349.290310323622;8960.059193784657;8960.596773145217;8341.91658083419;8522.531260780655;8601.483910965331;8628.266597339234;8644.092370301121;2362.7755363240462;2400.7479214682467;2403.170906037414;2406.32622865597;2407.6388541718707;2331.6385960176117;2383.4518060846017;2397.652340410639;2408.5182963407387;2415;2382.809375249976;2385.3678775124604;2386.224477044959;2404.434957784928;2410.192585483865;2314.201600447843;2344.953100937989;2351.7883390494853;2365.597848365773;2373.086361750721;2366.408397900525;2378.3816207785926;2390.760923907613;2396.3769419950763;2398.292503711392;8574.22831945128;8575.785605359853;8579.571021448903;8590.699325523577;8655.221030107321;5285.207218917193;5362.544183744387;5373.946260537384;5398.757055932492;5400.594955378323;3293.275479394529;3355.446351352024;3409.1988382730037;3411.1301618087477;3411.8976430707116;1088.3361149698678;1096.8848270931517;1125.2348403085898;1130.728625129971;1134.8297755336682;12193.878061219362;12217.877821221851;12227.877721222763;12234.388280585936;12238.204516706475;4650.395448591661;4728.503507131771;4836.443808961944;4857.489963553776;4857.781399837016;10345;10407.843882341771;10444.947775261075;10445.425501597485;10454;5243.659162154448;5294.047071527085;5322.8935421292135;5446.373667028263;5454.7818087276855;4251.489821221473;4820.831270905502;4934.062528119646;4953.826616068421;4965.0069986002945;3868.3810590305416;3971.146203566247;3993.800309984489;3999.5000624921886;4121.381792731115;1241.490988694631;1267.828843106169;1284.948602055926;1292.101989117573;1299.857015728269;866.5493943149527;971.9319647624599;972.7859870828406;973.7516933181993;975;5751.511121554715;5900.970495147582;5974.193483879708;5981.730822113015;6077.392260773976;470.8352076773102;474.23647926837765;482.8599706085266;484.4186975629259;488.5236894028365;3858.7298889078056;3911.2177564487215;3962.306596345628;4185.162967406531;4196.139791342767;10356.741081472872;10541.104006159563;10843.349399036084;10861.565537378574;10927.125829933586;10627.309224900357;10680.839787403194;10768.784624307627;10782;10800.891991080145;7651.464397492234;7897.368210543143;7966.482178658369;7982.082060562993;8005.439619226599;5645.71771411436;5668.744906479136;5840.1531777892815;5865.912011319749;6042.425969532887;9715.27135464857;10131.493425328852;10254.128399085863;10254.6410875619;10292.845607315747;10108.191344692259;10281.794364112526;10287.125594324567;10294.948525257325;10448.738781530523;7542.245775422414;8063.959680201561;8211.95894020526;8281.917180828115;8436.789080272796;8500.957495212484;8575.571221438779;8593.183647553473;8622.61198246093;8641.351898607756;7457.515261507984;7603.2776886195725;7641.083070031409;7661.731839385595;7736.994190755166;7384.667689953858;7544.924550754422;7597.354224890725;7644.3120119187315;7823.687052518063;6843.418309443753;6844.247132815486;6875.621840798804;6954;6963.825904352431;4993.400791904995;5051.545360917535;5074.3657042869645;5160.303359046481;5172.19830926207;5218.55642270396;5247.606429517878;5326.25432439451;5413.512783849473;5437.945620543744 01:25:54 INFO - PROCESS | 26240 | |4;prototype.html;337.8310844577711;337.92708151618604;338.9966100338997;344.78623253582765;347.1408264545249;5658.151277308406;5679.602427830054;5680.31836179658;5689.4879460848515;5735.308084115186;5548.472895074971;5562.721863906809;5597.496225339719;5601.719914004294;5624.325080990277;4167.6457501112445;4269.466316710411;4365.73393715822;4383.934240986372;4403.339499075132;4354.847580334689;4373.059792144688;4376.737395756249;4378.912421751563;4384.430024096863;4351.71713838601;4352.434183556149;4353.542877997812;4373.890652733675;4379.343098535213;4279.186954478639;4351.26028575143;4354.455693038354;4354.825806967718;4357.453104148013;3819.2743378758223;3833.9808300958593;3840.9231815363537;3842.3083844907906;3859.59474255202;5403.351597808249;5422.376426710939;5425.9728701356635;5432.429594892519;5477.67133971963;4834.7824347904425;4950.603951683856;4952.4057113146655;5000.749812546864;5054.671446355975;5820.632151444407;5824.155497452845;5843.357230704619;5845.912311315291;5866.20806191163;4197.601227883346;4239.342901850187;4240.448741663564;4255.595718406777;4256.957430425687;5817.767289308423;6141.662208578527;6144.784932527385;6150.938490615082;6158.3841615838055;4188.727732697365;4204.621584057389;4231.851885184004;4240.257954857888;4241.384999175164;4254.936175957363;4264.253755592759;4290;4299.398084268205;4302.849400271038;4728.4562275338085;4863.756812159449;4882.5605695487575;4888.902221955541;4935.259711043373;5843.5909486336395;5847.883042339129;5855.941440585625;5869.157944695643;5873.295204575478;1464.2971373740663;1467.9339429725687;1488.5459934719797;1491.8209814822292;1496.2743069611229;940.3652534539295;964.0118878149813;1019.6278358399279;1028.1209565821264;1029.7683021320142;5573.275474188411;5606.495415412633;5620.91568626471;5629.8592535186945;5691.373948865621;6033.5474839387225;6035.305939816977;6055.72749226277;6108.389161083945;6132.448079672851;5400.135978243541;5491.972540137273;5556.861078473071;5565.5825813063375;5585.609007369527;3189.4418476766473;3220;3230.53157292196;3245.9675403246138;3265.559149514785;6005.279366475964;6133.877322453526;6197.566170368031;6299.244090709144;6321.96839015802;6046.2139921809885;6074.392560743979;6096.116063170904;6100.267967843798;6141.570090093651;6038.728257228435;6234.127222188898;6283.748650054038;6361.4592759615025;6363.681815909186;5897.466658668863;5925.733341999534;6042.607230530001;6085.208922840003;6124.418180272867;5927.614705044159;5990.88018239624;6025.879482410415;6029.427204415573;6060.696965151813;5992.610480318765;6168.920438923081;6202.2867370253;6216.720247588779;6336.3030066693545;4211.768352740506;4251.723637963522;4262.893427664333;4284.507281662524;4294.527601963844;5872.32638697969;5968.612554978044;5971;6004.789832355847;6023.096535519707;5870.706464676664;5914.34942156371;5925.733341999534;5933.940660593339;5957.880842383215;5671.6029877909805;5834.766609335579;5844;5858.326292476419;5867.20792692981;5779.190913272061;5791.698731722878;5797.420257974169;5804.6807425592;5806.390329015392;5945.940540594712;5977.193078934288;5977.820665380045;6024.668643224665;6044.123602077586;5658.603897727119;5831.241938548132;5838.948989181988;5853.94146058534;5902 01:25:54 INFO - PROCESS | 26240 | |5;yui.html;835.6866175184306;837.3719710217337;858.0689951402728;862.262765335638;877.6489404238308;14876.256187190638;14943.178125203109;15439.768403473943;15453.381864725425;15456.072635641855;14137.575872723835;14137.717245655107;14209;14228.928855355734;14249.572512824632;684.1072400517323;804.5816175588691;815.4943934760457;839.0518713853337;839.2195258409677;809.5668817182778;813.7843471480063;815.1237419773737;815.3110621524802;815.3477218225426;862.3058437957442;862.4178679391417;865.3293697384546;868.3053557154283;868.5743985447117;854.3848429131078;858.2275951643509;859.5315553023586;859.9011113721939;860.7848037990502;624.2540164503421;624.5160000999216;626.1140486212005;626.6616027345228;627.3663599764226;13114;13147.14543554666;13148.276844773629;13149.408276627479;13191;14328.928355358157;14348.49780257686;14385.712285754227;14397.352119154662;14762.483313084098;11442.56967879015;11809.114316426303;11818.586349477813;11823.467943942458;11846;3814.5422549293985;3836.731428799985;3871.728978971473;3961.7622942623534;4002.679785617144;57843;57953;58482.415175848124;58754;58852.41147588512;11190.32858028521;11441.599544015919;11456.198066135457;11515.424228788695;12100.273983560839;20373.083211255234;20592.58814823695;20623.175072996914;20670.379888603366;20726.274580389916;8175.468594541336;8386.496810191407;8463.873041904377;8582.957085214533;8654.134586541422;4476.6194873436125;4530.411046563926;4588.082383523309;4671.995520963009;4691.437027556715;3324.434846076173;3372.9712437706244;3408.522806807049;3418.077119177808;3421.367047096295;620.1503939602683;628.4595248086641;637.2926052082186;641.0512441586478;646.5474168082361;621.6208113051035;653.3923451190343;692.9930700692928;730.6054730445607;751.7932568543695;9740.95129524362;9753.268504862164;9794.853077203848;9891.60433582663;9920.553575089138;749.5520605215963;754.1515794730927;755.4975940999174;769.6690423118113;774.0943096577018;4496.550344965477;4608.769561521911;4624.861254162313;4715.151272770934;4744.3595114659765;68478.31521684819;69136.6543167291;71090;71857;71908.28091719121;62208.68895655493;62219;62658.68670656617;63096;65249;57238;57394.7130264346;57699.71150144306;59044.40955590475;59359;8615.353848461516;8671.4363566368;8721.694740684046;8831.337649676429;8920.197182253629;37400.06499837526;37461.250774983804;37539.81230093832;37782;39273.214535709696;48757.074575525585;50272;50721.49278507168;50989.745051274505;51207.23189152091;11729.824052639047;12197.512099516274;12266.26402415858;12666.556670516487;12896.613101606967;12902.290374029519;13040.673983150118;13146.40841162169;13170.934145329213;13624;12245.816312755494;12387.132900696864;12454;12464.314462704639;12884.806727899277;12123.636290911287;12526.373681315716;12650.936745316214;12708.555200568306;13137.277449740355;10517.368957862553;11755.764884702428;12364.319962402154;12540.184887982252;12845.293508857103;10213.591456341961;10456.63401780934;10591.364518128938;10604.416757078126;11233.157513186381;10094.545745441326;10352.223583231138;10399.688009359732;10416.947915260374;10436.269461137648 01:25:54 INFO - PROCESS | 26240 | __end_tp_report 01:25:54 INFO - PROCESS | 26240 | __start_cc_report 01:25:54 INFO - PROCESS | 26240 | _x_x_mozilla_cycle_collect,345 01:25:54 INFO - PROCESS | 26240 | __end_cc_report 01:25:54 INFO - PROCESS | 26240 | __startTimestamp1464078354518__endTimestamp 01:25:54 INFO - PROCESS | 26240 | 01:25:54 INFO - PROCESS | 26240 | ------- Summary: start ------- 01:25:54 INFO - PROCESS | 26240 | Number of tests: 6 01:25:54 INFO - PROCESS | 26240 | 01:25:54 INFO - PROCESS | 26240 | [#0] dojo.html Cycles:165 Average:5470.82 Median:5703.83 stddev:755.14 (13.2%) stddev-sans-first:735.23 01:25:54 INFO - PROCESS | 26240 | Values: 3152.4 3176.9 3184.7 3186.5 3222.5 5440.6 5487.0 5500.4 5583.2 5583.8 5404.6 5440.8 5483.7 5528.9 5552.5 4981.8 5017.1 5129.7 5156.4 5217.2 687.8 4999.8 5075.8 5098.7 5163.1 4955.1 4983.9 5005.5 5016.6 5037.5 4894.7 4984.6 4987.6 5013.1 5054.9 4980.4 5001.2 5017.8 5030.8 5035.6 5418.3 5482.1 5518.2 5529.5 5579.7 5839.3 5863.4 5997.4 6013.3 6027.0 5881.5 5908.2 5930.6 5946.6 6006.5 5528.3 5531.2 5535.4 5535.8 5548.4 5893.1 6045.1 6083.1 6120.9 6126.9 5929.6 5930.1 5937.2 5946.2 5948.5 6027.3 6030.3 6036.7 6055.7 6061.5 5680.7 5756.3 5765.6 5805.2 5840.8 5734.2 5826.2 5829.4 5844.8 5892.3 4353.8 4385.1 4387.9 4390.5 4426.5 3828.7 3878.5 3914.1 3929.5 3964.0 5639.4 5643.9 5652.3 5665.1 5677.9 5956.4 6051.1 6073.2 6073.4 6074.7 5312.4 5535.2 5606.7 5609.5 5628.8 4949.7 4985.6 4985.9 5027.1 5027.9 5899.1 6211.8 6236.3 6248.8 6272.9 5864.6 5870.7 5890.7 5931.2 5942.6 6035.4 6057.2 6076.1 6097.1 6120.9 5639.4 5835.1 5847.9 5867.0 5888.2 6017.5 6073.4 6079.7 6094.2 6122.7 5807.1 5849.2 5859.2 5859.2 5890.9 5599.7 5661.6 5668.7 5856.0 5865.9 5469.6 5703.8 5727.4 5732.2 5749.4 5923.9 5930.0 5945.5 5965.4 5965.9 5538.9 5688.6 5711.6 5810.6 5826.0 01:25:54 INFO - PROCESS | 26240 | 01:25:54 INFO - PROCESS | 26240 | [#1] ext.html Cycles:180 Average:62156.52 Median:23302.29 stddev:122830.33 (527.1%) stddev-sans-first:123087.95 01:25:54 INFO - PROCESS | 26240 | Values: 597.4 610.1 627.1 628.4 641.3 42584.8 43612.3 43646.6 43746.6 47750.0 44991.1 45610.5 45671.1 45674.3 45686.3 8808.5 9001.7 9002.5 9004.8 9024.4 8868.3 8993.0 9000.5 9003.4 9016.7 8957.9 9016.4 9025.7 9028.1 9030.4 8847.6 8868.8 8904.3 8920.6 8959.3 8856.0 8924.0 8969.8 8973.9 8995.4 41561.8 41867.0 41870.0 41935.4 42126.4 3474.4 3551.4 4012.3 4164.2 4198.5 32127.8 32352.8 32847.2 33048.3 33117.0 4173.9 4247.8 4257.6 4268.7 4329.6 355370.5 355523.0 356040.0 358689.0 359742.0 57406.4 58202.7 58438.4 58564.1 58589.7 59694.7 60884.0 60956.7 61020.4 61243.4 16215.4 16358.7 16503.6 16574.4 16606.2 12237.8 12371.9 12380.9 12473.6 12503.9 15494.3 16503.1 16570.5 16636.5 17030.9 5846.3 6042.9 6084.5 6100.7 6120.2 1004.4 1068.7 1074.4 1172.7 1235.3 32842.5 33984.3 34062.3 34221.5 37232.3 1191.6 1197.7 1214.4 1240.2 1241.7 17007.7 17491.5 18105.6 18359.5 19178.9 532411.0 534956.0 536924.0 537314.9 538362.0 58544.7 58973.1 59189.7 59460.7 59842.7 1386.2 1395.5 1407.5 1427.9 1432.0 32343.8 33870.2 33976.7 34170.3 34176.1 57046.4 57308.0 57395.4 57601.4 57957.1 476925.0 477221.0 477452.0 479412.4 481458.0 27816.0 28007.7 28247.9 28635.3 28936.0 48835.8 49371.8 49977.8 50080.0 50485.0 40998.0 42882.0 43404.1 43542.3 43703.1 41448.0 41692.6 42199.8 42259.2 42708.4 41281.0 41515.4 42102.0 42246.8 42356.8 36235.0 37329.0 37455.3 37992.4 38143.6 28463.3 28786.1 28918.9 29005.4 29010.3 01:25:54 INFO - PROCESS | 26240 | 01:25:54 INFO - PROCESS | 26240 | [#2] jquery.html Cycles:180 Average:28594.69 Median:15817.36 stddev:80403.66 (508.3%) stddev-sans-first:80601.31 01:25:54 INFO - PROCESS | 26240 | Values: 382.7 390.8 397.6 399.7 399.9 14051.6 17913.3 18601.0 19188.0 19194.5 15506.0 17377.5 18227.7 18252.9 18315.4 5453.3 5705.2 5747.6 5769.1 5783.4 5569.0 5671.4 5699.1 5723.9 5734.7 5634.6 5658.7 5662.4 5672.8 5685.2 5556.8 5596.2 5635.5 5660.9 5708.9 5053.3 5076.5 5095.9 5105.8 5127.4 21756.3 21827.2 22250.2 22553.1 22579.7 2337.9 2404.2 2427.7 2525.4 2702.1 14265.7 14296.4 14468.1 14655.6 14861.6 1908.0 1963.5 2013.1 2024.1 2043.8 81826.6 82686.6 83899.6 84212.0 84873.6 9249.4 9271.2 9700.1 10149.5 10454.4 14583.9 14604.9 14744.9 14746.0 14772.9 7162.6 7477.9 7699.4 7769.7 7902.6 7781.5 7861.3 7904.9 7978.2 8058.7 6400.0 6437.0 6489.6 6638.6 6664.4 1861.2 1887.2 1902.6 1927.9 1943.4 1063.1 1076.7 1093.9 1103.3 1136.7 18515.7 18844.2 19292.9 19553.7 19628.3 1016.9 1036.3 1064.4 1101.5 1115.0 10748.2 11222.5 11347.4 11350.1 11373.3 478796.0 490679.0 490741.0 490953.0 491103.0 81607.6 83838.0 84149.6 84909.6 85099.0 987.2 996.6 1002.4 1011.2 1020.3 15703.8 17211.7 17343.7 17541.5 17940.8 28932.6 31387.5 42233.4 42463.8 43164.6 54759.7 56423.4 56515.0 56749.7 57705.4 8570.5 8588.0 8588.7 8716.4 9020.4 12982.9 12986.8 13343.8 13364.5 13377.0 11151.1 11477.4 11831.9 11994.8 12310.1 10835.3 11161.2 11472.3 11673.2 11931.6 11329.7 12145.5 12393.1 12459.2 12556.8 8445.8 8580.2 8599.4 8742.0 8788.1 9043.6 9763.6 9964.2 9969.3 10458.4 01:25:54 INFO - PROCESS | 26240 | 01:25:54 INFO - PROCESS | 26240 | [#3] mootools.html Cycles:180 Average:5778.51 Median:4828.64 stddev:3272.40 (67.8%) stddev-sans-first:3265.55 01:25:54 INFO - PROCESS | 26240 | Values: 1469.3 1544.8 1666.6 1794.5 1807.9 7628.2 8298.6 8349.3 8960.1 8960.6 8341.9 8522.5 8601.5 8628.3 8644.1 2362.8 2400.7 2403.2 2406.3 2407.6 2331.6 2383.5 2397.7 2408.5 2415.0 2382.8 2385.4 2386.2 2404.4 2410.2 2314.2 2345.0 2351.8 2365.6 2373.1 2366.4 2378.4 2390.8 2396.4 2398.3 8574.2 8575.8 8579.6 8590.7 8655.2 5285.2 5362.5 5373.9 5398.8 5400.6 3293.3 3355.4 3409.2 3411.1 3411.9 1088.3 1096.9 1125.2 1130.7 1134.8 12193.9 12217.9 12227.9 12234.4 12238.2 4650.4 4728.5 4836.4 4857.5 4857.8 10345.0 10407.8 10444.9 10445.4 10454.0 5243.7 5294.0 5322.9 5446.4 5454.8 4251.5 4820.8 4934.1 4953.8 4965.0 3868.4 3971.1 3993.8 3999.5 4121.4 1241.5 1267.8 1284.9 1292.1 1299.9 866.5 971.9 972.8 973.8 975.0 5751.5 5901.0 5974.2 5981.7 6077.4 470.8 474.2 482.9 484.4 488.5 3858.7 3911.2 3962.3 4185.2 4196.1 10356.7 10541.1 10843.3 10861.6 10927.1 10627.3 10680.8 10768.8 10782.0 10800.9 7651.5 7897.4 7966.5 7982.1 8005.4 5645.7 5668.7 5840.2 5865.9 6042.4 9715.3 10131.5 10254.1 10254.6 10292.8 10108.2 10281.8 10287.1 10294.9 10448.7 7542.2 8064.0 8212.0 8281.9 8436.8 8501.0 8575.6 8593.2 8622.6 8641.4 7457.5 7603.3 7641.1 7661.7 7737.0 7384.7 7544.9 7597.4 7644.3 7823.7 6843.4 6844.2 6875.6 6954.0 6963.8 4993.4 5051.5 5074.4 5160.3 5172.2 5218.6 5247.6 5326.3 5413.5 5437.9 01:25:54 INFO - PROCESS | 26240 | 01:25:54 INFO - PROCESS | 26240 | [#4] prototype.html Cycles:180 Average:4940.69 Median:5627.09 stddev:1460.42 (26.0%) stddev-sans-first:1423.07 01:25:54 INFO - PROCESS | 26240 | Values: 337.8 337.9 339.0 344.8 347.1 5658.2 5679.6 5680.3 5689.5 5735.3 5548.5 5562.7 5597.5 5601.7 5624.3 4167.6 4269.5 4365.7 4383.9 4403.3 4354.8 4373.1 4376.7 4378.9 4384.4 4351.7 4352.4 4353.5 4373.9 4379.3 4279.2 4351.3 4354.5 4354.8 4357.5 3819.3 3834.0 3840.9 3842.3 3859.6 5403.4 5422.4 5426.0 5432.4 5477.7 4834.8 4950.6 4952.4 5000.7 5054.7 5820.6 5824.2 5843.4 5845.9 5866.2 4197.6 4239.3 4240.4 4255.6 4257.0 5817.8 6141.7 6144.8 6150.9 6158.4 4188.7 4204.6 4231.9 4240.3 4241.4 4254.9 4264.3 4290.0 4299.4 4302.8 4728.5 4863.8 4882.6 4888.9 4935.3 5843.6 5847.9 5855.9 5869.2 5873.3 1464.3 1467.9 1488.5 1491.8 1496.3 940.4 964.0 1019.6 1028.1 1029.8 5573.3 5606.5 5620.9 5629.9 5691.4 6033.5 6035.3 6055.7 6108.4 6132.4 5400.1 5492.0 5556.9 5565.6 5585.6 3189.4 3220.0 3230.5 3246.0 3265.6 6005.3 6133.9 6197.6 6299.2 6322.0 6046.2 6074.4 6096.1 6100.3 6141.6 6038.7 6234.1 6283.7 6361.5 6363.7 5897.5 5925.7 6042.6 6085.2 6124.4 5927.6 5990.9 6025.9 6029.4 6060.7 5992.6 6168.9 6202.3 6216.7 6336.3 4211.8 4251.7 4262.9 4284.5 4294.5 5872.3 5968.6 5971.0 6004.8 6023.1 5870.7 5914.3 5925.7 5933.9 5957.9 5671.6 5834.8 5844.0 5858.3 5867.2 5779.2 5791.7 5797.4 5804.7 5806.4 5945.9 5977.2 5977.8 6024.7 6044.1 5658.6 5831.2 5838.9 5853.9 5902.0 01:25:54 INFO - PROCESS | 26240 | 01:25:54 INFO - PROCESS | 26240 | [#5] yui.html Cycles:180 Average:15926.16 Median:4648.43 stddev:19364.19 (416.6%) stddev-sans-first:19385.36 01:25:54 INFO - PROCESS | 26240 | Values: 835.7 837.4 858.1 862.3 877.6 14876.3 14943.2 15439.8 15453.4 15456.1 14137.6 14137.7 14209.0 14228.9 14249.6 684.1 804.6 815.5 839.1 839.2 809.6 813.8 815.1 815.3 815.3 862.3 862.4 865.3 868.3 868.6 854.4 858.2 859.5 859.9 860.8 624.3 624.5 626.1 626.7 627.4 13114.0 13147.1 13148.3 13149.4 13191.0 14328.9 14348.5 14385.7 14397.4 14762.5 11442.6 11809.1 11818.6 11823.5 11846.0 3814.5 3836.7 3871.7 3961.8 4002.7 57843.0 57953.0 58482.4 58754.0 58852.4 11190.3 11441.6 11456.2 11515.4 12100.3 20373.1 20592.6 20623.2 20670.4 20726.3 8175.5 8386.5 8463.9 8583.0 8654.1 4476.6 4530.4 4588.1 4672.0 4691.4 3324.4 3373.0 3408.5 3418.1 3421.4 620.2 628.5 637.3 641.1 646.5 621.6 653.4 693.0 730.6 751.8 9741.0 9753.3 9794.9 9891.6 9920.6 749.6 754.2 755.5 769.7 774.1 4496.6 4608.8 4624.9 4715.2 4744.4 68478.3 69136.7 71090.0 71857.0 71908.3 62208.7 62219.0 62658.7 63096.0 65249.0 57238.0 57394.7 57699.7 59044.4 59359.0 8615.4 8671.4 8721.7 8831.3 8920.2 37400.1 37461.3 37539.8 37782.0 39273.2 48757.1 50272.0 50721.5 50989.7 51207.2 11729.8 12197.5 12266.3 12666.6 12896.6 12902.3 13040.7 13146.4 13170.9 13624.0 12245.8 12387.1 12454.0 12464.3 12884.8 12123.6 12526.4 12650.9 12708.6 13137.3 10517.4 11755.8 12364.3 12540.2 12845.3 10213.6 10456.6 10591.4 10604.4 11233.2 10094.5 10352.2 10399.7 10416.9 10436.3 01:25:54 INFO - PROCESS | 26240 | -------- Summary: end -------- 01:25:54 INFO - PROCESS | 26240 | 01:25:54 INFO - PROCESS | 26240 | 01:25:54 INFO - PROCESS | 26240 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0043,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 01:25:54 INFO - PROCESS | 26240 | 01:25:54 INFO - PROCESS | 26240 | 01:25:54 INFO - PROCESS | 26240 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 01:25:54 INFO - PROCESS | 26240 | 01:25:55 INFO - TEST-INFO | 26240: exit 0 01:25:55 INFO - TEST-OK | dromaeo_css | took 1110132ms 01:25:55 INFO - TEST-START | kraken 01:25:55 INFO - operating with platform_type : linux_ 01:25:55 INFO - Initialising browser for kraken test... 01:25:55 INFO - TEST-INFO | started process 26473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO6tf7X/profile http://localhost:50123/getInfo.html) 01:25:59 INFO - PROCESS | 26473 | 01:25:59 INFO - PROCESS | 26473 | (process:26543): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:25:59 INFO - PROCESS | 26473 | __metrics Screen width/height:1600/1200 01:25:59 INFO - PROCESS | 26473 | colorDepth:24 01:25:59 INFO - PROCESS | 26473 | Browser inner width/height: 1024/697 01:25:59 INFO - PROCESS | 26473 | __metrics 01:26:00 ERROR - PROCESS | 26473 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 01:26:01 INFO - TEST-INFO | 26473: exit 0 01:26:01 INFO - Browser initialized. 01:26:01 INFO - Running cycle 1/1 for kraken test... 01:26:01 INFO - TEST-INFO | started process 26594 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO6tf7X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:26:03 INFO - PROCESS | 26594 | 01:26:03 INFO - PROCESS | 26594 | (process:26656): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:26:13 INFO - PROCESS | 26594 | RSS: Main: 163872768 01:26:13 INFO - PROCESS | 26594 | 01:26:15 INFO - PROCESS | 26594 | Cycle 1(1): loaded http://localhost:50123/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50123/tests/kraken/driver.html?testName=audio-beat-detection) 01:26:16 INFO - PROCESS | 26594 | RSS: Main: 168697856 01:26:16 INFO - PROCESS | 26594 | 01:26:19 INFO - PROCESS | 26594 | Cycle 1(1): loaded http://localhost:50123/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50123/tests/kraken/driver.html?testName=audio-dft) 01:26:19 INFO - PROCESS | 26594 | RSS: Main: 169029632 01:26:19 INFO - PROCESS | 26594 | 01:26:22 INFO - PROCESS | 26594 | Cycle 1(1): loaded http://localhost:50123/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50123/tests/kraken/driver.html?testName=audio-fft) 01:26:23 INFO - PROCESS | 26594 | RSS: Main: 163520512 01:26:23 INFO - PROCESS | 26594 | 01:26:25 INFO - PROCESS | 26594 | Cycle 1(1): loaded http://localhost:50123/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50123/tests/kraken/driver.html?testName=audio-oscillator) 01:26:25 INFO - PROCESS | 26594 | RSS: Main: 163524608 01:26:25 INFO - PROCESS | 26594 | 01:26:28 INFO - PROCESS | 26594 | Cycle 1(1): loaded http://localhost:50123/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50123/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:26:28 INFO - PROCESS | 26594 | RSS: Main: 163930112 01:26:28 INFO - PROCESS | 26594 | 01:26:31 INFO - PROCESS | 26594 | Cycle 1(1): loaded http://localhost:50123/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50123/tests/kraken/driver.html?testName=imaging-darkroom) 01:26:32 INFO - PROCESS | 26594 | RSS: Main: 164532224 01:26:32 INFO - PROCESS | 26594 | 01:26:35 INFO - PROCESS | 26594 | Cycle 1(1): loaded http://localhost:50123/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50123/tests/kraken/driver.html?testName=imaging-desaturate) 01:26:36 INFO - PROCESS | 26594 | RSS: Main: 162873344 01:26:36 INFO - PROCESS | 26594 | 01:26:39 INFO - PROCESS | 26594 | Cycle 1(1): loaded http://localhost:50123/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50123/tests/kraken/driver.html?testName=json-parse-financial) 01:26:40 INFO - PROCESS | 26594 | RSS: Main: 163725312 01:26:40 INFO - PROCESS | 26594 | 01:26:41 INFO - PROCESS | 26594 | Cycle 1(1): loaded http://localhost:50123/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50123/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:26:42 INFO - PROCESS | 26594 | RSS: Main: 164413440 01:26:42 INFO - PROCESS | 26594 | 01:26:44 INFO - PROCESS | 26594 | Cycle 1(1): loaded http://localhost:50123/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50123/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:26:44 INFO - PROCESS | 26594 | RSS: Main: 164249600 01:26:44 INFO - PROCESS | 26594 | 01:26:46 INFO - PROCESS | 26594 | Cycle 1(1): loaded http://localhost:50123/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50123/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:26:47 INFO - PROCESS | 26594 | RSS: Main: 164577280 01:26:47 INFO - PROCESS | 26594 | 01:26:49 INFO - PROCESS | 26594 | Cycle 1(1): loaded http://localhost:50123/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50123/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:26:50 INFO - PROCESS | 26594 | RSS: Main: 164782080 01:26:50 INFO - PROCESS | 26594 | 01:26:53 INFO - PROCESS | 26594 | Cycle 1(1): loaded http://localhost:50123/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50123/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:26:53 INFO - PROCESS | 26594 | RSS: Main: 164208640 01:26:53 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | Cycle 1(1): loaded http://localhost:50123/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50123/tests/kraken/driver.html?testName=ai-astar) 01:26:55 INFO - PROCESS | 26594 | RSS: Main: 165904384 01:26:55 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | __start_tp_report 01:26:55 INFO - PROCESS | 26594 | _x_x_mozilla_page_load 01:26:55 INFO - PROCESS | 26594 | _x_x_mozilla_page_load_details 01:26:55 INFO - PROCESS | 26594 | |i|pagename|runs| 01:26:55 INFO - PROCESS | 26594 | |0;ai-astar;111;106;111;109;111;112;110;110;110;110 01:26:55 INFO - PROCESS | 26594 | |1;audio-beat-detection;151;127;155;190;126;155;153;137;180;129 01:26:55 INFO - PROCESS | 26594 | |2;audio-dft;160;163;161;161;163;175;176;162;164;162 01:26:55 INFO - PROCESS | 26594 | |3;audio-fft;76;75;75;147;75;74;74;74;159;77 01:26:55 INFO - PROCESS | 26594 | |4;audio-oscillator;92;92;155;93;92;92;149;91;93;157 01:26:55 INFO - PROCESS | 26594 | |5;imaging-gaussian-blur;117;117;117;118;117;117;118;117;116;118 01:26:55 INFO - PROCESS | 26594 | |6;imaging-darkroom;146;148;147;147;147;146;147;177;147;146 01:26:55 INFO - PROCESS | 26594 | |7;imaging-desaturate;95;99;96;96;96;96;95;96;96;95 01:26:55 INFO - PROCESS | 26594 | |8;json-parse-financial;57;56;56;55;56;56;56;77;54;63 01:26:55 INFO - PROCESS | 26594 | |9;json-stringify-tinderbox;63;64;62;62;62;63;62;64;63;62 01:26:55 INFO - PROCESS | 26594 | |10;stanford-crypto-aes;79;78;78;78;80;79;80;78;79;78 01:26:55 INFO - PROCESS | 26594 | |11;stanford-crypto-ccm;134;120;134;120;120;126;127;118;159;124 01:26:55 INFO - PROCESS | 26594 | |12;stanford-crypto-pbkdf2;160;161;168;160;160;158;163;159;158;162 01:26:55 INFO - PROCESS | 26594 | |13;stanford-crypto-sha256-iterative;63;62;63;62;64;65;62;64;61;64 01:26:55 INFO - PROCESS | 26594 | __end_tp_report 01:26:55 INFO - PROCESS | 26594 | __start_cc_report 01:26:55 INFO - PROCESS | 26594 | _x_x_mozilla_cycle_collect,851 01:26:55 INFO - PROCESS | 26594 | __end_cc_report 01:26:55 INFO - PROCESS | 26594 | __startTimestamp1464078415868__endTimestamp 01:26:55 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | ------- Summary: start ------- 01:26:55 INFO - PROCESS | 26594 | Number of tests: 14 01:26:55 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.50 stddev:1.63 (1.5%) stddev-sans-first:1.69 01:26:55 INFO - PROCESS | 26594 | Values: 111.0 106.0 111.0 109.0 111.0 112.0 110.0 110.0 110.0 110.0 01:26:55 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:154.00 stddev:21.79 (14.2%) stddev-sans-first:23.11 01:26:55 INFO - PROCESS | 26594 | Values: 151.0 127.0 155.0 190.0 126.0 155.0 153.0 137.0 180.0 129.0 01:26:55 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | [#2] audio-dft Cycles:10 Average:164.70 Median:163.00 stddev:5.81 (3.6%) stddev-sans-first:5.91 01:26:55 INFO - PROCESS | 26594 | Values: 160.0 163.0 161.0 161.0 163.0 175.0 176.0 162.0 164.0 162.0 01:26:55 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | [#3] audio-fft Cycles:10 Average:90.60 Median:75.00 stddev:33.02 (44.0%) stddev-sans-first:34.60 01:26:55 INFO - PROCESS | 26594 | Values: 76.0 75.0 75.0 147.0 75.0 74.0 74.0 74.0 159.0 77.0 01:26:55 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:92.00 stddev:29.79 (32.4%) stddev-sans-first:30.83 01:26:55 INFO - PROCESS | 26594 | Values: 92.0 92.0 155.0 93.0 92.0 92.0 149.0 91.0 93.0 157.0 01:26:55 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 01:26:55 INFO - PROCESS | 26594 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 116.0 118.0 01:26:55 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:147.00 stddev:9.58 (6.5%) stddev-sans-first:10.06 01:26:55 INFO - PROCESS | 26594 | Values: 146.0 148.0 147.0 147.0 147.0 146.0 147.0 177.0 147.0 146.0 01:26:55 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.15 (1.2%) stddev-sans-first:1.17 01:26:55 INFO - PROCESS | 26594 | Values: 95.0 99.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 01:26:55 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:56.00 stddev:6.90 (12.3%) stddev-sans-first:7.29 01:26:55 INFO - PROCESS | 26594 | Values: 57.0 56.0 56.0 55.0 56.0 56.0 56.0 77.0 54.0 63.0 01:26:55 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 01:26:55 INFO - PROCESS | 26594 | Values: 63.0 64.0 62.0 62.0 62.0 63.0 62.0 64.0 63.0 62.0 01:26:55 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 01:26:55 INFO - PROCESS | 26594 | Values: 79.0 78.0 78.0 78.0 80.0 79.0 80.0 78.0 79.0 78.0 01:26:55 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:126.50 stddev:12.23 (9.7%) stddev-sans-first:12.79 01:26:55 INFO - PROCESS | 26594 | Values: 134.0 120.0 134.0 120.0 120.0 126.0 127.0 118.0 159.0 124.0 01:26:55 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:160.50 stddev:2.96 (1.8%) stddev-sans-first:3.12 01:26:55 INFO - PROCESS | 26594 | Values: 160.0 161.0 168.0 160.0 160.0 158.0 163.0 159.0 158.0 162.0 01:26:55 INFO - PROCESS | 26594 | 01:26:55 INFO - PROCESS | 26594 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.50 stddev:1.25 (2.0%) stddev-sans-first:1.32 01:26:55 INFO - PROCESS | 26594 | Values: 63.0 62.0 63.0 62.0 64.0 65.0 62.0 64.0 61.0 64.0 01:26:55 INFO - PROCESS | 26594 | -------- Summary: end -------- 01:26:55 INFO - PROCESS | 26594 | 01:26:56 INFO - TEST-INFO | 26594: exit 0 01:26:56 INFO - TEST-OK | kraken | took 61563ms 01:26:56 INFO - SUITE-END | took 1171s 01:26:57 INFO - Completed test suite (00:19:31) 01:26:57 INFO - javascript benchmark 01:26:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7252.688382854624, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3152.4483215437294, 3176.8570414331352, 3184.72929800967, 3186.537951996962, 3222.4682927316994, 5440.564754819615, 5486.999999999995, 5500.449955004503, 5583.218349431073, 5583.804566840161, 5404.567634589233, 5440.836774896759, 5483.670979741219, 5528.944710552903, 5552.5280351170095, 4981.775820088095, 5017.122003649347, 5129.743512824362, 5156.381234251895, 5217.243499692542, 687.8485569473592, 4999.7500124993785, 5075.7715902784275, 5098.694078355292, 5163.1480805667015, 4955.132851750929, 4983.875403114933, 5005.54950054495, 5016.573591244749, 5037.4710655381205, 4894.706317620954, 4984.601231901475, 4987.62592805541, 5013.097642424362, 5054.9241761373605, 4980.402351717781, 5001.24981252815, 5017.774200161001, 5030.798768049273, 5035.571976381975, 5418.349798024223, 5482.068048431776, 5518.19986102017, 5529.529989950859, 5579.748911298961, 5839.328477225131, 5863.355030946593, 5997.370276120988, 6013.278406591194, 6026.96986515069, 5881.47066763989, 5908.172855800191, 5930.614510056833, 5946.554008449383, 6006.549508786815, 5528.281323427969, 5531.197976293455, 5535.39110697827, 5535.806246781383, 5548.4174161712845, 5893.057110862242, 6045.093236014633, 6083.148359229712, 6120.908186377208, 6126.877462450726, 5929.644221346733, 5930.051191809376, 5937.168796368512, 5946.197263369476, 5948.494377977834, 6027.276726792726, 6030.33666296707, 6036.728347224385, 6055.697215139226, 6061.454469097803, 5680.68756218412, 5756.251687280626, 5765.596408251382, 5805.187273781674, 5840.8247752567495, 5734.225879506297, 5826.184334193216, 5829.446202610745, 5844.795432159854, 5892.322382925932, 4353.82584696615, 4385.122975404932, 4387.934180987288, 4390.517043125254, 4426.535213802569, 3828.73198876076, 3878.4764056851964, 3914.080191155076, 3929.528456585228, 3964.0486283291802, 5639.379668236491, 5643.943560564342, 5652.3217213934595, 5665.093585026459, 5677.858053548612, 5956.404359564009, 6051.0923361496125, 6073.210482637229, 6073.39266073398, 6074.726637301332, 5312.415634280226, 5535.197396377584, 5606.6916319602, 5609.523190528769, 5628.831135065954, 4949.727764972889, 4985.626078044161, 4985.925211121836, 5027.095122877917, 5027.924581131286, 5899.085641725539, 6211.751529938842, 6236.34518375564, 6248.843778905563, 6272.937270627235, 5864.560157988168, 5870.677112758839, 5890.7349169288345, 5931.199288096224, 5942.58401911862, 6035.36628653985, 6057.21256236704, 6076.088586712029, 6097.115918191748, 6120.8775824484155, 5639.436056394492, 5835.095560188178, 5847.853803654943, 5867.031939729897, 5888.205092312483, 6017.458428741435, 6073.423024812636, 6079.696015199134, 6094.199305899851, 6122.6938653068055, 5807.0998995155815, 5849.181114644039, 5859.179714839841, 5859.2090067842, 5890.9116363253725, 5599.748011339418, 5661.575381846295, 5668.659880407189, 5856.033754430471, 5865.853353666193, 5469.644473109235, 5703.828885133453, 5727.36998930109, 5732.168835518743, 5749.396313387034, 5923.940760592339, 5930.0, 5945.494632956247, 5965.373635768182, 5965.940340596539, 5538.944610553843, 5688.630239034615, 5711.600187986967, 5810.564207684525, 5826.038703613856], "value": 5419.733902282185, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.3638075449646, 610.0513701194641, 627.1095045036049, 628.4281304013349, 641.3105911145518, 42584.78707606462, 43612.345814812805, 43646.56353436465, 43746.56253437464, 47750.044999100086, 44991.10017799642, 45610.543894561044, 45671.0865782685, 45674.31488527675, 45686.314705279445, 8808.471491710501, 9001.684941027066, 9002.549872506348, 9004.774880628003, 9024.368294219406, 8868.33487488441, 8992.955035224815, 9000.504972226525, 9003.414778039407, 9016.68441604544, 8957.910420895772, 9016.41393309436, 9025.729228123135, 9028.052054534277, 9030.367874248805, 8847.601857916408, 8868.778280542974, 8904.332175086862, 8920.643174273022, 8959.28325733943, 8856.0, 8923.955380223122, 8969.820603587958, 8973.910260897374, 8995.415298005608, 41561.792191038854, 41867.0, 41870.0, 41935.370969435484, 42126.36810447846, 3474.4267195912644, 3551.3607550640872, 4012.277789997799, 4164.208800327928, 4198.538160802309, 32127.83936080328, 32352.838235808907, 32847.178820529676, 33048.33903321944, 33117.0, 4173.916521669549, 4247.787610619456, 4257.638100761439, 4268.722533035374, 4329.567043295645, 355370.45462499553, 355523.0, 356040.0, 358689.0, 359742.0, 57406.42593574095, 58202.70898645564, 58438.41561584415, 58564.12153817696, 58589.70705146447, 59694.70152649296, 60884.0, 60956.695216523636, 61020.38979610147, 61243.38756612466, 16215.432459863849, 16358.672826543403, 16503.587410314838, 16574.419895303847, 16606.169691515377, 12237.75524489523, 12371.876281237252, 12380.876191237972, 12473.625791226277, 12503.937480312541, 15494.30275637599, 16503.09232992197, 16570.502884913472, 16636.50090497287, 17030.914845425694, 5846.269216347957, 6042.879142417127, 6084.5436592255755, 6100.69496525172, 6120.17377654011, 1004.352192835617, 1068.7435015596202, 1074.3768614203743, 1172.73613436976, 1235.2773627428055, 32842.50736238958, 33984.32031359359, 34062.31875362528, 34221.48667769985, 37232.25535489275, 1191.6127258640977, 1197.6646538969103, 1214.40494157862, 1240.231056744824, 1241.714405686697, 17007.659846802995, 17491.47525574235, 18105.63788724218, 18359.54101147482, 19178.90410547966, 532411.0, 534956.0, 536924.0, 537314.9402758962, 538362.0, 58544.70727646335, 58973.11540326899, 59189.704051479464, 59460.70269648624, 59842.70078649666, 1386.230641993683, 1395.4766962389103, 1407.5355132806149, 1427.8929080319017, 1432.0047566940875, 32343.838280808446, 33870.153246169044, 33976.66023339735, 34170.31659366749, 34176.14559636029, 57046.42953570411, 57308.0, 57395.426045739005, 57601.423985761285, 57957.13064304123, 476925.0, 477221.0, 477452.0, 479412.426440818, 481458.0, 27816.0, 28007.719922800512, 28247.858760706065, 28635.28411789722, 28936.0, 48835.755821220664, 49371.75314123406, 49977.75011124921, 50080.0, 50485.0, 40998.0, 42882.0, 43404.13191736084, 43542.346864797684, 43703.12593748171, 41448.0, 41692.58307416887, 42199.7890010548, 42259.154816904105, 42708.359374608786, 41281.0, 41515.37726934159, 42102.0, 42246.78876605597, 42356.788216058725, 36235.0, 37329.0, 37455.2508949814, 37992.430113547765, 38143.61856381401, 28463.28841778972, 28786.136415907557, 28918.855405722836, 29005.41989160163, 29010.27474313159], "value": 20503.67907669713, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.6938449240608, 390.81826950468025, 397.6083557695671, 399.6722687396335, 399.9200159968007, 14051.578452646438, 17913.283468661255, 18601.0, 19188.0405979701, 19194.520136996583, 15506.0, 17377.47867563975, 18227.726584101216, 18252.908735456305, 18315.358962436316, 5453.318335208109, 5705.172749951254, 5747.568932330071, 5769.134629805541, 5783.421657834225, 5568.972155139219, 5671.404502527237, 5699.145128230757, 5723.914141287884, 5734.713264336788, 5634.577406694494, 5658.660480371171, 5662.377138514781, 5672.773089076432, 5685.1756495308155, 5556.833295001156, 5596.160575913605, 5635.464630860061, 5660.886782264352, 5708.885822283531, 5053.267276244961, 5076.466970968069, 5095.8980820383385, 5105.82129625465, 5127.410347809975, 21756.34730958074, 21827.23604673829, 22250.221242256604, 22553.097876084936, 22579.661305080437, 2337.9298621041394, 2404.2066118181133, 2427.7450867658818, 2525.368657835541, 2702.148823120711, 14265.714685706227, 14296.356663950044, 14468.131912085308, 14655.560333190022, 14861.628459288604, 1907.9618407631908, 1963.4698631369592, 2013.1242909334487, 2024.068928292987, 2043.8467114966288, 81826.59086704587, 82686.58656706738, 83899.58050209771, 84212.0, 84873.57563212144, 9249.352545321897, 9271.165595096474, 9700.126988571063, 10149.543270552844, 10454.425006624557, 14583.85416145825, 14604.904632152631, 14744.852551474349, 14746.0, 14772.852271477148, 7162.556298486113, 7477.887831682529, 7699.384049276045, 7769.650365733555, 7902.565358905201, 7781.45529812919, 7861.292483676497, 7904.881426778603, 7978.162292959272, 8058.717944871902, 6400.0, 6437.0, 6489.643069631121, 6638.634875081821, 6664.36757480802, 1861.1717785585286, 1887.160213704888, 1902.6384986852454, 1927.9132439040277, 1943.426689126711, 1063.0546100635818, 1076.6985244131656, 1093.8906109388997, 1103.2883789955595, 1136.7385501334738, 18515.72226416605, 18844.15201315944, 19292.903535482514, 19553.706694399596, 19628.3130090449, 1016.9288149829441, 1036.2797855490512, 1064.387976913278, 1101.4823033174396, 1114.9777004459866, 10748.193885458622, 11222.494987725571, 11347.37589432589, 11350.09199264057, 11373.260738052, 478796.0, 490679.0, 490741.0, 490953.0, 491103.0, 81607.591962041, 83838.0, 84149.57925210334, 84909.57545212358, 85099.0, 987.2052997337213, 996.5764550066193, 1002.4035698759227, 1011.185995273797, 1020.3010937507831, 15703.842961570695, 17211.741823872402, 17343.653126937643, 17541.473755787345, 17940.820591793916, 28932.566011510266, 31387.529187061755, 42233.36649950192, 42463.787681061396, 43164.568354316056, 54759.72620137033, 56423.43576564346, 56515.0, 56749.71625141848, 57705.422945770006, 8570.48577085377, 8588.0, 8588.742337729627, 8716.43343182691, 9020.413673111227, 12982.870171298166, 12986.805197921849, 13343.799843002169, 13364.465421383426, 13377.0, 11151.052160566118, 11477.426128693365, 11831.940840295743, 11994.76010479768, 12310.138290319592, 10835.349879007284, 11161.218714690218, 11472.31166130035, 11673.182877198515, 11931.642050738492, 11329.71675708114, 12145.514179432723, 12393.132480726623, 12459.190152640049, 12556.811647825107, 8445.831083378174, 8580.184882436159, 8599.355048371272, 8742.025518341206, 8788.121187881161, 9043.593038313424, 9763.560639771085, 9964.202863770735, 9969.252306077218, 10458.424786636808], "value": 9227.673608106463, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.2727100085456, 1544.7991761071062, 1666.5833541614597, 1794.5423916901188, 1807.8644101692375, 7628.160902300742, 8298.585070746454, 8349.290310323622, 8960.059193784657, 8960.596773145217, 8341.91658083419, 8522.531260780655, 8601.483910965331, 8628.266597339234, 8644.092370301121, 2362.7755363240462, 2400.7479214682467, 2403.170906037414, 2406.32622865597, 2407.6388541718707, 2331.6385960176117, 2383.4518060846017, 2397.652340410639, 2408.5182963407387, 2415.0, 2382.809375249976, 2385.3678775124604, 2386.224477044959, 2404.434957784928, 2410.192585483865, 2314.201600447843, 2344.953100937989, 2351.7883390494853, 2365.597848365773, 2373.086361750721, 2366.408397900525, 2378.3816207785926, 2390.760923907613, 2396.3769419950763, 2398.292503711392, 8574.22831945128, 8575.785605359853, 8579.571021448903, 8590.699325523577, 8655.221030107321, 5285.207218917193, 5362.544183744387, 5373.946260537384, 5398.757055932492, 5400.594955378323, 3293.275479394529, 3355.446351352024, 3409.1988382730037, 3411.1301618087477, 3411.8976430707116, 1088.3361149698678, 1096.8848270931517, 1125.2348403085898, 1130.728625129971, 1134.8297755336682, 12193.878061219362, 12217.877821221851, 12227.877721222763, 12234.388280585936, 12238.204516706475, 4650.395448591661, 4728.503507131771, 4836.443808961944, 4857.489963553776, 4857.781399837016, 10345.0, 10407.843882341771, 10444.947775261075, 10445.425501597485, 10454.0, 5243.659162154448, 5294.047071527085, 5322.8935421292135, 5446.373667028263, 5454.7818087276855, 4251.489821221473, 4820.831270905502, 4934.062528119646, 4953.826616068421, 4965.0069986002945, 3868.3810590305416, 3971.146203566247, 3993.800309984489, 3999.5000624921886, 4121.381792731115, 1241.490988694631, 1267.828843106169, 1284.948602055926, 1292.101989117573, 1299.857015728269, 866.5493943149527, 971.9319647624599, 972.7859870828406, 973.7516933181993, 975.0, 5751.511121554715, 5900.970495147582, 5974.193483879708, 5981.730822113015, 6077.392260773976, 470.8352076773102, 474.23647926837765, 482.8599706085266, 484.4186975629259, 488.5236894028365, 3858.7298889078056, 3911.2177564487215, 3962.306596345628, 4185.162967406531, 4196.139791342767, 10356.741081472872, 10541.104006159563, 10843.349399036084, 10861.565537378574, 10927.125829933586, 10627.309224900357, 10680.839787403194, 10768.784624307627, 10782.0, 10800.891991080145, 7651.464397492234, 7897.368210543143, 7966.482178658369, 7982.082060562993, 8005.439619226599, 5645.71771411436, 5668.744906479136, 5840.1531777892815, 5865.912011319749, 6042.425969532887, 9715.27135464857, 10131.493425328852, 10254.128399085863, 10254.6410875619, 10292.845607315747, 10108.191344692259, 10281.794364112526, 10287.125594324567, 10294.948525257325, 10448.738781530523, 7542.245775422414, 8063.959680201561, 8211.95894020526, 8281.917180828115, 8436.789080272796, 8500.957495212484, 8575.571221438779, 8593.183647553473, 8622.61198246093, 8641.351898607756, 7457.515261507984, 7603.2776886195725, 7641.083070031409, 7661.731839385595, 7736.994190755166, 7384.667689953858, 7544.924550754422, 7597.354224890725, 7644.3120119187315, 7823.687052518063, 6843.418309443753, 6844.247132815486, 6875.621840798804, 6954.0, 6963.825904352431, 4993.400791904995, 5051.545360917535, 5074.3657042869645, 5160.303359046481, 5172.19830926207, 5218.55642270396, 5247.606429517878, 5326.25432439451, 5413.512783849473, 5437.945620543744], "value": 4570.918434690925, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.8310844577711, 337.92708151618604, 338.9966100338997, 344.78623253582765, 347.1408264545249, 5658.151277308406, 5679.602427830054, 5680.31836179658, 5689.4879460848515, 5735.308084115186, 5548.472895074971, 5562.721863906809, 5597.496225339719, 5601.719914004294, 5624.325080990277, 4167.6457501112445, 4269.466316710411, 4365.73393715822, 4383.934240986372, 4403.339499075132, 4354.847580334689, 4373.059792144688, 4376.737395756249, 4378.912421751563, 4384.430024096863, 4351.71713838601, 4352.434183556149, 4353.542877997812, 4373.890652733675, 4379.343098535213, 4279.186954478639, 4351.26028575143, 4354.455693038354, 4354.825806967718, 4357.453104148013, 3819.2743378758223, 3833.9808300958593, 3840.9231815363537, 3842.3083844907906, 3859.59474255202, 5403.351597808249, 5422.376426710939, 5425.9728701356635, 5432.429594892519, 5477.67133971963, 4834.7824347904425, 4950.603951683856, 4952.4057113146655, 5000.749812546864, 5054.671446355975, 5820.632151444407, 5824.155497452845, 5843.357230704619, 5845.912311315291, 5866.20806191163, 4197.601227883346, 4239.342901850187, 4240.448741663564, 4255.595718406777, 4256.957430425687, 5817.767289308423, 6141.662208578527, 6144.784932527385, 6150.938490615082, 6158.3841615838055, 4188.727732697365, 4204.621584057389, 4231.851885184004, 4240.257954857888, 4241.384999175164, 4254.936175957363, 4264.253755592759, 4290.0, 4299.398084268205, 4302.849400271038, 4728.4562275338085, 4863.756812159449, 4882.5605695487575, 4888.902221955541, 4935.259711043373, 5843.5909486336395, 5847.883042339129, 5855.941440585625, 5869.157944695643, 5873.295204575478, 1464.2971373740663, 1467.9339429725687, 1488.5459934719797, 1491.8209814822292, 1496.2743069611229, 940.3652534539295, 964.0118878149813, 1019.6278358399279, 1028.1209565821264, 1029.7683021320142, 5573.275474188411, 5606.495415412633, 5620.91568626471, 5629.8592535186945, 5691.373948865621, 6033.5474839387225, 6035.305939816977, 6055.72749226277, 6108.389161083945, 6132.448079672851, 5400.135978243541, 5491.972540137273, 5556.861078473071, 5565.5825813063375, 5585.609007369527, 3189.4418476766473, 3220.0, 3230.53157292196, 3245.9675403246138, 3265.559149514785, 6005.279366475964, 6133.877322453526, 6197.566170368031, 6299.244090709144, 6321.96839015802, 6046.2139921809885, 6074.392560743979, 6096.116063170904, 6100.267967843798, 6141.570090093651, 6038.728257228435, 6234.127222188898, 6283.748650054038, 6361.4592759615025, 6363.681815909186, 5897.466658668863, 5925.733341999534, 6042.607230530001, 6085.208922840003, 6124.418180272867, 5927.614705044159, 5990.88018239624, 6025.879482410415, 6029.427204415573, 6060.696965151813, 5992.610480318765, 6168.920438923081, 6202.2867370253, 6216.720247588779, 6336.3030066693545, 4211.768352740506, 4251.723637963522, 4262.893427664333, 4284.507281662524, 4294.527601963844, 5872.32638697969, 5968.612554978044, 5971.0, 6004.789832355847, 6023.096535519707, 5870.706464676664, 5914.34942156371, 5925.733341999534, 5933.940660593339, 5957.880842383215, 5671.6029877909805, 5834.766609335579, 5844.0, 5858.326292476419, 5867.20792692981, 5779.190913272061, 5791.698731722878, 5797.420257974169, 5804.6807425592, 5806.390329015392, 5945.940540594712, 5977.193078934288, 5977.820665380045, 6024.668643224665, 6044.123602077586, 5658.603897727119, 5831.241938548132, 5838.948989181988, 5853.94146058534, 5902.0], "value": 4471.787167325287, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.6866175184306, 837.3719710217337, 858.0689951402728, 862.262765335638, 877.6489404238308, 14876.256187190638, 14943.178125203109, 15439.768403473943, 15453.381864725425, 15456.072635641855, 14137.575872723835, 14137.717245655107, 14209.0, 14228.928855355734, 14249.572512824632, 684.1072400517323, 804.5816175588691, 815.4943934760457, 839.0518713853337, 839.2195258409677, 809.5668817182778, 813.7843471480063, 815.1237419773737, 815.3110621524802, 815.3477218225426, 862.3058437957442, 862.4178679391417, 865.3293697384546, 868.3053557154283, 868.5743985447117, 854.3848429131078, 858.2275951643509, 859.5315553023586, 859.9011113721939, 860.7848037990502, 624.2540164503421, 624.5160000999216, 626.1140486212005, 626.6616027345228, 627.3663599764226, 13114.0, 13147.14543554666, 13148.276844773629, 13149.408276627479, 13191.0, 14328.928355358157, 14348.49780257686, 14385.712285754227, 14397.352119154662, 14762.483313084098, 11442.56967879015, 11809.114316426303, 11818.586349477813, 11823.467943942458, 11846.0, 3814.5422549293985, 3836.731428799985, 3871.728978971473, 3961.7622942623534, 4002.679785617144, 57843.0, 57953.0, 58482.415175848124, 58754.0, 58852.41147588512, 11190.32858028521, 11441.599544015919, 11456.198066135457, 11515.424228788695, 12100.273983560839, 20373.083211255234, 20592.58814823695, 20623.175072996914, 20670.379888603366, 20726.274580389916, 8175.468594541336, 8386.496810191407, 8463.873041904377, 8582.957085214533, 8654.134586541422, 4476.6194873436125, 4530.411046563926, 4588.082383523309, 4671.995520963009, 4691.437027556715, 3324.434846076173, 3372.9712437706244, 3408.522806807049, 3418.077119177808, 3421.367047096295, 620.1503939602683, 628.4595248086641, 637.2926052082186, 641.0512441586478, 646.5474168082361, 621.6208113051035, 653.3923451190343, 692.9930700692928, 730.6054730445607, 751.7932568543695, 9740.95129524362, 9753.268504862164, 9794.853077203848, 9891.60433582663, 9920.553575089138, 749.5520605215963, 754.1515794730927, 755.4975940999174, 769.6690423118113, 774.0943096577018, 4496.550344965477, 4608.769561521911, 4624.861254162313, 4715.151272770934, 4744.3595114659765, 68478.31521684819, 69136.6543167291, 71090.0, 71857.0, 71908.28091719121, 62208.68895655493, 62219.0, 62658.68670656617, 63096.0, 65249.0, 57238.0, 57394.7130264346, 57699.71150144306, 59044.40955590475, 59359.0, 8615.353848461516, 8671.4363566368, 8721.694740684046, 8831.337649676429, 8920.197182253629, 37400.06499837526, 37461.250774983804, 37539.81230093832, 37782.0, 39273.214535709696, 48757.074575525585, 50272.0, 50721.49278507168, 50989.745051274505, 51207.23189152091, 11729.824052639047, 12197.512099516274, 12266.26402415858, 12666.556670516487, 12896.613101606967, 12902.290374029519, 13040.673983150118, 13146.40841162169, 13170.934145329213, 13624.0, 12245.816312755494, 12387.132900696864, 12454.0, 12464.314462704639, 12884.806727899277, 12123.636290911287, 12526.373681315716, 12650.936745316214, 12708.555200568306, 13137.277449740355, 10517.368957862553, 11755.764884702428, 12364.319962402154, 12540.184887982252, 12845.293508857103, 10213.591456341961, 10456.63401780934, 10591.364518128938, 10604.416757078126, 11233.157513186381, 10094.545745441326, 10352.223583231138, 10399.688009359732, 10416.947915260374, 10436.269461137648], "value": 6943.265356432394, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 109.0, 111.0, 112.0, 110.0, 110.0, 110.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 155.0, 190.0, 126.0, 155.0, 153.0, 137.0, 180.0, 129.0], "value": 150.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 161.0, 161.0, 163.0, 175.0, 176.0, 162.0, 164.0, 162.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 147.0, 75.0, 74.0, 74.0, 74.0, 159.0, 77.0], "value": 90.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 155.0, 93.0, 92.0, 92.0, 149.0, 91.0, 93.0, 157.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 116.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 147.0, 146.0, 147.0, 177.0, 147.0, 146.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 55.0, 56.0, 56.0, 56.0, 77.0, 54.0, 63.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 62.0, 62.0, 63.0, 62.0, 64.0, 63.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 78.0, 80.0, 79.0, 80.0, 78.0, 79.0, 78.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 120.0, 134.0, 120.0, 120.0, 126.0, 127.0, 118.0, 159.0, 124.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 168.0, 160.0, 160.0, 158.0, 163.0, 159.0, 158.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 64.0, 65.0, 62.0, 64.0, 61.0, 64.0], "value": 63.0, "unit": "score"}]}]} 01:26:57 INFO - Return code: 0 01:26:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:26:57 ERROR - # TBPL SUCCESS # 01:26:57 INFO - Running post-action listener: _resource_record_post_action 01:26:57 INFO - ##### 01:26:57 INFO - ##### Finished run-tests step (success) 01:26:57 INFO - ##### 01:26:57 INFO - Running post-run listener: _resource_record_post_run 01:26:57 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539881472; Read time: 8; Write time: 510072 01:26:57 INFO - TinderboxPrint: CPU usage
13.4% 01:26:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 01:26:57 INFO - TinderboxPrint: I/O write bytes / time
539,881,472 / 510,072 01:26:57 INFO - TinderboxPrint: CPU idle
8,227.1 (86.6%) 01:26:57 INFO - TinderboxPrint: CPU user
1,217.8 (12.8%) 01:26:57 INFO - TinderboxPrint: Swap in / out
0 / 0 01:26:57 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247238656; Read time: 0; Write time: 290332 01:26:57 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284266496; Read time: 8; Write time: 218708 01:26:57 INFO - Running post-run listener: _upload_blobber_files 01:26:57 INFO - Blob upload gear active. 01:26:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:26:57 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 01:26:57 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'] 01:26:57 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 01:26:58 INFO - (blobuploader) - INFO - Open directory for files ... 01:26:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:26:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:26:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:26:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:26:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:26:58 INFO - (blobuploader) - INFO - Done attempting. 01:26:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:26:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:26:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:27:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:27:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:27:03 INFO - (blobuploader) - INFO - Done attempting. 01:27:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:27:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:27:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:27:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:27:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:27:04 INFO - (blobuploader) - INFO - Done attempting. 01:27:04 INFO - (blobuploader) - INFO - Iteration through files over. 01:27:04 INFO - Return code: 0 01:27:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:27:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:27:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4e062943429a59b308cd8a0f108463ae0cff72b79671cd796293120248891b72ff08fb7566d0b086f5e61a0b7f1fbf004106335d57667abf916b7b86591df4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6457702d9c9aa9e10e4e1a75b954a2ea34367991257b37619df5fb2f18fbe410871cb0def6bfbdd22829196391018054d6e9e9d4e2268b22892542e29e9a14f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c2220f9efef63ccc769485d3bb7dc972b87bba3bdc240909a9aa89dc8695e461529c7cf4efd9b13f92cdc94d12f6ae5b8151eec5f352fb01549182c18bf12966"} 01:27:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:27:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:27:04 INFO - Contents: 01:27:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4e062943429a59b308cd8a0f108463ae0cff72b79671cd796293120248891b72ff08fb7566d0b086f5e61a0b7f1fbf004106335d57667abf916b7b86591df4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6457702d9c9aa9e10e4e1a75b954a2ea34367991257b37619df5fb2f18fbe410871cb0def6bfbdd22829196391018054d6e9e9d4e2268b22892542e29e9a14f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c2220f9efef63ccc769485d3bb7dc972b87bba3bdc240909a9aa89dc8695e461529c7cf4efd9b13f92cdc94d12f6ae5b8151eec5f352fb01549182c18bf12966"} 01:27:04 INFO - Running post-run listener: copy_logs_to_upload_dir 01:27:04 INFO - Copying logs to upload dir... 01:27:04 INFO - mkdir: /builds/slave/test/build/upload/logs 01:27:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.512042 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-24 01:27:04.390903) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 01:27:04.394103) ========= 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=a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4e062943429a59b308cd8a0f108463ae0cff72b79671cd796293120248891b72ff08fb7566d0b086f5e61a0b7f1fbf004106335d57667abf916b7b86591df4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6457702d9c9aa9e10e4e1a75b954a2ea34367991257b37619df5fb2f18fbe410871cb0def6bfbdd22829196391018054d6e9e9d4e2268b22892542e29e9a14f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c2220f9efef63ccc769485d3bb7dc972b87bba3bdc240909a9aa89dc8695e461529c7cf4efd9b13f92cdc94d12f6ae5b8151eec5f352fb01549182c18bf12966"} build_url:https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4e062943429a59b308cd8a0f108463ae0cff72b79671cd796293120248891b72ff08fb7566d0b086f5e61a0b7f1fbf004106335d57667abf916b7b86591df4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6457702d9c9aa9e10e4e1a75b954a2ea34367991257b37619df5fb2f18fbe410871cb0def6bfbdd22829196391018054d6e9e9d4e2268b22892542e29e9a14f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c2220f9efef63ccc769485d3bb7dc972b87bba3bdc240909a9aa89dc8695e461529c7cf4efd9b13f92cdc94d12f6ae5b8151eec5f352fb01549182c18bf12966"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 01:27:04.418672) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:27:04.419027) ========= 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=a0d2d2de893abaa8702a9954000001a7-1464077171.312116-475566468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:27:04.501641) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 01:27:04.501973) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 01:27:04.502263) ========= ========= Total master_lag: 0.18 =========