builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1464012648.93 results: success (0) buildid: 20160523043014 builduid: b62c6aac5bf143eabcbc637de749e5be revision: d3d23c5640717bfb9c72db8e951c462685991854 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 07:10:48.933278) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 07:10:48.933783) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 07:10:48.934082) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 07:10:48.990880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:10:48.991169) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 07:10:49-- 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% 65.2M=0s 2016-05-23 07:10:49 (65.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109569 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:10:49.114371) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:10:49.114730) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018451 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:10:49.164628) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:10:49.165007) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d3d23c5640717bfb9c72db8e951c462685991854 --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 d3d23c5640717bfb9c72db8e951c462685991854 --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=03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 07:10:49,614 truncating revision to first 12 chars 2016-05-23 07:10:49,614 Setting DEBUG logging. 2016-05-23 07:10:49,614 attempt 1/10 2016-05-23 07:10:49,614 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d3d23c564071?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 07:10:50,234 unpacking tar archive at: mozilla-inbound-d3d23c564071/testing/mozharness/ program finished with exit code 0 elapsedTime=0.895609 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:10:50.075012) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 07:10:50.075334) ========= script_repo_revision: d3d23c5640717bfb9c72db8e951c462685991854 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 07:10:50.075765) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 07:10:50.076038) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 07:10:50.087292) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2016-05-23 07:10:50.087581) ========= /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=03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:10:50 INFO - MultiFileLogger online at 20160523 07:10:50 in /builds/slave/test 07:10:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:10:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:10:50 INFO - {'append_to_log': False, 07:10:50 INFO - 'base_work_dir': '/builds/slave/test', 07:10:50 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:10:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:10:50 INFO - 'branch': 'Mozilla-Inbound', 07:10:50 INFO - 'buildbot_json_path': 'buildprops.json', 07:10:50 INFO - 'config_files': ('talos/linux_config.py',), 07:10:50 INFO - 'default_actions': ('clobber', 07:10:50 INFO - 'read-buildbot-config', 07:10:50 INFO - 'download-and-extract', 07:10:50 INFO - 'populate-webroot', 07:10:50 INFO - 'create-virtualenv', 07:10:50 INFO - 'install', 07:10:50 INFO - 'run-tests'), 07:10:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:10:50 INFO - 'download_minidump_stackwalk': True, 07:10:50 INFO - 'download_symbols': 'ondemand', 07:10:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:10:50 INFO - 'tooltool.py': '/tools/tooltool.py', 07:10:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:10:50 INFO - '/tools/misc-python/virtualenv.py')}, 07:10:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:10:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:10:50 INFO - 'installer_path': 'installer.exe', 07:10:50 INFO - 'log_level': 'info', 07:10:50 INFO - 'log_name': 'talos', 07:10:50 INFO - 'log_to_console': True, 07:10:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:10:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:10:50 INFO - 'opt_config_files': (), 07:10:50 INFO - 'pip_index': False, 07:10:50 INFO - 'sps_profile': False, 07:10:50 INFO - 'sps_profile_interval': 0, 07:10:50 INFO - 'suite': 'dromaeojs-e10s', 07:10:50 INFO - 'system_bits': '32', 07:10:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:10:50 INFO - 'title': 'talos-linux64-ix-047', 07:10:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:10:50 INFO - 'use_talos_json': True, 07:10:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:10:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:10:50 INFO - 'work_dir': 'build'} 07:10:50 INFO - ##### 07:10:50 INFO - ##### Running clobber step. 07:10:50 INFO - ##### 07:10:50 INFO - Running pre-action listener: _resource_record_pre_action 07:10:50 INFO - Running main action method: clobber 07:10:50 INFO - rmtree: /builds/slave/test/build 07:10:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:10:51 INFO - Running post-action listener: _resource_record_post_action 07:10:51 INFO - ##### 07:10:51 INFO - ##### Finished clobber step (success) 07:10:51 INFO - ##### 07:10:51 INFO - ##### 07:10:51 INFO - ##### Running read-buildbot-config step. 07:10:51 INFO - ##### 07:10:51 INFO - Running pre-action listener: _resource_record_pre_action 07:10:51 INFO - Running main action method: read_buildbot_config 07:10:51 INFO - Using buildbot properties: 07:10:51 INFO - { 07:10:51 INFO - "project": "", 07:10:51 INFO - "product": "firefox", 07:10:51 INFO - "script_repo_revision": "production", 07:10:51 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:10:51 INFO - "repository": "", 07:10:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:10:51 INFO - "buildid": "20160523043014", 07:10:51 INFO - "pgo_build": "True", 07:10:51 INFO - "basedir": "/builds/slave/test", 07:10:51 INFO - "buildnumber": 1058, 07:10:51 INFO - "slavename": "talos-linux64-ix-047", 07:10:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:10:51 INFO - "platform": "ubuntu64_hw", 07:10:51 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:10:51 INFO - "branch": "mozilla-inbound", 07:10:51 INFO - "repo_path": "integration/mozilla-inbound", 07:10:51 INFO - "revision": "d3d23c5640717bfb9c72db8e951c462685991854", 07:10:51 INFO - "stage_platform": "linux64-pgo", 07:10:51 INFO - "builduid": "b62c6aac5bf143eabcbc637de749e5be", 07:10:51 INFO - "slavebuilddir": "test" 07:10:51 INFO - } 07:10:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:10:51 INFO - Running post-action listener: _resource_record_post_action 07:10:51 INFO - ##### 07:10:51 INFO - ##### Finished read-buildbot-config step (success) 07:10:51 INFO - ##### 07:10:51 INFO - ##### 07:10:51 INFO - ##### Running download-and-extract step. 07:10:51 INFO - ##### 07:10:51 INFO - Running pre-action listener: _resource_record_pre_action 07:10:51 INFO - Running main action method: download_and_extract 07:10:51 INFO - mkdir: /builds/slave/test/build/tests 07:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:51 INFO - https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:10:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:10:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:10:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/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 07:10:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/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 07:10:56 INFO - Downloaded 1361 bytes. 07:10:56 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:10:56 INFO - Using the following test package requirements: 07:10:56 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:10:56 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:10:56 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:10:56 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:56 INFO - u'jsshell-linux-x86_64.zip'], 07:10:56 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:10:56 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:10:56 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:10:56 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:10:56 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:10:56 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:10:56 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:10: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')]} 07:10:56 INFO - https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:10:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:10:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:10:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/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 07:10:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/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 07:10:58 INFO - Downloaded 24412482 bytes. 07:10:58 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'] 07:10:58 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 07:11:00 INFO - Return code: 0 07:11:00 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 07:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:00 INFO - https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:11:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:11:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:11:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/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 07:11:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/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 07:11:01 INFO - Downloaded 24412482 bytes. 07:11:01 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'] 07:11:01 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 07:11:03 INFO - Return code: 0 07:11: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')]} 07:11:03 INFO - https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:11:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:11:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:11:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/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 07:11:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/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 07:11:04 INFO - Downloaded 10840359 bytes. 07:11:04 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'] 07:11:04 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 07:11:04 INFO - Return code: 0 07:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:04 INFO - https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:11:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:11:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:11:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/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 07:11:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/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 07:11:06 INFO - Downloaded 58615786 bytes. 07:11:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:11:06 INFO - mkdir: /builds/slave/test/properties 07:11:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:11:06 INFO - Writing to file /builds/slave/test/properties/build_url 07:11:06 INFO - Contents: 07:11:06 INFO - build_url:https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:11:06 INFO - Running post-action listener: _resource_record_post_action 07:11:06 INFO - Running post-action listener: set_extra_try_arguments 07:11:06 INFO - ##### 07:11:06 INFO - ##### Finished download-and-extract step (success) 07:11:06 INFO - ##### 07:11:06 INFO - ##### 07:11:06 INFO - ##### Running populate-webroot step. 07:11:06 INFO - ##### 07:11:06 INFO - Running pre-action listener: _resource_record_pre_action 07:11:06 INFO - Running main action method: populate_webroot 07:11:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:11:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:11:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:11:06 INFO - '--tppagecycles', 07:11:06 INFO - '7'], 07:11:06 INFO - 'tests': ['tsvgm']}}, 07:11:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:11:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:11:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:11:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:11:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:11:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:11:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:06 INFO - 'talos_options': ['--disable-e10s'], 07:11:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:06 INFO - 'talos_options': ['--disable-e10s'], 07:11:06 INFO - 'tests': ['damp', 'tps']}, 07:11:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:06 INFO - 'tests': ['damp', 'tps']}, 07:11:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:11:06 INFO - 'tests': ['dromaeo_dom']}, 07:11:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:11:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:11:06 INFO - 'tests': ['a11yr', 07:11:06 INFO - 'ts_paint', 07:11:06 INFO - 'tpaint', 07:11:06 INFO - 'sessionrestore', 07:11:06 INFO - 'sessionrestore_no_auto_restore', 07:11:06 INFO - 'tabpaint']}, 07:11:06 INFO - 'other-e10s': {'tests': ['a11yr', 07:11:06 INFO - 'ts_paint', 07:11:06 INFO - 'tpaint', 07:11:06 INFO - 'sessionrestore', 07:11:06 INFO - 'sessionrestore_no_auto_restore', 07:11:06 INFO - 'tabpaint']}, 07:11:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:11:06 INFO - 'ts_paint', 07:11:06 INFO - 'tpaint', 07:11:06 INFO - 'sessionrestore', 07:11:06 INFO - 'sessionrestore_no_auto_restore', 07:11:06 INFO - 'tabpaint']}, 07:11:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:11:06 INFO - 'ts_paint', 07:11:06 INFO - 'tpaint', 07:11:06 INFO - 'sessionrestore', 07:11:06 INFO - 'sessionrestore_no_auto_restore', 07:11:06 INFO - 'tabpaint']}, 07:11:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:11:06 INFO - 'tests': ['a11yr', 07:11:06 INFO - 'ts_paint', 07:11:06 INFO - 'tpaint', 07:11:06 INFO - 'sessionrestore', 07:11:06 INFO - 'sessionrestore_no_auto_restore', 07:11:06 INFO - 'tabpaint']}, 07:11:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:11:06 INFO - 'tests': ['a11yr', 07:11:06 INFO - 'ts_paint', 07:11:06 INFO - 'tpaint', 07:11:06 INFO - 'sessionrestore', 07:11:06 INFO - 'sessionrestore_no_auto_restore', 07:11:06 INFO - 'tabpaint']}, 07:11:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:11:06 INFO - 'tests': ['tsvgx', 07:11:06 INFO - 'tsvgr_opacity', 07:11:06 INFO - 'tart', 07:11:06 INFO - 'tscrollx', 07:11:06 INFO - 'cart']}, 07:11:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:11:06 INFO - 'tsvgr_opacity', 07:11:06 INFO - 'tart', 07:11:06 INFO - 'tscrollx', 07:11:06 INFO - 'cart']}, 07:11:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:06 INFO - 'talos_options': ['--disable-e10s'], 07:11:06 INFO - 'tests': ['tp5o']}, 07:11:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:06 INFO - 'tests': ['tp5o']}, 07:11:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:06 INFO - 'talos_options': ['--disable-e10s', 07:11:06 INFO - '--xperf_path', 07:11:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:06 INFO - 'tests': ['tp5n']}, 07:11:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:06 INFO - 'talos_options': ['--xperf_path', 07:11:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:06 INFO - 'tests': ['tp5n']}}, 07:11:06 INFO - 'talos.zip': {'path': '', 07:11:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:11:06 INFO - Running post-action listener: _resource_record_post_action 07:11:06 INFO - ##### 07:11:06 INFO - ##### Finished populate-webroot step (success) 07:11:06 INFO - ##### 07:11:06 INFO - ##### 07:11:06 INFO - ##### Running create-virtualenv step. 07:11:06 INFO - ##### 07:11:06 INFO - Running pre-action listener: _resource_record_pre_action 07:11:06 INFO - Running main action method: create_virtualenv 07:11:06 INFO - Creating virtualenv /builds/slave/test/build/venv 07:11:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:11:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:11:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:11:07 INFO - Using real prefix '/usr' 07:11:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:11:07 INFO - Installing distribute.............................................................................................................................................................................................done. 07:11:09 INFO - Installing pip.................done. 07:11:09 INFO - Return code: 0 07:11:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:09 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 0x7f82d86c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2618770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a79c0>, '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 0x26a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:11:09 INFO - Using env: {'DISPLAY': ':0', 07:11:09 INFO - 'HOME': '/home/cltbld', 07:11:09 INFO - 'LANG': 'en_US.UTF-8', 07:11:09 INFO - 'LANGUAGE': 'en_US:en', 07:11:09 INFO - 'LOGNAME': 'cltbld', 07:11:09 INFO - 'MAIL': '/var/mail/cltbld', 07:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:09 INFO - 'MOZ_NO_REMOTE': '1', 07:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:09 INFO - 'NO_EM_RESTART': '1', 07:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:09 INFO - 'PWD': '/builds/slave/test', 07:11:09 INFO - 'SHELL': '/bin/bash', 07:11:09 INFO - 'SHLVL': '1', 07:11:09 INFO - 'TERM': 'linux', 07:11:09 INFO - 'TMOUT': '86400', 07:11:09 INFO - 'USER': 'cltbld', 07:11:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 07:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:09 INFO - '_': '/tools/buildbot/bin/python'} 07:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:11:09 INFO - Cleaning up... 07:11:09 INFO - Return code: 0 07:11:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:09 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 0x7f82d86c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2618770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a79c0>, '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 0x26a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:11:09 INFO - Using env: {'DISPLAY': ':0', 07:11:09 INFO - 'HOME': '/home/cltbld', 07:11:09 INFO - 'LANG': 'en_US.UTF-8', 07:11:09 INFO - 'LANGUAGE': 'en_US:en', 07:11:09 INFO - 'LOGNAME': 'cltbld', 07:11:09 INFO - 'MAIL': '/var/mail/cltbld', 07:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:09 INFO - 'MOZ_NO_REMOTE': '1', 07:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:09 INFO - 'NO_EM_RESTART': '1', 07:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:09 INFO - 'PWD': '/builds/slave/test', 07:11:09 INFO - 'SHELL': '/bin/bash', 07:11:09 INFO - 'SHLVL': '1', 07:11:09 INFO - 'TERM': 'linux', 07:11:09 INFO - 'TMOUT': '86400', 07:11:09 INFO - 'USER': 'cltbld', 07:11:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 07:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:09 INFO - '_': '/tools/buildbot/bin/python'} 07:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:09 INFO - Downloading/unpacking psutil>=3.1.1 07:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:11:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:11:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:11:11 INFO - Installing collected packages: psutil 07:11:11 INFO - Running setup.py install for psutil 07:11:11 INFO - building 'psutil._psutil_linux' extension 07:11:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:11:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:11:12 INFO - building 'psutil._psutil_posix' extension 07:11:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:11:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:11:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:11:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:11:12 INFO - Successfully installed psutil 07:11:12 INFO - Cleaning up... 07:11:12 INFO - Return code: 0 07:11:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:12 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 0x7f82d86c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2618770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a79c0>, '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 0x26a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:11:12 INFO - Using env: {'DISPLAY': ':0', 07:11:12 INFO - 'HOME': '/home/cltbld', 07:11:12 INFO - 'LANG': 'en_US.UTF-8', 07:11:12 INFO - 'LANGUAGE': 'en_US:en', 07:11:12 INFO - 'LOGNAME': 'cltbld', 07:11:12 INFO - 'MAIL': '/var/mail/cltbld', 07:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:12 INFO - 'MOZ_NO_REMOTE': '1', 07:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:12 INFO - 'NO_EM_RESTART': '1', 07:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:12 INFO - 'PWD': '/builds/slave/test', 07:11:12 INFO - 'SHELL': '/bin/bash', 07:11:12 INFO - 'SHLVL': '1', 07:11:12 INFO - 'TERM': 'linux', 07:11:12 INFO - 'TMOUT': '86400', 07:11:12 INFO - 'USER': 'cltbld', 07:11:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 07:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:12 INFO - '_': '/tools/buildbot/bin/python'} 07:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:11:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:11:14 INFO - Installing collected packages: mozsystemmonitor 07:11:14 INFO - Running setup.py install for mozsystemmonitor 07:11:14 INFO - Successfully installed mozsystemmonitor 07:11:14 INFO - Cleaning up... 07:11:14 INFO - Return code: 0 07:11:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:11: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')]} 07:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11: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')]} 07:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:14 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 0x7f82d86c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2618770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a79c0>, '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 0x26a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:11:14 INFO - Using env: {'DISPLAY': ':0', 07:11:14 INFO - 'HOME': '/home/cltbld', 07:11:14 INFO - 'LANG': 'en_US.UTF-8', 07:11:14 INFO - 'LANGUAGE': 'en_US:en', 07:11:14 INFO - 'LOGNAME': 'cltbld', 07:11:14 INFO - 'MAIL': '/var/mail/cltbld', 07:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:14 INFO - 'MOZ_NO_REMOTE': '1', 07:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:14 INFO - 'NO_EM_RESTART': '1', 07:11:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:14 INFO - 'PWD': '/builds/slave/test', 07:11:14 INFO - 'SHELL': '/bin/bash', 07:11:14 INFO - 'SHLVL': '1', 07:11:14 INFO - 'TERM': 'linux', 07:11:14 INFO - 'TMOUT': '86400', 07:11:14 INFO - 'USER': 'cltbld', 07:11:14 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 07:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:14 INFO - '_': '/tools/buildbot/bin/python'} 07:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:14 INFO - Downloading/unpacking blobuploader==1.2.4 07:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:16 INFO - Downloading blobuploader-1.2.4.tar.gz 07:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:11:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:11:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:17 INFO - Downloading docopt-0.6.1.tar.gz 07:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:11:17 INFO - Installing collected packages: blobuploader, requests, docopt 07:11:17 INFO - Running setup.py install for blobuploader 07:11:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:11:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:11:17 INFO - Running setup.py install for requests 07:11:18 INFO - Running setup.py install for docopt 07:11:18 INFO - Successfully installed blobuploader requests docopt 07:11:18 INFO - Cleaning up... 07:11:18 INFO - Return code: 0 07:11:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:18 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 0x7f82d86c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2618770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a79c0>, '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 0x26a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:11:18 INFO - Using env: {'DISPLAY': ':0', 07:11:18 INFO - 'HOME': '/home/cltbld', 07:11:18 INFO - 'LANG': 'en_US.UTF-8', 07:11:18 INFO - 'LANGUAGE': 'en_US:en', 07:11:18 INFO - 'LOGNAME': 'cltbld', 07:11:18 INFO - 'MAIL': '/var/mail/cltbld', 07:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:18 INFO - 'MOZ_NO_REMOTE': '1', 07:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:18 INFO - 'NO_EM_RESTART': '1', 07:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:18 INFO - 'PWD': '/builds/slave/test', 07:11:18 INFO - 'SHELL': '/bin/bash', 07:11:18 INFO - 'SHLVL': '1', 07:11:18 INFO - 'TERM': 'linux', 07:11:18 INFO - 'TMOUT': '86400', 07:11:18 INFO - 'USER': 'cltbld', 07:11:18 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 07:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:18 INFO - '_': '/tools/buildbot/bin/python'} 07:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:11:18 INFO - Running setup.py (path:/tmp/pip-nfVcrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:11:18 INFO - Running setup.py (path:/tmp/pip-JKzj1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:11:18 INFO - Running setup.py (path:/tmp/pip-af80pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:11:18 INFO - Running setup.py (path:/tmp/pip-l9tACB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:11:18 INFO - Running setup.py (path:/tmp/pip-Pt8yGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:11:18 INFO - Running setup.py (path:/tmp/pip-T1xTpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:11:18 INFO - Running setup.py (path:/tmp/pip-Pf72jX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:11:19 INFO - Running setup.py (path:/tmp/pip-DuShoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:11:19 INFO - Running setup.py (path:/tmp/pip-CZF9bS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:11:19 INFO - Running setup.py (path:/tmp/pip-SrK8Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:11:19 INFO - Running setup.py (path:/tmp/pip-GEHTdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:11:19 INFO - Running setup.py (path:/tmp/pip-dFv_3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:11:19 INFO - Running setup.py (path:/tmp/pip-1aUAel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:11:19 INFO - Running setup.py (path:/tmp/pip-Xx0OHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:19 INFO - Running setup.py (path:/tmp/pip-vo1Oc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:11:19 INFO - Running setup.py (path:/tmp/pip-6ISrLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:11:19 INFO - Running setup.py (path:/tmp/pip-H4W40r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:11:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:11:19 INFO - Running setup.py install for manifestparser 07:11:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:11:19 INFO - Running setup.py install for mozcrash 07:11:19 INFO - Running setup.py install for mozdebug 07:11:20 INFO - Running setup.py install for mozdevice 07:11:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:11:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:11:20 INFO - Running setup.py install for mozfile 07:11:20 INFO - Running setup.py install for mozhttpd 07:11:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:11:20 INFO - Running setup.py install for mozinfo 07:11:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:11:20 INFO - Running setup.py install for mozInstall 07:11:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:11:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:11:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:11:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:11:20 INFO - Running setup.py install for mozleak 07:11:20 INFO - Running setup.py install for mozlog 07:11:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:11:20 INFO - Running setup.py install for moznetwork 07:11:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:11:20 INFO - Running setup.py install for mozprocess 07:11:21 INFO - Running setup.py install for mozprofile 07:11:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:11:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:11:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:11:21 INFO - Running setup.py install for mozrunner 07:11:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:11:21 INFO - Running setup.py install for mozscreenshot 07:11:21 INFO - Running setup.py install for moztest 07:11:21 INFO - Running setup.py install for mozversion 07:11:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:11:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:11:21 INFO - Cleaning up... 07:11:21 INFO - Return code: 0 07:11:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:21 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 0x7f82d86c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2618770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a79c0>, '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 0x26a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:11:21 INFO - Using env: {'DISPLAY': ':0', 07:11:21 INFO - 'HOME': '/home/cltbld', 07:11:21 INFO - 'LANG': 'en_US.UTF-8', 07:11:21 INFO - 'LANGUAGE': 'en_US:en', 07:11:21 INFO - 'LOGNAME': 'cltbld', 07:11:21 INFO - 'MAIL': '/var/mail/cltbld', 07:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:21 INFO - 'MOZ_NO_REMOTE': '1', 07:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:21 INFO - 'NO_EM_RESTART': '1', 07:11:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:21 INFO - 'PWD': '/builds/slave/test', 07:11:21 INFO - 'SHELL': '/bin/bash', 07:11:21 INFO - 'SHLVL': '1', 07:11:21 INFO - 'TERM': 'linux', 07:11:21 INFO - 'TMOUT': '86400', 07:11:21 INFO - 'USER': 'cltbld', 07:11:21 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 07:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:21 INFO - '_': '/tools/buildbot/bin/python'} 07:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:11:21 INFO - Running setup.py (path:/tmp/pip-HNoRaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:11:21 INFO - Running setup.py (path:/tmp/pip-yKnkJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:11:21 INFO - Running setup.py (path:/tmp/pip-epX4dT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:11:22 INFO - Running setup.py (path:/tmp/pip-G_M4iN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:11:22 INFO - Running setup.py (path:/tmp/pip-zlJBjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:11:22 INFO - Running setup.py (path:/tmp/pip-y_neeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:11:22 INFO - Running setup.py (path:/tmp/pip-LIUGHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:11:22 INFO - Running setup.py (path:/tmp/pip-4XQL2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:11:22 INFO - Running setup.py (path:/tmp/pip-wkEjny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:11:22 INFO - Running setup.py (path:/tmp/pip-5zTCWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:11:22 INFO - Running setup.py (path:/tmp/pip-SsdFDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:11:22 INFO - Running setup.py (path:/tmp/pip-bAWXYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:11:22 INFO - Running setup.py (path:/tmp/pip-wU5usI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:11:22 INFO - Running setup.py (path:/tmp/pip-9Jus3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:22 INFO - Running setup.py (path:/tmp/pip-6rUIbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:11:22 INFO - Running setup.py (path:/tmp/pip-eHSbrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:11:22 INFO - Running setup.py (path:/tmp/pip-aWuM1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:11:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:24 INFO - Downloading blessings-1.6.tar.gz 07:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:11:25 INFO - Installing collected packages: blessings 07:11:25 INFO - Running setup.py install for blessings 07:11:25 INFO - Successfully installed blessings 07:11:25 INFO - Cleaning up... 07:11:25 INFO - Return code: 0 07:11:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:11:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:11:25 INFO - Reading from file tmpfile_stdout 07:11:25 INFO - Current package versions: 07:11:25 INFO - argparse == 1.2.1 07:11:25 INFO - blessings == 1.6 07:11:25 INFO - blobuploader == 1.2.4 07:11:25 INFO - docopt == 0.6.1 07:11:25 INFO - manifestparser == 1.1 07:11:25 INFO - mozInstall == 1.12 07:11:25 INFO - mozcrash == 0.17 07:11:25 INFO - mozdebug == 0.1 07:11:25 INFO - mozdevice == 0.48 07:11:25 INFO - mozfile == 1.2 07:11:25 INFO - mozhttpd == 0.7 07:11:25 INFO - mozinfo == 0.9 07:11:25 INFO - mozleak == 0.1 07:11:25 INFO - mozlog == 3.2 07:11:25 INFO - moznetwork == 0.27 07:11:25 INFO - mozprocess == 0.22 07:11:25 INFO - mozprofile == 0.28 07:11:25 INFO - mozrunner == 6.11 07:11:25 INFO - mozscreenshot == 0.1 07:11:25 INFO - mozsystemmonitor == 0.3 07:11:25 INFO - moztest == 0.7 07:11:25 INFO - mozversion == 1.4 07:11:25 INFO - psutil == 3.1.1 07:11:25 INFO - requests == 1.2.3 07:11:25 INFO - wsgiref == 0.1.2 07:11:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:25 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 0x7f82d86c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2618770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a79c0>, '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 0x26a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:11:25 INFO - Using env: {'DISPLAY': ':0', 07:11:25 INFO - 'HOME': '/home/cltbld', 07:11:25 INFO - 'LANG': 'en_US.UTF-8', 07:11:25 INFO - 'LANGUAGE': 'en_US:en', 07:11:25 INFO - 'LOGNAME': 'cltbld', 07:11:25 INFO - 'MAIL': '/var/mail/cltbld', 07:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:25 INFO - 'MOZ_NO_REMOTE': '1', 07:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:25 INFO - 'NO_EM_RESTART': '1', 07:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:25 INFO - 'PWD': '/builds/slave/test', 07:11:25 INFO - 'SHELL': '/bin/bash', 07:11:25 INFO - 'SHLVL': '1', 07:11:25 INFO - 'TERM': 'linux', 07:11:25 INFO - 'TMOUT': '86400', 07:11:25 INFO - 'USER': 'cltbld', 07:11:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 07:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:25 INFO - '_': '/tools/buildbot/bin/python'} 07:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:11:25 INFO - Cleaning up... 07:11:25 INFO - Return code: 0 07:11:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:25 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 0x7f82d86c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2618770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a79c0>, '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 0x26a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:11:25 INFO - Using env: {'DISPLAY': ':0', 07:11:25 INFO - 'HOME': '/home/cltbld', 07:11:25 INFO - 'LANG': 'en_US.UTF-8', 07:11:25 INFO - 'LANGUAGE': 'en_US:en', 07:11:25 INFO - 'LOGNAME': 'cltbld', 07:11:25 INFO - 'MAIL': '/var/mail/cltbld', 07:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:25 INFO - 'MOZ_NO_REMOTE': '1', 07:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:25 INFO - 'NO_EM_RESTART': '1', 07:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:25 INFO - 'PWD': '/builds/slave/test', 07:11:25 INFO - 'SHELL': '/bin/bash', 07:11:25 INFO - 'SHLVL': '1', 07:11:25 INFO - 'TERM': 'linux', 07:11:25 INFO - 'TMOUT': '86400', 07:11:25 INFO - 'USER': 'cltbld', 07:11:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 07:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:25 INFO - '_': '/tools/buildbot/bin/python'} 07:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:25 INFO - Downloading/unpacking jsonschema 07:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:11:27 INFO - Downloading/unpacking functools32 (from jsonschema) 07:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:27 INFO - Downloading functools32-3.2.3-2.tar.gz 07:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:11:27 INFO - warning: no files found matching '*.txt' 07:11:27 INFO - no previously-included directories found matching 'build' 07:11:27 INFO - no previously-included directories found matching 'dist' 07:11:27 INFO - no previously-included directories found matching '.git*' 07:11:27 INFO - Installing collected packages: jsonschema, functools32 07:11:28 INFO - Running setup.py install for functools32 07:11:28 INFO - warning: no files found matching '*.txt' 07:11:28 INFO - no previously-included directories found matching 'build' 07:11:28 INFO - no previously-included directories found matching 'dist' 07:11:28 INFO - no previously-included directories found matching '.git*' 07:11:28 INFO - Successfully installed jsonschema functools32 07:11:28 INFO - Cleaning up... 07:11:28 INFO - Return code: 0 07:11:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:28 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 0x7f82d86c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2618770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a79c0>, '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 0x26a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8d50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:11:28 INFO - Using env: {'DISPLAY': ':0', 07:11:28 INFO - 'HOME': '/home/cltbld', 07:11:28 INFO - 'LANG': 'en_US.UTF-8', 07:11:28 INFO - 'LANGUAGE': 'en_US:en', 07:11:28 INFO - 'LOGNAME': 'cltbld', 07:11:28 INFO - 'MAIL': '/var/mail/cltbld', 07:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:28 INFO - 'MOZ_NO_REMOTE': '1', 07:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:28 INFO - 'NO_EM_RESTART': '1', 07:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:28 INFO - 'PWD': '/builds/slave/test', 07:11:28 INFO - 'SHELL': '/bin/bash', 07:11:28 INFO - 'SHLVL': '1', 07:11:28 INFO - 'TERM': 'linux', 07:11:28 INFO - 'TMOUT': '86400', 07:11:28 INFO - 'USER': 'cltbld', 07:11:28 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 07:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:28 INFO - '_': '/tools/buildbot/bin/python'} 07:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:28 INFO - Downloading/unpacking flake8 07:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:11:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:11:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:11:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:11:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:11:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:11:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:11:30 INFO - no previously-included directories found matching 'docs/_build' 07:11:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:11:31 INFO - Running setup.py install for pep8 07:11:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:11:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:11:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:11:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:11:31 INFO - no previously-included directories found matching 'docs/_build' 07:11:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:11:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:11:31 INFO - Cleaning up... 07:11:31 INFO - Return code: 0 07:11:31 INFO - Running post-action listener: _resource_record_post_action 07:11:31 INFO - Running post-action listener: _start_resource_monitoring 07:11:31 INFO - Starting resource monitoring. 07:11:31 INFO - ##### 07:11:31 INFO - ##### Finished create-virtualenv step (success) 07:11:31 INFO - ##### 07:11:31 INFO - ##### 07:11:31 INFO - ##### Running install step. 07:11:31 INFO - ##### 07:11:31 INFO - Running pre-action listener: _resource_record_pre_action 07:11:31 INFO - Running main action method: install 07:11:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:11:31 INFO - Reading from file tmpfile_stdout 07:11:31 INFO - Detecting whether we're running mozinstall >=1.0... 07:11:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:11:31 INFO - Reading from file tmpfile_stdout 07:11:31 INFO - Output received: 07:11:31 INFO - Usage: mozinstall [options] installer 07:11:31 INFO - Options: 07:11:31 INFO - -h, --help show this help message and exit 07:11:31 INFO - -d DEST, --destination=DEST 07:11:31 INFO - Directory to install application into. [default: 07:11:31 INFO - "/builds/slave/test"] 07:11:31 INFO - --app=APP Application being installed. [default: firefox] 07:11:31 INFO - mkdir: /builds/slave/test/build/application 07:11:31 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'] 07:11:31 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 07:11:48 INFO - Reading from file tmpfile_stdout 07:11:48 INFO - Output received: 07:11:48 INFO - /builds/slave/test/build/application/firefox/firefox 07:11:48 INFO - Running post-action listener: _resource_record_post_action 07:11:48 INFO - ##### 07:11:48 INFO - ##### Finished install step (success) 07:11:48 INFO - ##### 07:11:48 INFO - ##### 07:11:48 INFO - ##### Running run-tests step. 07:11:48 INFO - ##### 07:11:48 INFO - Running pre-action listener: _resource_record_pre_action 07:11:48 INFO - Running main action method: run_tests 07:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:11:48 INFO - Python 2.7.3 07:11:48 INFO - Return code: 0 07:11:48 INFO - grabbing minidump binary from tooltool 07:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:48 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 0x26a79c0>, '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 0x26a88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a8d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:11:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:11:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:11:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:11:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:11:48 INFO - Return code: 0 07:11:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:11:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:11:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:11:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:11:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:11:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:11:49 INFO - Return code: 0 07:11:49 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/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:11:49 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/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:11:49 INFO - Using env: {'DISPLAY': ':0', 07:11:49 INFO - 'HOME': '/home/cltbld', 07:11:49 INFO - 'LANG': 'en_US.UTF-8', 07:11:49 INFO - 'LANGUAGE': 'en_US:en', 07:11:49 INFO - 'LOGNAME': 'cltbld', 07:11:49 INFO - 'MAIL': '/var/mail/cltbld', 07:11:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:11:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:49 INFO - 'MOZ_NO_REMOTE': '1', 07:11:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:49 INFO - 'NO_EM_RESTART': '1', 07:11:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:49 INFO - 'PWD': '/builds/slave/test', 07:11:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:11:49 INFO - 'SHELL': '/bin/bash', 07:11:49 INFO - 'SHLVL': '1', 07:11:49 INFO - 'TERM': 'linux', 07:11:49 INFO - 'TMOUT': '86400', 07:11:49 INFO - 'USER': 'cltbld', 07:11:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116', 07:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:49 INFO - '_': '/tools/buildbot/bin/python'} 07:11:49 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/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:11:49 INFO - mozversion application_buildid: 20160523043014 07:11:49 INFO - mozversion application_changeset: d3d23c5640717bfb9c72db8e951c462685991854 07:11:49 INFO - mozversion application_display_name: Nightly 07:11:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:11:49 INFO - mozversion application_name: Firefox 07:11:49 INFO - mozversion application_remotingname: firefox 07:11:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:11:49 INFO - mozversion application_vendor: Mozilla 07:11:49 INFO - mozversion application_version: 49.0a1 07:11:49 INFO - mozversion platform_buildid: 20160523043014 07:11:49 INFO - mozversion platform_changeset: d3d23c5640717bfb9c72db8e951c462685991854 07:11:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:11:49 INFO - mozversion platform_version: 49.0a1 07:11:49 INFO - using testdate: 1464012709 07:11:49 INFO - actual date: 1464012709 07:11:49 INFO - starting webserver on 'localhost:51615' 07:11:49 INFO - SUITE-START | Running 2 tests 07:11:49 INFO - TEST-START | dromaeo_css 07:11:49 INFO - operating with platform_type : linux_ 07:11:49 INFO - Initialising browser for dromaeo_css test... 07:11:49 INFO - TEST-INFO | started process 22303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAfsKrb/profile http://localhost:51615/getInfo.html) 07:11:53 INFO - PROCESS | 22303 | 07:11:53 INFO - PROCESS | 22303 | (process:22371): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:11:54 INFO - PROCESS | 22303 | __metrics Screen width/height:1600/1200 07:11:54 INFO - PROCESS | 22303 | colorDepth:24 07:11:54 INFO - PROCESS | 22303 | Browser inner width/height: 1024/697 07:11:54 INFO - PROCESS | 22303 | __metrics 07:11:54 ERROR - PROCESS | 22303 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 07:11:55 INFO - TEST-INFO | 22303: exit 0 07:11:55 INFO - Browser initialized. 07:11:55 INFO - Running cycle 1/1 for dromaeo_css test... 07:11:55 INFO - TEST-INFO | started process 22422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAfsKrb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:57 INFO - PROCESS | 22422 | 07:11:57 INFO - PROCESS | 22422 | (process:22482): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:12:07 INFO - PROCESS | 22422 | RSS: Main: 163946496 07:12:07 INFO - PROCESS | 22422 | 07:12:57 INFO - PROCESS | 22422 | 1464012777104 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:15:04 INFO - PROCESS | 22422 | Cycle 1(1): loaded http://localhost:51615/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51615/tests/dromaeo/cssquery-ext.html) 07:15:05 INFO - PROCESS | 22422 | RSS: Main: 167112704 07:15:05 INFO - PROCESS | 22422 | 07:18:07 INFO - PROCESS | 22422 | Cycle 1(1): loaded http://localhost:51615/tests/dromaeo/cssquery-ext.html (next: http://localhost:51615/tests/dromaeo/cssquery-jquery.html) 07:18:08 INFO - PROCESS | 22422 | RSS: Main: 167272448 07:18:08 INFO - PROCESS | 22422 | 07:21:09 INFO - PROCESS | 22422 | Cycle 1(1): loaded http://localhost:51615/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51615/tests/dromaeo/cssquery-mootools.html) 07:21:10 INFO - PROCESS | 22422 | RSS: Main: 167809024 07:21:10 INFO - PROCESS | 22422 | 07:24:12 INFO - PROCESS | 22422 | Cycle 1(1): loaded http://localhost:51615/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51615/tests/dromaeo/cssquery-prototype.html) 07:24:12 INFO - PROCESS | 22422 | RSS: Main: 165457920 07:24:12 INFO - PROCESS | 22422 | 07:27:15 INFO - PROCESS | 22422 | Cycle 1(1): loaded http://localhost:51615/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51615/tests/dromaeo/cssquery-yui.html) 07:27:16 INFO - PROCESS | 22422 | RSS: Main: 166887424 07:27:16 INFO - PROCESS | 22422 | 07:30:18 INFO - PROCESS | 22422 | Cycle 1(1): loaded http://localhost:51615/tests/dromaeo/cssquery-yui.html (next: http://localhost:51615/tests/dromaeo/cssquery-dojo.html) 07:30:18 INFO - PROCESS | 22422 | RSS: Main: 168628224 07:30:18 INFO - PROCESS | 22422 | 07:30:18 INFO - PROCESS | 22422 | __start_tp_report 07:30:18 INFO - PROCESS | 22422 | _x_x_mozilla_page_load 07:30:18 INFO - PROCESS | 22422 | _x_x_mozilla_page_load_details 07:30:18 INFO - PROCESS | 22422 | |i|pagename|runs| 07:30:18 INFO - PROCESS | 22422 | |0;dojo.html;3093.597832281803;3129.467990441625;3141.0419821954297;3142.6228852537697;3147.166001009732;5284.365876094869;5288.338957630296;5334.333208348957;5368.0605893968495;5397.514223719864;5285.709285989269;5344.866378340534;5378;5390.245365648802;5407.351117865852;4884.63365247607;4885.389326334208;4982.277569752384;5025.246213068032;5062.670926389791;800.4680044545604;4947.901041979158;4968.801247950078;4980.4272508661425;5014.047331007116;4874.878128046792;4909.165441874889;4927.630427717918;4935.185694360426;4970.776315065813;4801.399825021872;4904.803807847682;4916.262560615901;4935.161022626126;4948.752562371867;4834.806607735686;4857.53853383928;4878.243872199815;4882.780274887638;4895.31465594817;5272.340957380327;5328.520433161034;5328.600354973392;5331.893362132774;5395.325584301962;5634.915476267859;5643;5760.164776107441;5773.769049238025;5778.508826749731;5723.313202415695;5764.423557644244;5773.307203135609;5780.797672081457;5832.737526811261;5364.973175134139;5374.731263436852;5380.166074258496;5380.24676545284;5387;5730.856728581819;5857.4435428634215;5914.142449344907;5919.112133180058;5926.051831706993;5635.408282130399;5659.6321239119325;5662.8301150965535;5668.206451096849;5679.943200567942;5688.54491640676;5690.374058853523;5701.885962280731;5746.396628353963;5761;5523.751431185526;5634.295713035871;5649.802256921071;5700.458456446631;5704.8859022819315;5573.721313934287;5689.48794608479;5691.601587888891;5708.429157084258;5719.084946408555;4348.913021739548;4360.738355698668;4365.607095361433;4369.60673539383;4404.867853964386;3867.013911452618;3904.5509766376663;3924.47019652349;3938.8818335449982;3950;5678.943210567924;5684.744186511617;5689.203511508392;5693.259876216065;5694.857628559236;5656.4060773619;5777.797777077866;5829.941700583025;5855.473007429352;5878;5575.972120139373;5584.720763961785;5613.354464236665;5614.719264036782;5654.40628733977;4996.850094497171;5003.424606170264;5019.598432125421;5031.345925029796;5052.418971818214;5874.32445268791;5992.700364981733;6106.053561697944;6125.479334256638;6143.232095988002;5648.068068768689;5700.258966334516;5720.942790572041;5738.799142030176;5750.453706897754;5953.910691339547;5965.224520812267;6003.579749417673;6011.969940150271;6013.128096426081;5392.649477783932;5502.614816962774;5551.750171242223;5552.888942221214;5601.943980560305;5691.146328050825;5740.540756739534;5742.483176514133;5751.7411716472025;5795.884082318245;5580.274564306615;5581.5255703265675;5584.190292407659;5607.635503692247;5615.101583746581;5442.673439593637;5494.725263736717;5547.41752116022;5566.332040155045;5579.804706835242;5352.866178345573;5455.454454554671;5496.31296087989;5504.972475137599;5524.14375771756;5693;5696.287964004499;5703.401142880104;5727.627704199381;5734.455226753452;5440.347158341025;5513.09034009384;5516.117421212587;5572.442755724395;5601.187827765033 07:30:18 INFO - PROCESS | 22422 | |1;ext.html;577.7746678795271;626.4706323156933;642.916420865288;645.6416688737752;652.5366989437496;32375.838120809392;42903.141937161236;43866.56133438665;43955.34066988998;43986.7800660997;45914;46257.53742462574;46386.30420543686;46423.76788116063;46464;8677.73966780996;8863.778405539848;8868.778280543005;8869;8910.910890891073;8671.783205419852;8780.73657790264;8820.382573219846;8852.203301702846;8854.468731876108;8865.157810008039;8914.73255802327;8916.242119419858;8933.687320943769;8939.95530022349;8802.427842190236;8829.381943263974;8860.68987585438;8872.290216782674;8881.422707524023;8733.956330218372;8755.430896991675;8779.912200877974;8841.513716745576;8864;42104.157916841796;42269.57730422687;42407.787961060305;42427;42827.78586107049;3527.629598892105;3613.94579081314;3766.2844059628583;3960.5341142837265;4210.789460526961;32052.358952821047;32333.191670208198;32501.02496925096;32894.506582401285;33813.154671133176;4206.516250631186;4257.74453532789;4266.296061149907;4344.652427805768;4367.58507941745;357705;359044;359365;359874;360613.9999999974;58043.999999999156;58494.707526462094;58544;58875.11687324694;58953.115703264484;61540.69229653913;61772.69113654403;61812.69093654593;61888.69055654693;62194.37805621886;15057.774133388008;15196.088234705952;15292.311845966959;15308.387664493519;15354.923225383802;11030;11098.667039988813;11143.498542565603;11160.386178760084;11211.887881121085;15193.848061519464;17398.0431076292;17411.564710882078;17570.38503652366;17678.292868285123;6259.71831267594;6262.342454042351;6416.871662566722;6419.101325814389;6454.515911306671;1084.9728756781144;1121.9382933938548;1153.313778301909;1157.346099453806;1188.560232713884;32401.35197296041;33277.83361083228;33365.499517507254;33443.33113337719;33797.324053518794;1070.0904231403401;1120.8598925134359;1126.4367816091954;1159.7216667999787;1192.24292574216;16578.419755308507;16723.91638041802;16959.830401695825;16999.320027198773;17050;500408;503213;504417;505397;506744;57731.4226857726;58657.41342586605;59213;59216.40783592195;59221.11168332479;1368.131236664725;1384.7992041153975;1394.8395934467462;1414.1232435889815;1419.042146551074;30909.690903090683;32090.197745055626;32091.839540802146;32467.675323246465;32647.877887937208;49806;50079.49920500894;50089;50451.49548504468;50480;432630;433520;434999;437213;437898;28005.43989120247;28604.14187574376;28704.42591148207;30393;41988.16023679448;45881;48067.27899081447;49779.502204977485;50281.49718502768;50320.74839625778;41133.794331028155;41300.173996520505;41877.162456750084;42786.572134278256;43330.56669433392;41034.32644745448;41427;42020.579794201665;42415.36376954286;42562.57437425586;39108.41337379999;41875.7906210467;42015.579844201166;42295;42680.35979460248;37375;38163.42754858624;38198.2360352797;38239.426408603336;38639.80680096582;29032.274193145342;29187.85406073041;29534.409311814074;29659;29691 07:30:18 INFO - PROCESS | 22422 | |2;jquery.html;390.90227443139224;396.3480075276169;402.49687890137335;405.25837716977895;423.78175239751533;13626.931865340659;17443.651126977453;18250.361237356694;19040.619922509686;19089.331873384435;18272.360467383645;18353.174107165178;18710.71933920989;19493.707594386062;19498.122584483695;5490.80782172624;5496.422875598055;5669.9433005670035;5703.458171473703;5835.737391817378;5747.770089196427;5753.453421924911;5772.826815195551;5811.360750317462;5898.941010589882;6504.674766261668;6516.543841931067;6534.411902928736;6537.084808126866;6551.4431273341825;6247.344028876993;6397.200349956255;6398.520110991694;6491.578047426926;6493.285738568754;5616.073347897592;5683.488486036235;5711.971440142773;5713.6000479966415;5757.021306377926;13901.513447029305;18640.881547107216;21349.679754803692;22731.09075636989;22893.88553057224;2238;2242.4842286274084;2260.389694782416;2282.6804247405375;2407.903683852644;9960.452175130366;10144.188464922789;10166.694999150037;10268.589256429734;10544.05103540685;1973.7631484221986;2004.1582535335194;2035.1757538197053;2055.8869262190574;2058.7220725202055;69894;72483.27516724818;77406.61296693537;82800.58599707023;82852.75720864252;10819.621313254156;10826.621068262573;10918.617848375268;11044.779104417867;11170.939324952951;15455.072695638073;15465.381384744484;15478.148701821508;15570.299336529657;15598;7840.882386764203;7986.401019923529;8175.305099066527;8176.918230817616;8224.300934420642;7644.235576442423;7774.766756997299;7805.102413222438;7869.724559640385;7882.645280962371;4699.577038066591;4759.619230461555;4775.71345719258;4828.66199366048;4917.680350777188;1961.2139804974229;1969.812867777559;1989.9701504477443;2054.5685406064595;2065.7727649958492;1000.1648623399543;1006.2352612014921;1035.5081336365167;1047.450088703437;1070.400575677623;17046.48860534186;18705.158267877705;19583;19644.90177549103;19740.210391584464;982.5382070426888;992.161623428202;1011.7571782772229;1026.609888242463;1037.657573000923;10541.367517948947;10865.782684346268;10918.945405273082;10956.28784129029;10992.780144397067;449797;454055;462279;469589;469663;73567.26432735712;90163;91301.54349228212;91550;91570.54214728884;1004.4023805835516;1013.8580598716038;1030.2376241581176;1056.2025670618787;1063.3832377221347;16596.253168607684;16864.325426982785;17079.31682732677;17090.2309396075;17317.48047558575;39812.80093599513;40071.39892901667;40968.38547421731;41414;41591.58408415877;53460.46539534555;53633.19550206672;56002.43997560135;56421.43578564162;56916.43083569277;5325.893482130413;5903.498202652822;8157.2250636189465;8397.95801020991;8807.647694092164;10096.848547271944;12072.215306005082;12173.087018473472;12493.562725304571;12645.87354126447;10601.25791194609;10912.118704067629;10965.50655220533;11121.110311175249;11434;10973.889024614986;10975.121990240601;11083.33499989971;11195.60815371458;11428;10772.784544308914;10963.890361096286;11184.049355804522;11187.664370068911;11315.20793544444;8614.61234244473;8615.91384086151;8635.956820215859;8737.519436430803;8761.29909607217;10635.096016838655;10653.786924261627;10752.677419677422;10795.920407959142;10801.67594972152 07:30:18 INFO - PROCESS | 22422 | |3;mootools.html;1530.5025866593357;1562.3828587707856;1698.651776385841;1811.2302271534595;1825.8721889467733;7750.108737495176;8592.699255526059;8848.955755221223;9513.42919424835;9533.761655958604;9010.909890901088;9029;9031.367804253705;9038.096190380958;9047.185753282203;2338.9532209355802;2401.543706695731;2401.579723548372;2409.5421869844763;2415.1546958564536;2342.390978345625;2354.5761762882676;2386.8925898334614;2397.1370306689664;2399.7360290368047;2395.964060539093;2403.6875206223253;2404.170561156407;2427.611582146857;2433.2578563538113;2298.7241531016216;2310.0413328468667;2327;2341.555104530142;2345.6950596422525;2328.2433209207074;2333.57995560799;2364.9527009459716;2392.425817803732;2393.497365553236;9006.279497640238;9021.233195178418;9069.59186836594;9090.2273306769;9106.499142547158;5497.642653227527;5644.6613203207935;5648.378678345379;5682.176084467729;5685.516731077863;3476.235228249781;3484.703800176988;3501.9649803501893;3564.590072141711;3589.0668426209113;1165.9358735269557;1193.2959553863263;1210.382704820539;1234.4630085912656;2071.7721050684413;12751.489940402373;13186.07697461178;13221.07452478327;13313.201207927556;13390.531331403452;4757.809687612456;4817.855464336076;4937.481564435682;4960.131976904027;4963.255511673206;10245.897541024644;10294.124999375137;10295.485225738683;10319;10327.84508232377;5566.610337276352;5578.553715702734;5579.079451890474;5585.58108141891;5595.272614560163;4518.796654150571;5039;5173.5602473789395;5176.585873130216;5204.9219261711105;4038.656714179269;4048.230836141183;4080.5307389649975;4082.510098788164;4126.592278068541;1186.5550418593027;1189.3815216087587;1198.7962046452124;1202.963911082669;1212.927224366541;975.882894052704;982.6167794560128;1008.455434065611;1020.8468729690605;1030.7835354575473;5925.644461332334;6285.214348206474;6347.079673447324;6384.904226436514;6412.2625898022325;1027.9771627230953;1049.8267785815256;1096.1231015187977;1102.1953973599157;1105.4693747001324;4302.44068271129;4429.867103986886;4437.822487100544;4459.0858873930765;4510.0528888933695;11023.61417350405;11174;11196.160287978435;11251.09991200702;11303.039241664386;10946.233763636468;11172.162087843444;11191.888081119247;11230.606928757617;11234.831477527843;8367.205115514016;8748.69379571712;8752.343574231958;8906.109389061043;8931.821363572692;6233.470155036873;6430.099786030053;6457.321981192095;6496.317886622026;6538.051982462422;10642.787144257227;10810.51352689115;10895.291806032583;10914.781704366027;10971.615993440191;10867.836982445428;10890.074343680875;11135.944320278672;11197.60808371703;11242.325460472397;7454.776356709307;7664.156942736183;7881.093674227537;8226.30076443509;8392.790180245298;9034.412763170372;9074.682386116454;9135.858017747782;9167.17495425415;9177.357584969255;7679.846403071795;7850.332721718718;7972.920270797218;8036.598170091589;8112.43212975086;8105.432619716563;8110.83778324442;8144.674213031412;8248;8320.583970801315;7340.743073992385;7346.33882950537;7480.588567628833;7619.314261716472;7674.577898215652;5474.151506516497;5511.200875873056;5547.029269877675;5611.214429979887;5705.144228365778;5571.470710282517;5593.972030139986;5614.803481878114;5640.069388551007;5641.60835675692 07:30:18 INFO - PROCESS | 22422 | |4;prototype.html;328.0149222310889;337.7230670849901;340.10213037580786;340.7614669731189;346.8040557085247;5318.441563635821;5406.216098665701;5476.671399716015;5549.528290095342;5579.274694289747;5372.54333381663;5391.353037635489;5398.78404863805;5492.697901615409;5517.586181036429;4292.248856450125;4306.504751953518;4318.632916202127;4340.435743353375;4346.565343465644;4219.156168766243;4343.891402714926;4357.847475338363;4358.43340365752;4379.102284031782;4267.701260911737;4288.463942007249;4289.541555871003;4290.077633308838;4301.741895486281;4299.591538803808;4302.41917341158;4303;4319.200947824646;4345.891352716191;3735.514383130203;3871.5354157500997;3873.65137137659;3880.0105972976994;3882.864099756523;5270.947290527084;5274.551663108602;5278.366596008465;5279.700187382886;5312;4884.5848102911295;4915.181382888319;4916.1888288432365;4928.950710492885;4935;5481.725913704299;5693.857653558653;5699.772009119631;5737.799177028825;5761.279840019997;4169.2703776838935;4204.2432362174795;4211.789410529492;4220.388043733672;4221.767802770846;5916.467517923407;5933.7329820157765;5939.970300148471;5972.552058595579;6024.518038556905;4128.504579450485;4224.155168966157;4238.87283381499;4247.745135291892;4290.2706539888295;4291.29193683045;4330.938919964566;4337.9132417351475;4353.172897149531;4372.344148377705;4905.9754701226975;4913.803447862046;4921.163402221631;4941.703497790144;4964.801407943714;5648.830535083954;5757.96356655806;5763.942360576424;5792.333881603585;5834.395541226112;1483.5326872035275;1493.2459108150315;1499.430216517738;1504.473434298009;1505.1721553145726;974.3131092579714;984.2027957354566;1006.6225165562914;1009.5507499162802;1009.7778488732467;5115.335006449138;5120.129577971754;5131.179011358165;5149.201873709581;5158.6131040171385;5203.661761985459;5328.333958255218;5330.147176451749;5350.38470575881;5351.438098999627;4831.371921650163;5079.415867175248;5127.359080114986;5135.97432012845;5167.534921856975;2808.2838876086876;2871.798974071795;2874.3676391193903;2875.7843161762953;2887.6534815821815;5376.327959005124;5453.481919217668;5481.698506582176;5495.835124946258;5530.917036244459;5148.932343448709;5273.288106105627;5276.419593844674;5358.071094406011;5406.675599463966;5359.464053594609;5391.598184472065;5409.377921538995;5440.945590544044;5471.112466199234;4853.854384368475;5148.3564554430695;5192.870178245574;5201.219817027476;5205.3753549572775;5120.795168193379;5150.8322381734215;5166.405863325615;5202.791888324425;5209.244659524424;5446;5503.614746967834;5503.807366742145;5518.310211223597;5551.750171242385;3979.243943650697;4179.916401672011;4278.251306021496;4285.550017248144;4291.678124140764;5853.824385268449;5885.705714714333;5885.94114058871;5909.438603332676;5930.495907847881;5582.27430434041;5636.278764885102;5655.802046928337;5663.461971112738;5727.8854422912145;5678.517326027169;5685.573581981285;5692.601517893708;5714.971425142848;5740.827775166752;5567.693776842312;5589.037809960727;5592.748326325243;5607.794324220312;5632.380438151718;5432.728363581884;5638.182463542846;5767.480926716616;5828.59199856006;5845.3570107289015;5640.830775076754;5679.943200567942;5706.229658995982;5710.172025056427;5716.342620598518 07:30:18 INFO - PROCESS | 22422 | |5;yui.html;820.2084987986593;843.5276245302629;852.1606217875395;854.3080105114857;855.5850412549912;13304.866951330483;13893.434265563863;14032.438702451915;14099.647508812272;14133.152010879341;13030.218186908793;13181.670458238548;13214.20714757113;13258.469661213565;13274;793.6944276453578;804.1074407407773;806.3992325717348;808.9676412943504;809.6639894443799;797.103258833812;802.8715405535115;803.5540275147291;804.7103042904549;809.3969992355674;833.0960907415462;837.4054421360842;837.5728378526965;840.705752986456;841.9873701894477;821.9712310069119;831.4844796226317;833.7790485521342;837.8785076163983;837.9078301386843;603.0532064658488;607.1257389359308;607.9483243924271;609.0620444515441;609.2780055634088;13869.583912482642;13882.930585347009;13905.860941390558;13917.721645567031;13923.164610123426;13898.444062237499;14066.999999999898;14073.5074272401;14078;14167;11555.19113662044;11635.534578616845;11713.121515886343;11717.355545444998;12152.817707734392;3800.6959443244473;3845.4616353710503;3863.265979463893;3865.6520913117956;4020.2160578687167;55956.440435595934;57142.42857571454;57318.42681573173;57336;57530.42469575335;9518.619255229853;9618.615255389846;9660.71017869465;9706.9029309706;9850.064243896819;19330.323438679578;19408.61182776365;19463.416097517096;19480.70778938317;19484.318048868223;7838.725644602411;7860.449768516149;7869.48848324857;8006.959965200137;8014.118446970829;4525.886852828706;4534.614557762628;4545.659075569345;4656.627469802475;4717.363155973968;3390.355832391838;3535.876244331436;3546.29074185164;3547.2018795770746;3551.360755064113;639.4724352409281;641.1760887259942;643.411278680012;646.8997305417668;655.0370954696589;747.3535391885979;765.9004329437249;781.7459325719165;788.9842203155905;795.5584650519017;9047.728568142966;9643.373180743229;9732.610695572239;9759.951200243953;9831;687.2508965227926;741.2661465149463;761.9238076192447;772.1390649425962;774.8566515194594;4379.759113248738;4430.667699922518;4451.265541185733;4470.955290447119;4621.491635920046;65711.34288657148;67188.63273887182;68446.65776671085;68802.65598671975;68823.65588172027;60542.394576054554;60694;61012.69493652503;61097.38902610917;62171;54795.90408191814;55058.44941550613;55461.44538554644;55472.16791748127;55935;8790.120987901159;8863.64545418176;8866.202041816268;8957.865632015655;8969.461832290084;37237.25525489421;37258.25483490261;37629.247415052094;37652.05869853166;37732.43401348927;46444;49163.75418122886;49314;49469.25796112989;50438;11337.659870203906;11352.375619341015;11408.885911140782;11493.195476316578;11801.881981180422;11599.8260026098;11782.561253844136;11999;12165.878341216829;12573.811392828931;11195.440227988405;11502.252353596989;11889.881101188877;12454.937725311316;12747.235165889706;10714.250002500063;11127;11134;11472.655820325404;11847.407629618312;11342.376169310766;11640.708982275512;11691.240069395462;11883.287002779862;12034;9511.524423778921;9744.17174540172;9894.356866803635;10051.095401413908;10129.139023182817;9907.207423405966;10002.349847259904;10083.647072352433;10158.542865571215;10163.339382940085 07:30:18 INFO - PROCESS | 22422 | __end_tp_report 07:30:18 INFO - PROCESS | 22422 | __start_cc_report 07:30:18 INFO - PROCESS | 22422 | _x_x_mozilla_cycle_collect,327 07:30:18 INFO - PROCESS | 22422 | __end_cc_report 07:30:18 INFO - PROCESS | 22422 | __startTimestamp1464013818920__endTimestamp 07:30:18 INFO - PROCESS | 22422 | 07:30:18 INFO - PROCESS | 22422 | ------- Summary: start ------- 07:30:18 INFO - PROCESS | 22422 | Number of tests: 6 07:30:18 INFO - PROCESS | 22422 | 07:30:18 INFO - PROCESS | 22422 | [#0] dojo.html Cycles:165 Average:5322.59 Median:5573.72 stddev:697.95 (12.5%) stddev-sans-first:677.83 07:30:18 INFO - PROCESS | 22422 | Values: 3093.6 3129.5 3141.0 3142.6 3147.2 5284.4 5288.3 5334.3 5368.1 5397.5 5285.7 5344.9 5378.0 5390.2 5407.4 4884.6 4885.4 4982.3 5025.2 5062.7 800.5 4947.9 4968.8 4980.4 5014.0 4874.9 4909.2 4927.6 4935.2 4970.8 4801.4 4904.8 4916.3 4935.2 4948.8 4834.8 4857.5 4878.2 4882.8 4895.3 5272.3 5328.5 5328.6 5331.9 5395.3 5634.9 5643.0 5760.2 5773.8 5778.5 5723.3 5764.4 5773.3 5780.8 5832.7 5365.0 5374.7 5380.2 5380.2 5387.0 5730.9 5857.4 5914.1 5919.1 5926.1 5635.4 5659.6 5662.8 5668.2 5679.9 5688.5 5690.4 5701.9 5746.4 5761.0 5523.8 5634.3 5649.8 5700.5 5704.9 5573.7 5689.5 5691.6 5708.4 5719.1 4348.9 4360.7 4365.6 4369.6 4404.9 3867.0 3904.6 3924.5 3938.9 3950.0 5678.9 5684.7 5689.2 5693.3 5694.9 5656.4 5777.8 5829.9 5855.5 5878.0 5576.0 5584.7 5613.4 5614.7 5654.4 4996.9 5003.4 5019.6 5031.3 5052.4 5874.3 5992.7 6106.1 6125.5 6143.2 5648.1 5700.3 5720.9 5738.8 5750.5 5953.9 5965.2 6003.6 6012.0 6013.1 5392.6 5502.6 5551.8 5552.9 5601.9 5691.1 5740.5 5742.5 5751.7 5795.9 5580.3 5581.5 5584.2 5607.6 5615.1 5442.7 5494.7 5547.4 5566.3 5579.8 5352.9 5455.5 5496.3 5505.0 5524.1 5693.0 5696.3 5703.4 5727.6 5734.5 5440.3 5513.1 5516.1 5572.4 5601.2 07:30:18 INFO - PROCESS | 22422 | 07:30:18 INFO - PROCESS | 22422 | [#1] ext.html Cycles:180 Average:59803.26 Median:42421.18 stddev:115595.77 (272.5%) stddev-sans-first:115834.52 07:30:18 INFO - PROCESS | 22422 | Values: 577.8 626.5 642.9 645.6 652.5 32375.8 42903.1 43866.6 43955.3 43986.8 45914.0 46257.5 46386.3 46423.8 46464.0 8677.7 8863.8 8868.8 8869.0 8910.9 8671.8 8780.7 8820.4 8852.2 8854.5 8865.2 8914.7 8916.2 8933.7 8940.0 8802.4 8829.4 8860.7 8872.3 8881.4 8734.0 8755.4 8779.9 8841.5 8864.0 42104.2 42269.6 42407.8 42427.0 42827.8 3527.6 3613.9 3766.3 3960.5 4210.8 32052.4 32333.2 32501.0 32894.5 33813.2 4206.5 4257.7 4266.3 4344.7 4367.6 357705.0 359044.0 359365.0 359874.0 360614.0 58044.0 58494.7 58544.0 58875.1 58953.1 61540.7 61772.7 61812.7 61888.7 62194.4 15057.8 15196.1 15292.3 15308.4 15354.9 11030.0 11098.7 11143.5 11160.4 11211.9 15193.8 17398.0 17411.6 17570.4 17678.3 6259.7 6262.3 6416.9 6419.1 6454.5 1085.0 1121.9 1153.3 1157.3 1188.6 32401.4 33277.8 33365.5 33443.3 33797.3 1070.1 1120.9 1126.4 1159.7 1192.2 16578.4 16723.9 16959.8 16999.3 17050.0 500408.0 503213.0 504417.0 505397.0 506744.0 57731.4 58657.4 59213.0 59216.4 59221.1 1368.1 1384.8 1394.8 1414.1 1419.0 30909.7 32090.2 32091.8 32467.7 32647.9 49806.0 50079.5 50089.0 50451.5 50480.0 432630.0 433520.0 434999.0 437213.0 437898.0 28005.4 28604.1 28704.4 30393.0 41988.2 45881.0 48067.3 49779.5 50281.5 50320.7 41133.8 41300.2 41877.2 42786.6 43330.6 41034.3 41427.0 42020.6 42415.4 42562.6 39108.4 41875.8 42015.6 42295.0 42680.4 37375.0 38163.4 38198.2 38239.4 38639.8 29032.3 29187.9 29534.4 29659.0 29691.0 07:30:18 INFO - PROCESS | 22422 | 07:30:18 INFO - PROCESS | 22422 | [#2] jquery.html Cycles:180 Average:27610.12 Median:2240.24 stddev:76048.09 (3394.6%) stddev-sans-first:76233.96 07:30:18 INFO - PROCESS | 22422 | Values: 390.9 396.3 402.5 405.3 423.8 13626.9 17443.7 18250.4 19040.6 19089.3 18272.4 18353.2 18710.7 19493.7 19498.1 5490.8 5496.4 5669.9 5703.5 5835.7 5747.8 5753.5 5772.8 5811.4 5898.9 6504.7 6516.5 6534.4 6537.1 6551.4 6247.3 6397.2 6398.5 6491.6 6493.3 5616.1 5683.5 5712.0 5713.6 5757.0 13901.5 18640.9 21349.7 22731.1 22893.9 2238.0 2242.5 2260.4 2282.7 2407.9 9960.5 10144.2 10166.7 10268.6 10544.1 1973.8 2004.2 2035.2 2055.9 2058.7 69894.0 72483.3 77406.6 82800.6 82852.8 10819.6 10826.6 10918.6 11044.8 11170.9 15455.1 15465.4 15478.1 15570.3 15598.0 7840.9 7986.4 8175.3 8176.9 8224.3 7644.2 7774.8 7805.1 7869.7 7882.6 4699.6 4759.6 4775.7 4828.7 4917.7 1961.2 1969.8 1990.0 2054.6 2065.8 1000.2 1006.2 1035.5 1047.5 1070.4 17046.5 18705.2 19583.0 19644.9 19740.2 982.5 992.2 1011.8 1026.6 1037.7 10541.4 10865.8 10918.9 10956.3 10992.8 449797.0 454055.0 462279.0 469589.0 469663.0 73567.3 90163.0 91301.5 91550.0 91570.5 1004.4 1013.9 1030.2 1056.2 1063.4 16596.3 16864.3 17079.3 17090.2 17317.5 39812.8 40071.4 40968.4 41414.0 41591.6 53460.5 53633.2 56002.4 56421.4 56916.4 5325.9 5903.5 8157.2 8398.0 8807.6 10096.8 12072.2 12173.1 12493.6 12645.9 10601.3 10912.1 10965.5 11121.1 11434.0 10973.9 10975.1 11083.3 11195.6 11428.0 10772.8 10963.9 11184.0 11187.7 11315.2 8614.6 8615.9 8636.0 8737.5 8761.3 10635.1 10653.8 10752.7 10795.9 10801.7 07:30:18 INFO - PROCESS | 22422 | 07:30:18 INFO - PROCESS | 22422 | [#3] mootools.html Cycles:180 Average:6091.63 Median:4448.45 stddev:3445.73 (77.5%) stddev-sans-first:3438.35 07:30:18 INFO - PROCESS | 22422 | Values: 1530.5 1562.4 1698.7 1811.2 1825.9 7750.1 8592.7 8849.0 9513.4 9533.8 9010.9 9029.0 9031.4 9038.1 9047.2 2339.0 2401.5 2401.6 2409.5 2415.2 2342.4 2354.6 2386.9 2397.1 2399.7 2396.0 2403.7 2404.2 2427.6 2433.3 2298.7 2310.0 2327.0 2341.6 2345.7 2328.2 2333.6 2365.0 2392.4 2393.5 9006.3 9021.2 9069.6 9090.2 9106.5 5497.6 5644.7 5648.4 5682.2 5685.5 3476.2 3484.7 3502.0 3564.6 3589.1 1165.9 1193.3 1210.4 1234.5 2071.8 12751.5 13186.1 13221.1 13313.2 13390.5 4757.8 4817.9 4937.5 4960.1 4963.3 10245.9 10294.1 10295.5 10319.0 10327.8 5566.6 5578.6 5579.1 5585.6 5595.3 4518.8 5039.0 5173.6 5176.6 5204.9 4038.7 4048.2 4080.5 4082.5 4126.6 1186.6 1189.4 1198.8 1203.0 1212.9 975.9 982.6 1008.5 1020.8 1030.8 5925.6 6285.2 6347.1 6384.9 6412.3 1028.0 1049.8 1096.1 1102.2 1105.5 4302.4 4429.9 4437.8 4459.1 4510.1 11023.6 11174.0 11196.2 11251.1 11303.0 10946.2 11172.2 11191.9 11230.6 11234.8 8367.2 8748.7 8752.3 8906.1 8931.8 6233.5 6430.1 6457.3 6496.3 6538.1 10642.8 10810.5 10895.3 10914.8 10971.6 10867.8 10890.1 11135.9 11197.6 11242.3 7454.8 7664.2 7881.1 8226.3 8392.8 9034.4 9074.7 9135.9 9167.2 9177.4 7679.8 7850.3 7972.9 8036.6 8112.4 8105.4 8110.8 8144.7 8248.0 8320.6 7340.7 7346.3 7480.6 7619.3 7674.6 5474.2 5511.2 5547.0 5611.2 5705.1 5571.5 5594.0 5614.8 5640.1 5641.6 07:30:18 INFO - PROCESS | 22422 | 07:30:18 INFO - PROCESS | 22422 | [#4] prototype.html Cycles:180 Average:4692.15 Median:5202.01 stddev:1328.81 (25.5%) stddev-sans-first:1291.54 07:30:18 INFO - PROCESS | 22422 | Values: 328.0 337.7 340.1 340.8 346.8 5318.4 5406.2 5476.7 5549.5 5579.3 5372.5 5391.4 5398.8 5492.7 5517.6 4292.2 4306.5 4318.6 4340.4 4346.6 4219.2 4343.9 4357.8 4358.4 4379.1 4267.7 4288.5 4289.5 4290.1 4301.7 4299.6 4302.4 4303.0 4319.2 4345.9 3735.5 3871.5 3873.7 3880.0 3882.9 5270.9 5274.6 5278.4 5279.7 5312.0 4884.6 4915.2 4916.2 4929.0 4935.0 5481.7 5693.9 5699.8 5737.8 5761.3 4169.3 4204.2 4211.8 4220.4 4221.8 5916.5 5933.7 5940.0 5972.6 6024.5 4128.5 4224.2 4238.9 4247.7 4290.3 4291.3 4330.9 4337.9 4353.2 4372.3 4906.0 4913.8 4921.2 4941.7 4964.8 5648.8 5758.0 5763.9 5792.3 5834.4 1483.5 1493.2 1499.4 1504.5 1505.2 974.3 984.2 1006.6 1009.6 1009.8 5115.3 5120.1 5131.2 5149.2 5158.6 5203.7 5328.3 5330.1 5350.4 5351.4 4831.4 5079.4 5127.4 5136.0 5167.5 2808.3 2871.8 2874.4 2875.8 2887.7 5376.3 5453.5 5481.7 5495.8 5530.9 5148.9 5273.3 5276.4 5358.1 5406.7 5359.5 5391.6 5409.4 5440.9 5471.1 4853.9 5148.4 5192.9 5201.2 5205.4 5120.8 5150.8 5166.4 5202.8 5209.2 5446.0 5503.6 5503.8 5518.3 5551.8 3979.2 4179.9 4278.3 4285.6 4291.7 5853.8 5885.7 5885.9 5909.4 5930.5 5582.3 5636.3 5655.8 5663.5 5727.9 5678.5 5685.6 5692.6 5715.0 5740.8 5567.7 5589.0 5592.7 5607.8 5632.4 5432.7 5638.2 5767.5 5828.6 5845.4 5640.8 5679.9 5706.2 5710.2 5716.3 07:30:18 INFO - PROCESS | 22422 | 07:30:18 INFO - PROCESS | 22422 | [#5] yui.html Cycles:180 Average:15327.92 Median:52616.95 stddev:18727.94 (35.6%) stddev-sans-first:18748.79 07:30:18 INFO - PROCESS | 22422 | Values: 820.2 843.5 852.2 854.3 855.6 13304.9 13893.4 14032.4 14099.6 14133.2 13030.2 13181.7 13214.2 13258.5 13274.0 793.7 804.1 806.4 809.0 809.7 797.1 802.9 803.6 804.7 809.4 833.1 837.4 837.6 840.7 842.0 822.0 831.5 833.8 837.9 837.9 603.1 607.1 607.9 609.1 609.3 13869.6 13882.9 13905.9 13917.7 13923.2 13898.4 14067.0 14073.5 14078.0 14167.0 11555.2 11635.5 11713.1 11717.4 12152.8 3800.7 3845.5 3863.3 3865.7 4020.2 55956.4 57142.4 57318.4 57336.0 57530.4 9518.6 9618.6 9660.7 9706.9 9850.1 19330.3 19408.6 19463.4 19480.7 19484.3 7838.7 7860.4 7869.5 8007.0 8014.1 4525.9 4534.6 4545.7 4656.6 4717.4 3390.4 3535.9 3546.3 3547.2 3551.4 639.5 641.2 643.4 646.9 655.0 747.4 765.9 781.7 789.0 795.6 9047.7 9643.4 9732.6 9760.0 9831.0 687.3 741.3 761.9 772.1 774.9 4379.8 4430.7 4451.3 4471.0 4621.5 65711.3 67188.6 68446.7 68802.7 68823.7 60542.4 60694.0 61012.7 61097.4 62171.0 54795.9 55058.4 55461.4 55472.2 55935.0 8790.1 8863.6 8866.2 8957.9 8969.5 37237.3 37258.3 37629.2 37652.1 37732.4 46444.0 49163.8 49314.0 49469.3 50438.0 11337.7 11352.4 11408.9 11493.2 11801.9 11599.8 11782.6 11999.0 12165.9 12573.8 11195.4 11502.3 11889.9 12454.9 12747.2 10714.3 11127.0 11134.0 11472.7 11847.4 11342.4 11640.7 11691.2 11883.3 12034.0 9511.5 9744.2 9894.4 10051.1 10129.1 9907.2 10002.3 10083.6 10158.5 10163.3 07:30:18 INFO - PROCESS | 22422 | -------- Summary: end -------- 07:30:18 INFO - PROCESS | 22422 | 07:30:19 INFO - PROCESS | 22422 | 07:30:19 INFO - PROCESS | 22422 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0043,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 07:30:19 INFO - PROCESS | 22422 | 07:30:19 INFO - PROCESS | 22422 | 07:30:19 INFO - PROCESS | 22422 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 07:30:19 INFO - PROCESS | 22422 | 07:30:19 INFO - TEST-INFO | 22422: exit 0 07:30:19 INFO - TEST-OK | dromaeo_css | took 1110132ms 07:30:19 INFO - TEST-START | kraken 07:30:19 INFO - operating with platform_type : linux_ 07:30:19 INFO - Initialising browser for kraken test... 07:30:19 INFO - TEST-INFO | started process 22661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPJGvS5/profile http://localhost:51615/getInfo.html) 07:30:23 INFO - PROCESS | 22661 | 07:30:23 INFO - PROCESS | 22661 | (process:22730): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:30:24 INFO - PROCESS | 22661 | __metrics Screen width/height:1600/1200 07:30:24 INFO - PROCESS | 22661 | colorDepth:24 07:30:24 INFO - PROCESS | 22661 | Browser inner width/height: 1024/697 07:30:24 INFO - PROCESS | 22661 | __metrics 07:30:24 ERROR - PROCESS | 22661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 07:30:25 INFO - TEST-INFO | 22661: exit 0 07:30:25 INFO - Browser initialized. 07:30:25 INFO - Running cycle 1/1 for kraken test... 07:30:25 INFO - TEST-INFO | started process 22781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPJGvS5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:27 INFO - PROCESS | 22781 | 07:30:27 INFO - PROCESS | 22781 | (process:22842): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:30:37 INFO - PROCESS | 22781 | RSS: Main: 163991552 07:30:37 INFO - PROCESS | 22781 | 07:30:40 INFO - PROCESS | 22781 | Cycle 1(1): loaded http://localhost:51615/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51615/tests/kraken/driver.html?testName=audio-beat-detection) 07:30:41 INFO - PROCESS | 22781 | RSS: Main: 169123840 07:30:41 INFO - PROCESS | 22781 | 07:30:43 INFO - PROCESS | 22781 | Cycle 1(1): loaded http://localhost:51615/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51615/tests/kraken/driver.html?testName=audio-dft) 07:30:44 INFO - PROCESS | 22781 | RSS: Main: 168861696 07:30:44 INFO - PROCESS | 22781 | 07:30:47 INFO - PROCESS | 22781 | Cycle 1(1): loaded http://localhost:51615/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51615/tests/kraken/driver.html?testName=audio-fft) 07:30:47 INFO - PROCESS | 22781 | RSS: Main: 163774464 07:30:47 INFO - PROCESS | 22781 | 07:30:50 INFO - PROCESS | 22781 | Cycle 1(1): loaded http://localhost:51615/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51615/tests/kraken/driver.html?testName=audio-oscillator) 07:30:50 INFO - PROCESS | 22781 | RSS: Main: 163995648 07:30:50 INFO - PROCESS | 22781 | 07:30:53 INFO - PROCESS | 22781 | Cycle 1(1): loaded http://localhost:51615/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51615/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:30:53 INFO - PROCESS | 22781 | RSS: Main: 164552704 07:30:53 INFO - PROCESS | 22781 | 07:30:56 INFO - PROCESS | 22781 | Cycle 1(1): loaded http://localhost:51615/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51615/tests/kraken/driver.html?testName=imaging-darkroom) 07:30:57 INFO - PROCESS | 22781 | RSS: Main: 164458496 07:30:57 INFO - PROCESS | 22781 | 07:31:00 INFO - PROCESS | 22781 | Cycle 1(1): loaded http://localhost:51615/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51615/tests/kraken/driver.html?testName=imaging-desaturate) 07:31:01 INFO - PROCESS | 22781 | RSS: Main: 162873344 07:31:01 INFO - PROCESS | 22781 | 07:31:04 INFO - PROCESS | 22781 | Cycle 1(1): loaded http://localhost:51615/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51615/tests/kraken/driver.html?testName=json-parse-financial) 07:31:05 INFO - PROCESS | 22781 | RSS: Main: 163622912 07:31:05 INFO - PROCESS | 22781 | 07:31:06 INFO - PROCESS | 22781 | Cycle 1(1): loaded http://localhost:51615/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51615/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:31:07 INFO - PROCESS | 22781 | RSS: Main: 163860480 07:31:07 INFO - PROCESS | 22781 | 07:31:09 INFO - PROCESS | 22781 | Cycle 1(1): loaded http://localhost:51615/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51615/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:31:09 INFO - PROCESS | 22781 | RSS: Main: 164007936 07:31:09 INFO - PROCESS | 22781 | 07:31:11 INFO - PROCESS | 22781 | Cycle 1(1): loaded http://localhost:51615/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51615/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:31:12 INFO - PROCESS | 22781 | RSS: Main: 164343808 07:31:12 INFO - PROCESS | 22781 | 07:31:15 INFO - PROCESS | 22781 | Cycle 1(1): loaded http://localhost:51615/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:31:15 INFO - PROCESS | 22781 | RSS: Main: 164892672 07:31:15 INFO - PROCESS | 22781 | 07:31:18 INFO - PROCESS | 22781 | Cycle 1(1): loaded http://localhost:51615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:31:19 INFO - PROCESS | 22781 | RSS: Main: 165113856 07:31:19 INFO - PROCESS | 22781 | 07:31:20 INFO - PROCESS | 22781 | Cycle 1(1): loaded http://localhost:51615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51615/tests/kraken/driver.html?testName=ai-astar) 07:31:21 INFO - PROCESS | 22781 | RSS: Main: 166289408 07:31:21 INFO - PROCESS | 22781 | 07:31:21 INFO - PROCESS | 22781 | __start_tp_report 07:31:21 INFO - PROCESS | 22781 | _x_x_mozilla_page_load 07:31:21 INFO - PROCESS | 22781 | _x_x_mozilla_page_load_details 07:31:21 INFO - PROCESS | 22781 | |i|pagename|runs| 07:31:21 INFO - PROCESS | 22781 | |0;ai-astar;110;107;111;111;111;112;111;110;110;110 07:31:21 INFO - PROCESS | 22781 | |1;audio-beat-detection;153;125;151;178;127;161;154;129;205;126 07:31:21 INFO - PROCESS | 22781 | |2;audio-dft;164;162;162;163;164;176;163;162;163;162 07:31:21 INFO - PROCESS | 22781 | |3;audio-fft;75;74;75;152;75;76;75;75;161;74 07:31:21 INFO - PROCESS | 22781 | |4;audio-oscillator;93;93;153;93;93;93;145;92;94;163 07:31:21 INFO - PROCESS | 22781 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;117;117 07:31:21 INFO - PROCESS | 22781 | |6;imaging-darkroom;147;145;150;147;148;147;146;147;146;146 07:31:21 INFO - PROCESS | 22781 | |7;imaging-desaturate;95;95;95;95;96;96;96;95;95;96 07:31:21 INFO - PROCESS | 22781 | |8;json-parse-financial;55;57;59;54;55;54;55;85;56;52 07:31:21 INFO - PROCESS | 22781 | |9;json-stringify-tinderbox;62;68;62;62;61;64;61;62;62;63 07:31:21 INFO - PROCESS | 22781 | |10;stanford-crypto-aes;78;79;79;84;79;78;82;85;81;80 07:31:21 INFO - PROCESS | 22781 | |11;stanford-crypto-ccm;127;131;128;119;132;119;120;118;168;134 07:31:21 INFO - PROCESS | 22781 | |12;stanford-crypto-pbkdf2;160;160;166;168;162;158;161;162;158;158 07:31:21 INFO - PROCESS | 22781 | |13;stanford-crypto-sha256-iterative;62;71;63;61;62;62;63;62;62;61 07:31:21 INFO - PROCESS | 22781 | __end_tp_report 07:31:21 INFO - PROCESS | 22781 | __start_cc_report 07:31:21 INFO - PROCESS | 22781 | _x_x_mozilla_cycle_collect,871 07:31:21 INFO - PROCESS | 22781 | __end_cc_report 07:31:21 INFO - PROCESS | 22781 | __startTimestamp1464013881161__endTimestamp 07:31:21 INFO - PROCESS | 22781 | 07:31:21 INFO - PROCESS | 22781 | ------- Summary: start ------- 07:31:21 INFO - PROCESS | 22781 | Number of tests: 14 07:31:21 INFO - PROCESS | 22781 | 07:31:21 INFO - PROCESS | 22781 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:1.34 (1.2%) stddev-sans-first:1.41 07:31:21 INFO - PROCESS | 22781 | Values: 110.0 107.0 111.0 111.0 111.0 112.0 111.0 110.0 110.0 110.0 07:31:21 INFO - PROCESS | 22781 | 07:31:21 INFO - PROCESS | 22781 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:153.50 stddev:26.07 (17.0%) stddev-sans-first:27.65 07:31:21 INFO - PROCESS | 22781 | Values: 153.0 125.0 151.0 178.0 127.0 161.0 154.0 129.0 205.0 126.0 07:31:21 INFO - PROCESS | 22781 | 07:31:21 INFO - PROCESS | 22781 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.00 stddev:4.25 (2.6%) stddev-sans-first:4.51 07:31:21 INFO - PROCESS | 22781 | Values: 164.0 162.0 162.0 163.0 164.0 176.0 163.0 162.0 163.0 162.0 07:31:21 INFO - PROCESS | 22781 | 07:31:21 INFO - PROCESS | 22781 | [#3] audio-fft Cycles:10 Average:91.20 Median:75.00 stddev:34.49 (46.0%) stddev-sans-first:36.08 07:31:21 INFO - PROCESS | 22781 | Values: 75.0 74.0 75.0 152.0 75.0 76.0 75.0 75.0 161.0 74.0 07:31:21 INFO - PROCESS | 22781 | 07:31:21 INFO - PROCESS | 22781 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:93.00 stddev:29.62 (31.8%) stddev-sans-first:30.67 07:31:21 INFO - PROCESS | 22781 | Values: 93.0 93.0 153.0 93.0 93.0 93.0 145.0 92.0 94.0 163.0 07:31:21 INFO - PROCESS | 22781 | 07:31:21 INFO - PROCESS | 22781 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:31:21 INFO - PROCESS | 22781 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 07:31:21 INFO - PROCESS | 22781 | 07:31:21 INFO - PROCESS | 22781 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.37 (0.9%) stddev-sans-first:1.45 07:31:21 INFO - PROCESS | 22781 | Values: 147.0 145.0 150.0 147.0 148.0 147.0 146.0 147.0 146.0 146.0 07:31:21 INFO - PROCESS | 22781 | 07:31:21 INFO - PROCESS | 22781 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:31:21 INFO - PROCESS | 22781 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 07:31:21 INFO - PROCESS | 22781 | 07:31:21 INFO - PROCESS | 22781 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:55.50 stddev:9.60 (17.3%) stddev-sans-first:10.11 07:31:21 INFO - PROCESS | 22781 | Values: 55.0 57.0 59.0 54.0 55.0 54.0 55.0 85.0 56.0 52.0 07:31:21 INFO - PROCESS | 22781 | 07:31:21 INFO - PROCESS | 22781 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:62.00 stddev:2.06 (3.3%) stddev-sans-first:2.17 07:31:21 INFO - PROCESS | 22781 | Values: 62.0 68.0 62.0 62.0 61.0 64.0 61.0 62.0 62.0 63.0 07:31:21 INFO - PROCESS | 22781 | 07:31:21 INFO - PROCESS | 22781 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.50 stddev:2.46 (3.1%) stddev-sans-first:2.44 07:31:21 INFO - PROCESS | 22781 | Values: 78.0 79.0 79.0 84.0 79.0 78.0 82.0 85.0 81.0 80.0 07:31:21 INFO - PROCESS | 22781 | 07:31:21 INFO - PROCESS | 22781 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:129.50 stddev:14.77 (11.4%) stddev-sans-first:15.63 07:31:21 INFO - PROCESS | 22781 | Values: 127.0 131.0 128.0 119.0 132.0 119.0 120.0 118.0 168.0 134.0 07:31:21 INFO - PROCESS | 22781 | 07:31:21 INFO - PROCESS | 22781 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.50 stddev:3.40 (2.1%) stddev-sans-first:3.57 07:31:21 INFO - PROCESS | 22781 | Values: 160.0 160.0 166.0 168.0 162.0 158.0 161.0 162.0 158.0 158.0 07:31:21 INFO - PROCESS | 22781 | 07:31:21 INFO - PROCESS | 22781 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:62.00 stddev:2.92 (4.7%) stddev-sans-first:3.08 07:31:21 INFO - PROCESS | 22781 | Values: 62.0 71.0 63.0 61.0 62.0 62.0 63.0 62.0 62.0 61.0 07:31:21 INFO - PROCESS | 22781 | -------- Summary: end -------- 07:31:21 INFO - PROCESS | 22781 | 07:31:22 INFO - TEST-INFO | 22781: exit 0 07:31:22 INFO - TEST-OK | kraken | took 62564ms 07:31:22 INFO - SUITE-END | took 1172s 07:31:22 INFO - Completed test suite (00:19:32) 07:31:22 INFO - javascript benchmark 07:31:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7170.152738294318, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.597832281803, 3129.467990441625, 3141.0419821954297, 3142.6228852537697, 3147.166001009732, 5284.365876094869, 5288.338957630296, 5334.333208348957, 5368.0605893968495, 5397.514223719864, 5285.709285989269, 5344.866378340534, 5378.0, 5390.245365648802, 5407.351117865852, 4884.63365247607, 4885.389326334208, 4982.277569752384, 5025.246213068032, 5062.670926389791, 800.4680044545604, 4947.901041979158, 4968.801247950078, 4980.4272508661425, 5014.047331007116, 4874.878128046792, 4909.165441874889, 4927.630427717918, 4935.185694360426, 4970.776315065813, 4801.399825021872, 4904.803807847682, 4916.262560615901, 4935.161022626126, 4948.752562371867, 4834.806607735686, 4857.53853383928, 4878.243872199815, 4882.780274887638, 4895.31465594817, 5272.340957380327, 5328.520433161034, 5328.600354973392, 5331.893362132774, 5395.325584301962, 5634.915476267859, 5643.0, 5760.164776107441, 5773.769049238025, 5778.508826749731, 5723.313202415695, 5764.423557644244, 5773.307203135609, 5780.797672081457, 5832.737526811261, 5364.973175134139, 5374.731263436852, 5380.166074258496, 5380.24676545284, 5387.0, 5730.856728581819, 5857.4435428634215, 5914.142449344907, 5919.112133180058, 5926.051831706993, 5635.408282130399, 5659.6321239119325, 5662.8301150965535, 5668.206451096849, 5679.943200567942, 5688.54491640676, 5690.374058853523, 5701.885962280731, 5746.396628353963, 5761.0, 5523.751431185526, 5634.295713035871, 5649.802256921071, 5700.458456446631, 5704.8859022819315, 5573.721313934287, 5689.48794608479, 5691.601587888891, 5708.429157084258, 5719.084946408555, 4348.913021739548, 4360.738355698668, 4365.607095361433, 4369.60673539383, 4404.867853964386, 3867.013911452618, 3904.5509766376663, 3924.47019652349, 3938.8818335449982, 3950.0, 5678.943210567924, 5684.744186511617, 5689.203511508392, 5693.259876216065, 5694.857628559236, 5656.4060773619, 5777.797777077866, 5829.941700583025, 5855.473007429352, 5878.0, 5575.972120139373, 5584.720763961785, 5613.354464236665, 5614.719264036782, 5654.40628733977, 4996.850094497171, 5003.424606170264, 5019.598432125421, 5031.345925029796, 5052.418971818214, 5874.32445268791, 5992.700364981733, 6106.053561697944, 6125.479334256638, 6143.232095988002, 5648.068068768689, 5700.258966334516, 5720.942790572041, 5738.799142030176, 5750.453706897754, 5953.910691339547, 5965.224520812267, 6003.579749417673, 6011.969940150271, 6013.128096426081, 5392.649477783932, 5502.614816962774, 5551.750171242223, 5552.888942221214, 5601.943980560305, 5691.146328050825, 5740.540756739534, 5742.483176514133, 5751.7411716472025, 5795.884082318245, 5580.274564306615, 5581.5255703265675, 5584.190292407659, 5607.635503692247, 5615.101583746581, 5442.673439593637, 5494.725263736717, 5547.41752116022, 5566.332040155045, 5579.804706835242, 5352.866178345573, 5455.454454554671, 5496.31296087989, 5504.972475137599, 5524.14375771756, 5693.0, 5696.287964004499, 5703.401142880104, 5727.627704199381, 5734.455226753452, 5440.347158341025, 5513.09034009384, 5516.117421212587, 5572.442755724395, 5601.187827765033], "value": 5278.065406074614, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.7746678795271, 626.4706323156933, 642.916420865288, 645.6416688737752, 652.5366989437496, 32375.838120809392, 42903.141937161236, 43866.56133438665, 43955.34066988998, 43986.7800660997, 45914.0, 46257.53742462574, 46386.30420543686, 46423.76788116063, 46464.0, 8677.73966780996, 8863.778405539848, 8868.778280543005, 8869.0, 8910.910890891073, 8671.783205419852, 8780.73657790264, 8820.382573219846, 8852.203301702846, 8854.468731876108, 8865.157810008039, 8914.73255802327, 8916.242119419858, 8933.687320943769, 8939.95530022349, 8802.427842190236, 8829.381943263974, 8860.68987585438, 8872.290216782674, 8881.422707524023, 8733.956330218372, 8755.430896991675, 8779.912200877974, 8841.513716745576, 8864.0, 42104.157916841796, 42269.57730422687, 42407.787961060305, 42427.0, 42827.78586107049, 3527.629598892105, 3613.94579081314, 3766.2844059628583, 3960.5341142837265, 4210.789460526961, 32052.358952821047, 32333.191670208198, 32501.02496925096, 32894.506582401285, 33813.154671133176, 4206.516250631186, 4257.74453532789, 4266.296061149907, 4344.652427805768, 4367.58507941745, 357705.0, 359044.0, 359365.0, 359874.0, 360613.9999999974, 58043.999999999156, 58494.707526462094, 58544.0, 58875.11687324694, 58953.115703264484, 61540.69229653913, 61772.69113654403, 61812.69093654593, 61888.69055654693, 62194.37805621886, 15057.774133388008, 15196.088234705952, 15292.311845966959, 15308.387664493519, 15354.923225383802, 11030.0, 11098.667039988813, 11143.498542565603, 11160.386178760084, 11211.887881121085, 15193.848061519464, 17398.0431076292, 17411.564710882078, 17570.38503652366, 17678.292868285123, 6259.71831267594, 6262.342454042351, 6416.871662566722, 6419.101325814389, 6454.515911306671, 1084.9728756781144, 1121.9382933938548, 1153.313778301909, 1157.346099453806, 1188.560232713884, 32401.35197296041, 33277.83361083228, 33365.499517507254, 33443.33113337719, 33797.324053518794, 1070.0904231403401, 1120.8598925134359, 1126.4367816091954, 1159.7216667999787, 1192.24292574216, 16578.419755308507, 16723.91638041802, 16959.830401695825, 16999.320027198773, 17050.0, 500408.0, 503213.0, 504417.0, 505397.0, 506744.0, 57731.4226857726, 58657.41342586605, 59213.0, 59216.40783592195, 59221.11168332479, 1368.131236664725, 1384.7992041153975, 1394.8395934467462, 1414.1232435889815, 1419.042146551074, 30909.690903090683, 32090.197745055626, 32091.839540802146, 32467.675323246465, 32647.877887937208, 49806.0, 50079.49920500894, 50089.0, 50451.49548504468, 50480.0, 432630.0, 433520.0, 434999.0, 437213.0, 437898.0, 28005.43989120247, 28604.14187574376, 28704.42591148207, 30393.0, 41988.16023679448, 45881.0, 48067.27899081447, 49779.502204977485, 50281.49718502768, 50320.74839625778, 41133.794331028155, 41300.173996520505, 41877.162456750084, 42786.572134278256, 43330.56669433392, 41034.32644745448, 41427.0, 42020.579794201665, 42415.36376954286, 42562.57437425586, 39108.41337379999, 41875.7906210467, 42015.579844201166, 42295.0, 42680.35979460248, 37375.0, 38163.42754858624, 38198.2360352797, 38239.426408603336, 38639.80680096582, 29032.274193145342, 29187.85406073041, 29534.409311814074, 29659.0, 29691.0], "value": 20178.667595240873, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.90227443139224, 396.3480075276169, 402.49687890137335, 405.25837716977895, 423.78175239751533, 13626.931865340659, 17443.651126977453, 18250.361237356694, 19040.619922509686, 19089.331873384435, 18272.360467383645, 18353.174107165178, 18710.71933920989, 19493.707594386062, 19498.122584483695, 5490.80782172624, 5496.422875598055, 5669.9433005670035, 5703.458171473703, 5835.737391817378, 5747.770089196427, 5753.453421924911, 5772.826815195551, 5811.360750317462, 5898.941010589882, 6504.674766261668, 6516.543841931067, 6534.411902928736, 6537.084808126866, 6551.4431273341825, 6247.344028876993, 6397.200349956255, 6398.520110991694, 6491.578047426926, 6493.285738568754, 5616.073347897592, 5683.488486036235, 5711.971440142773, 5713.6000479966415, 5757.021306377926, 13901.513447029305, 18640.881547107216, 21349.679754803692, 22731.09075636989, 22893.88553057224, 2238.0, 2242.4842286274084, 2260.389694782416, 2282.6804247405375, 2407.903683852644, 9960.452175130366, 10144.188464922789, 10166.694999150037, 10268.589256429734, 10544.05103540685, 1973.7631484221986, 2004.1582535335194, 2035.1757538197053, 2055.8869262190574, 2058.7220725202055, 69894.0, 72483.27516724818, 77406.61296693537, 82800.58599707023, 82852.75720864252, 10819.621313254156, 10826.621068262573, 10918.617848375268, 11044.779104417867, 11170.939324952951, 15455.072695638073, 15465.381384744484, 15478.148701821508, 15570.299336529657, 15598.0, 7840.882386764203, 7986.401019923529, 8175.305099066527, 8176.918230817616, 8224.300934420642, 7644.235576442423, 7774.766756997299, 7805.102413222438, 7869.724559640385, 7882.645280962371, 4699.577038066591, 4759.619230461555, 4775.71345719258, 4828.66199366048, 4917.680350777188, 1961.2139804974229, 1969.812867777559, 1989.9701504477443, 2054.5685406064595, 2065.7727649958492, 1000.1648623399543, 1006.2352612014921, 1035.5081336365167, 1047.450088703437, 1070.400575677623, 17046.48860534186, 18705.158267877705, 19583.0, 19644.90177549103, 19740.210391584464, 982.5382070426888, 992.161623428202, 1011.7571782772229, 1026.609888242463, 1037.657573000923, 10541.367517948947, 10865.782684346268, 10918.945405273082, 10956.28784129029, 10992.780144397067, 449797.0, 454055.0, 462279.0, 469589.0, 469663.0, 73567.26432735712, 90163.0, 91301.54349228212, 91550.0, 91570.54214728884, 1004.4023805835516, 1013.8580598716038, 1030.2376241581176, 1056.2025670618787, 1063.3832377221347, 16596.253168607684, 16864.325426982785, 17079.31682732677, 17090.2309396075, 17317.48047558575, 39812.80093599513, 40071.39892901667, 40968.38547421731, 41414.0, 41591.58408415877, 53460.46539534555, 53633.19550206672, 56002.43997560135, 56421.43578564162, 56916.43083569277, 5325.893482130413, 5903.498202652822, 8157.2250636189465, 8397.95801020991, 8807.647694092164, 10096.848547271944, 12072.215306005082, 12173.087018473472, 12493.562725304571, 12645.87354126447, 10601.25791194609, 10912.118704067629, 10965.50655220533, 11121.110311175249, 11434.0, 10973.889024614986, 10975.121990240601, 11083.33499989971, 11195.60815371458, 11428.0, 10772.784544308914, 10963.890361096286, 11184.049355804522, 11187.664370068911, 11315.20793544444, 8614.61234244473, 8615.91384086151, 8635.956820215859, 8737.519436430803, 8761.29909607217, 10635.096016838655, 10653.786924261627, 10752.677419677422, 10795.920407959142, 10801.67594972152], "value": 9067.302404358525, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.5025866593357, 1562.3828587707856, 1698.651776385841, 1811.2302271534595, 1825.8721889467733, 7750.108737495176, 8592.699255526059, 8848.955755221223, 9513.42919424835, 9533.761655958604, 9010.909890901088, 9029.0, 9031.367804253705, 9038.096190380958, 9047.185753282203, 2338.9532209355802, 2401.543706695731, 2401.579723548372, 2409.5421869844763, 2415.1546958564536, 2342.390978345625, 2354.5761762882676, 2386.8925898334614, 2397.1370306689664, 2399.7360290368047, 2395.964060539093, 2403.6875206223253, 2404.170561156407, 2427.611582146857, 2433.2578563538113, 2298.7241531016216, 2310.0413328468667, 2327.0, 2341.555104530142, 2345.6950596422525, 2328.2433209207074, 2333.57995560799, 2364.9527009459716, 2392.425817803732, 2393.497365553236, 9006.279497640238, 9021.233195178418, 9069.59186836594, 9090.2273306769, 9106.499142547158, 5497.642653227527, 5644.6613203207935, 5648.378678345379, 5682.176084467729, 5685.516731077863, 3476.235228249781, 3484.703800176988, 3501.9649803501893, 3564.590072141711, 3589.0668426209113, 1165.9358735269557, 1193.2959553863263, 1210.382704820539, 1234.4630085912656, 2071.7721050684413, 12751.489940402373, 13186.07697461178, 13221.07452478327, 13313.201207927556, 13390.531331403452, 4757.809687612456, 4817.855464336076, 4937.481564435682, 4960.131976904027, 4963.255511673206, 10245.897541024644, 10294.124999375137, 10295.485225738683, 10319.0, 10327.84508232377, 5566.610337276352, 5578.553715702734, 5579.079451890474, 5585.58108141891, 5595.272614560163, 4518.796654150571, 5039.0, 5173.5602473789395, 5176.585873130216, 5204.9219261711105, 4038.656714179269, 4048.230836141183, 4080.5307389649975, 4082.510098788164, 4126.592278068541, 1186.5550418593027, 1189.3815216087587, 1198.7962046452124, 1202.963911082669, 1212.927224366541, 975.882894052704, 982.6167794560128, 1008.455434065611, 1020.8468729690605, 1030.7835354575473, 5925.644461332334, 6285.214348206474, 6347.079673447324, 6384.904226436514, 6412.2625898022325, 1027.9771627230953, 1049.8267785815256, 1096.1231015187977, 1102.1953973599157, 1105.4693747001324, 4302.44068271129, 4429.867103986886, 4437.822487100544, 4459.0858873930765, 4510.0528888933695, 11023.61417350405, 11174.0, 11196.160287978435, 11251.09991200702, 11303.039241664386, 10946.233763636468, 11172.162087843444, 11191.888081119247, 11230.606928757617, 11234.831477527843, 8367.205115514016, 8748.69379571712, 8752.343574231958, 8906.109389061043, 8931.821363572692, 6233.470155036873, 6430.099786030053, 6457.321981192095, 6496.317886622026, 6538.051982462422, 10642.787144257227, 10810.51352689115, 10895.291806032583, 10914.781704366027, 10971.615993440191, 10867.836982445428, 10890.074343680875, 11135.944320278672, 11197.60808371703, 11242.325460472397, 7454.776356709307, 7664.156942736183, 7881.093674227537, 8226.30076443509, 8392.790180245298, 9034.412763170372, 9074.682386116454, 9135.858017747782, 9167.17495425415, 9177.357584969255, 7679.846403071795, 7850.332721718718, 7972.920270797218, 8036.598170091589, 8112.43212975086, 8105.432619716563, 8110.83778324442, 8144.674213031412, 8248.0, 8320.583970801315, 7340.743073992385, 7346.33882950537, 7480.588567628833, 7619.314261716472, 7674.577898215652, 5474.151506516497, 5511.200875873056, 5547.029269877675, 5611.214429979887, 5705.144228365778, 5571.470710282517, 5593.972030139986, 5614.803481878114, 5640.069388551007, 5641.60835675692], "value": 4885.82037191846, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.0149222310889, 337.7230670849901, 340.10213037580786, 340.7614669731189, 346.8040557085247, 5318.441563635821, 5406.216098665701, 5476.671399716015, 5549.528290095342, 5579.274694289747, 5372.54333381663, 5391.353037635489, 5398.78404863805, 5492.697901615409, 5517.586181036429, 4292.248856450125, 4306.504751953518, 4318.632916202127, 4340.435743353375, 4346.565343465644, 4219.156168766243, 4343.891402714926, 4357.847475338363, 4358.43340365752, 4379.102284031782, 4267.701260911737, 4288.463942007249, 4289.541555871003, 4290.077633308838, 4301.741895486281, 4299.591538803808, 4302.41917341158, 4303.0, 4319.200947824646, 4345.891352716191, 3735.514383130203, 3871.5354157500997, 3873.65137137659, 3880.0105972976994, 3882.864099756523, 5270.947290527084, 5274.551663108602, 5278.366596008465, 5279.700187382886, 5312.0, 4884.5848102911295, 4915.181382888319, 4916.1888288432365, 4928.950710492885, 4935.0, 5481.725913704299, 5693.857653558653, 5699.772009119631, 5737.799177028825, 5761.279840019997, 4169.2703776838935, 4204.2432362174795, 4211.789410529492, 4220.388043733672, 4221.767802770846, 5916.467517923407, 5933.7329820157765, 5939.970300148471, 5972.552058595579, 6024.518038556905, 4128.504579450485, 4224.155168966157, 4238.87283381499, 4247.745135291892, 4290.2706539888295, 4291.29193683045, 4330.938919964566, 4337.9132417351475, 4353.172897149531, 4372.344148377705, 4905.9754701226975, 4913.803447862046, 4921.163402221631, 4941.703497790144, 4964.801407943714, 5648.830535083954, 5757.96356655806, 5763.942360576424, 5792.333881603585, 5834.395541226112, 1483.5326872035275, 1493.2459108150315, 1499.430216517738, 1504.473434298009, 1505.1721553145726, 974.3131092579714, 984.2027957354566, 1006.6225165562914, 1009.5507499162802, 1009.7778488732467, 5115.335006449138, 5120.129577971754, 5131.179011358165, 5149.201873709581, 5158.6131040171385, 5203.661761985459, 5328.333958255218, 5330.147176451749, 5350.38470575881, 5351.438098999627, 4831.371921650163, 5079.415867175248, 5127.359080114986, 5135.97432012845, 5167.534921856975, 2808.2838876086876, 2871.798974071795, 2874.3676391193903, 2875.7843161762953, 2887.6534815821815, 5376.327959005124, 5453.481919217668, 5481.698506582176, 5495.835124946258, 5530.917036244459, 5148.932343448709, 5273.288106105627, 5276.419593844674, 5358.071094406011, 5406.675599463966, 5359.464053594609, 5391.598184472065, 5409.377921538995, 5440.945590544044, 5471.112466199234, 4853.854384368475, 5148.3564554430695, 5192.870178245574, 5201.219817027476, 5205.3753549572775, 5120.795168193379, 5150.8322381734215, 5166.405863325615, 5202.791888324425, 5209.244659524424, 5446.0, 5503.614746967834, 5503.807366742145, 5518.310211223597, 5551.750171242385, 3979.243943650697, 4179.916401672011, 4278.251306021496, 4285.550017248144, 4291.678124140764, 5853.824385268449, 5885.705714714333, 5885.94114058871, 5909.438603332676, 5930.495907847881, 5582.27430434041, 5636.278764885102, 5655.802046928337, 5663.461971112738, 5727.8854422912145, 5678.517326027169, 5685.573581981285, 5692.601517893708, 5714.971425142848, 5740.827775166752, 5567.693776842312, 5589.037809960727, 5592.748326325243, 5607.794324220312, 5632.380438151718, 5432.728363581884, 5638.182463542846, 5767.480926716616, 5828.59199856006, 5845.3570107289015, 5640.830775076754, 5679.943200567942, 5706.229658995982, 5710.172025056427, 5716.342620598518], "value": 4272.288614081857, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.2084987986593, 843.5276245302629, 852.1606217875395, 854.3080105114857, 855.5850412549912, 13304.866951330483, 13893.434265563863, 14032.438702451915, 14099.647508812272, 14133.152010879341, 13030.218186908793, 13181.670458238548, 13214.20714757113, 13258.469661213565, 13274.0, 793.6944276453578, 804.1074407407773, 806.3992325717348, 808.9676412943504, 809.6639894443799, 797.103258833812, 802.8715405535115, 803.5540275147291, 804.7103042904549, 809.3969992355674, 833.0960907415462, 837.4054421360842, 837.5728378526965, 840.705752986456, 841.9873701894477, 821.9712310069119, 831.4844796226317, 833.7790485521342, 837.8785076163983, 837.9078301386843, 603.0532064658488, 607.1257389359308, 607.9483243924271, 609.0620444515441, 609.2780055634088, 13869.583912482642, 13882.930585347009, 13905.860941390558, 13917.721645567031, 13923.164610123426, 13898.444062237499, 14066.999999999898, 14073.5074272401, 14078.0, 14167.0, 11555.19113662044, 11635.534578616845, 11713.121515886343, 11717.355545444998, 12152.817707734392, 3800.6959443244473, 3845.4616353710503, 3863.265979463893, 3865.6520913117956, 4020.2160578687167, 55956.440435595934, 57142.42857571454, 57318.42681573173, 57336.0, 57530.42469575335, 9518.619255229853, 9618.615255389846, 9660.71017869465, 9706.9029309706, 9850.064243896819, 19330.323438679578, 19408.61182776365, 19463.416097517096, 19480.70778938317, 19484.318048868223, 7838.725644602411, 7860.449768516149, 7869.48848324857, 8006.959965200137, 8014.118446970829, 4525.886852828706, 4534.614557762628, 4545.659075569345, 4656.627469802475, 4717.363155973968, 3390.355832391838, 3535.876244331436, 3546.29074185164, 3547.2018795770746, 3551.360755064113, 639.4724352409281, 641.1760887259942, 643.411278680012, 646.8997305417668, 655.0370954696589, 747.3535391885979, 765.9004329437249, 781.7459325719165, 788.9842203155905, 795.5584650519017, 9047.728568142966, 9643.373180743229, 9732.610695572239, 9759.951200243953, 9831.0, 687.2508965227926, 741.2661465149463, 761.9238076192447, 772.1390649425962, 774.8566515194594, 4379.759113248738, 4430.667699922518, 4451.265541185733, 4470.955290447119, 4621.491635920046, 65711.34288657148, 67188.63273887182, 68446.65776671085, 68802.65598671975, 68823.65588172027, 60542.394576054554, 60694.0, 61012.69493652503, 61097.38902610917, 62171.0, 54795.90408191814, 55058.44941550613, 55461.44538554644, 55472.16791748127, 55935.0, 8790.120987901159, 8863.64545418176, 8866.202041816268, 8957.865632015655, 8969.461832290084, 37237.25525489421, 37258.25483490261, 37629.247415052094, 37652.05869853166, 37732.43401348927, 46444.0, 49163.75418122886, 49314.0, 49469.25796112989, 50438.0, 11337.659870203906, 11352.375619341015, 11408.885911140782, 11493.195476316578, 11801.881981180422, 11599.8260026098, 11782.561253844136, 11999.0, 12165.878341216829, 12573.811392828931, 11195.440227988405, 11502.252353596989, 11889.881101188877, 12454.937725311316, 12747.235165889706, 10714.250002500063, 11127.0, 11134.0, 11472.655820325404, 11847.407629618312, 11342.376169310766, 11640.708982275512, 11691.240069395462, 11883.287002779862, 12034.0, 9511.524423778921, 9744.17174540172, 9894.356866803635, 10051.095401413908, 10129.139023182817, 9907.207423405966, 10002.349847259904, 10083.647072352433, 10158.542865571215, 10163.339382940085], "value": 6740.370390624108, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 111.0, 111.0, 111.0, 112.0, 111.0, 110.0, 110.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 151.0, 178.0, 127.0, 161.0, 154.0, 129.0, 205.0, 126.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 163.0, 164.0, 176.0, 163.0, 162.0, 163.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 152.0, 75.0, 76.0, 75.0, 75.0, 161.0, 74.0], "value": 91.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 153.0, 93.0, 93.0, 93.0, 145.0, 92.0, 94.0, 163.0], "value": 111.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 150.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 59.0, 54.0, 55.0, 54.0, 55.0, 85.0, 56.0, 52.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 68.0, 62.0, 62.0, 61.0, 64.0, 61.0, 62.0, 62.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 84.0, 79.0, 78.0, 82.0, 85.0, 81.0, 80.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 131.0, 128.0, 119.0, 132.0, 119.0, 120.0, 118.0, 168.0, 134.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 166.0, 168.0, 162.0, 158.0, 161.0, 162.0, 158.0, 158.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 71.0, 63.0, 61.0, 62.0, 62.0, 63.0, 62.0, 62.0, 61.0], "value": 62.9, "unit": "score"}]}]} 07:31:22 INFO - Return code: 0 07:31:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:31:22 ERROR - # TBPL SUCCESS # 07:31:22 INFO - Running post-action listener: _resource_record_post_action 07:31:22 INFO - ##### 07:31:22 INFO - ##### Finished run-tests step (success) 07:31:22 INFO - ##### 07:31:22 INFO - Running post-run listener: _resource_record_post_run 07:31:22 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545599488; Read time: 8; Write time: 493744 07:31:22 INFO - TinderboxPrint: CPU usage
13.4% 07:31:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 07:31:22 INFO - TinderboxPrint: I/O write bytes / time
545,599,488 / 493,744 07:31:22 INFO - TinderboxPrint: CPU idle
8,225.9 (86.5%) 07:31:22 INFO - TinderboxPrint: CPU user
1,226.6 (12.9%) 07:31:22 INFO - TinderboxPrint: Swap in / out
0 / 0 07:31:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247136256; Read time: 0; Write time: 217392 07:31:22 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298463232; Read time: 8; Write time: 276352 07:31:23 INFO - Running post-run listener: _upload_blobber_files 07:31:23 INFO - Blob upload gear active. 07:31:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:31:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:31:23 INFO - (blobuploader) - INFO - Open directory for files ... 07:31:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:31:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:31:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:28 INFO - (blobuploader) - INFO - Done attempting. 07:31:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:31:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:31:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:28 INFO - (blobuploader) - INFO - Done attempting. 07:31:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:31:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:31:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:29 INFO - (blobuploader) - INFO - Done attempting. 07:31:29 INFO - (blobuploader) - INFO - Iteration through files over. 07:31:29 INFO - Return code: 0 07:31:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:31:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:31:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7522b79ef19417dc2384a3c06164743c3de369e53bcc53a5ad8b81d94f897d63cc5d2fb21f67b267d43392c8a3cd57ae3246510a2c089a1769a9765a49f06b3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b60e60725d994717a9f1fd58af6ee3195abf4fdbb3537c9bb10d0b632a2f815890780efb5086d4b37f8a5f7ae766a0858cdba0a3f443d46b7b84485f3b6cf74c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/270c18a499593e7707c3a96ef7f5b2eba89ae5237969b862318132743193ae4acc726b8a3b4f910d75534ea9d3075184c5c487ec7cd5f71f37fbd11265b34d01"} 07:31:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:31:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:31:29 INFO - Contents: 07:31:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7522b79ef19417dc2384a3c06164743c3de369e53bcc53a5ad8b81d94f897d63cc5d2fb21f67b267d43392c8a3cd57ae3246510a2c089a1769a9765a49f06b3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b60e60725d994717a9f1fd58af6ee3195abf4fdbb3537c9bb10d0b632a2f815890780efb5086d4b37f8a5f7ae766a0858cdba0a3f443d46b7b84485f3b6cf74c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/270c18a499593e7707c3a96ef7f5b2eba89ae5237969b862318132743193ae4acc726b8a3b4f910d75534ea9d3075184c5c487ec7cd5f71f37fbd11265b34d01"} 07:31:29 INFO - Running post-run listener: copy_logs_to_upload_dir 07:31:29 INFO - Copying logs to upload dir... 07:31:29 INFO - mkdir: /builds/slave/test/build/upload/logs 07:31:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.460186 ========= master_lag: 84.86 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2016-05-23 07:32:54.412608) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 07:32:54.416120) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116 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/7522b79ef19417dc2384a3c06164743c3de369e53bcc53a5ad8b81d94f897d63cc5d2fb21f67b267d43392c8a3cd57ae3246510a2c089a1769a9765a49f06b3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b60e60725d994717a9f1fd58af6ee3195abf4fdbb3537c9bb10d0b632a2f815890780efb5086d4b37f8a5f7ae766a0858cdba0a3f443d46b7b84485f3b6cf74c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/270c18a499593e7707c3a96ef7f5b2eba89ae5237969b862318132743193ae4acc726b8a3b4f910d75534ea9d3075184c5c487ec7cd5f71f37fbd11265b34d01"} build_url:https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011384 build_url: 'https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/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/7522b79ef19417dc2384a3c06164743c3de369e53bcc53a5ad8b81d94f897d63cc5d2fb21f67b267d43392c8a3cd57ae3246510a2c089a1769a9765a49f06b3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b60e60725d994717a9f1fd58af6ee3195abf4fdbb3537c9bb10d0b632a2f815890780efb5086d4b37f8a5f7ae766a0858cdba0a3f443d46b7b84485f3b6cf74c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/270c18a499593e7707c3a96ef7f5b2eba89ae5237969b862318132743193ae4acc726b8a3b4f910d75534ea9d3075184c5c487ec7cd5f71f37fbd11265b34d01"}' ========= master_lag: 0.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 07:32:54.590136) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:32:54.590445) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464006439.459790-1019345116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004669 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:32:54.633279) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 07:32:54.633546) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 07:32:55.171619) ========= ========= Total master_lag: 85.13 =========