builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1463063112.11 results: success (0) buildid: 20160512043110 builduid: 99f5a735d5374a5cbd2a3e955452512f revision: 6f5d73b492f87b0594536c5d4116610b56617277 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 07:25:12.109225) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 07:25:12.109699) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 07:25:12.109983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 07:25:12.127524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 07:25:12.127859) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 07:25:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.8M=0s 2016-05-12 07:25:12 (37.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083739 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 07:25:12.224368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 07:25:12.224675) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013593 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 07:25:12.274029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 07:25:12.274367) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6f5d73b492f87b0594536c5d4116610b56617277 --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 6f5d73b492f87b0594536c5d4116610b56617277 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 07:25:13,114 truncating revision to first 12 chars 2016-05-12 07:25:13,114 Setting DEBUG logging. 2016-05-12 07:25:13,114 attempt 1/10 2016-05-12 07:25:13,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/6f5d73b492f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 07:25:14,232 unpacking tar archive at: mozilla-inbound-6f5d73b492f8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.408301 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 07:25:13.695886) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 07:25:13.696226) ========= script_repo_revision: 6f5d73b492f87b0594536c5d4116610b56617277 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 07:25:13.696659) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 07:25:13.696929) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 07:25:13.705676) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-05-12 07:25:13.705975) ========= /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=337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:25:14 INFO - MultiFileLogger online at 20160512 07:25:14 in /builds/slave/test 07:25:14 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:25:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:25:14 INFO - {'append_to_log': False, 07:25:14 INFO - 'base_work_dir': '/builds/slave/test', 07:25:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:25:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:25:14 INFO - 'branch': 'Mozilla-Inbound', 07:25:14 INFO - 'buildbot_json_path': 'buildprops.json', 07:25:14 INFO - 'config_files': ('talos/linux_config.py',), 07:25:14 INFO - 'default_actions': ('clobber', 07:25:14 INFO - 'read-buildbot-config', 07:25:14 INFO - 'download-and-extract', 07:25:14 INFO - 'populate-webroot', 07:25:14 INFO - 'create-virtualenv', 07:25:14 INFO - 'install', 07:25:14 INFO - 'run-tests'), 07:25:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:25:14 INFO - 'download_minidump_stackwalk': True, 07:25:14 INFO - 'download_symbols': 'ondemand', 07:25:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:25:14 INFO - 'tooltool.py': '/tools/tooltool.py', 07:25:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:25:14 INFO - '/tools/misc-python/virtualenv.py')}, 07:25:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:25:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:25:14 INFO - 'installer_path': 'installer.exe', 07:25:14 INFO - 'log_level': 'info', 07:25:14 INFO - 'log_name': 'talos', 07:25:14 INFO - 'log_to_console': True, 07:25:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:25:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:25:14 INFO - 'opt_config_files': (), 07:25:14 INFO - 'pip_index': False, 07:25:14 INFO - 'sps_profile': False, 07:25:14 INFO - 'sps_profile_interval': 0, 07:25:14 INFO - 'suite': 'dromaeojs-e10s', 07:25:14 INFO - 'system_bits': '32', 07:25:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:25:14 INFO - 'title': 'talos-linux64-ix-060', 07:25:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:25:14 INFO - 'use_talos_json': True, 07:25:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:25:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:25:14 INFO - 'work_dir': 'build'} 07:25:14 INFO - ##### 07:25:14 INFO - ##### Running clobber step. 07:25:14 INFO - ##### 07:25:14 INFO - Running pre-action listener: _resource_record_pre_action 07:25:14 INFO - Running main action method: clobber 07:25:14 INFO - rmtree: /builds/slave/test/build 07:25:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:25:15 INFO - Running post-action listener: _resource_record_post_action 07:25:15 INFO - ##### 07:25:15 INFO - ##### Finished clobber step (success) 07:25:15 INFO - ##### 07:25:15 INFO - ##### 07:25:15 INFO - ##### Running read-buildbot-config step. 07:25:15 INFO - ##### 07:25:15 INFO - Running pre-action listener: _resource_record_pre_action 07:25:15 INFO - Running main action method: read_buildbot_config 07:25:15 INFO - Using buildbot properties: 07:25:15 INFO - { 07:25:15 INFO - "project": "", 07:25:15 INFO - "product": "firefox", 07:25:15 INFO - "script_repo_revision": "production", 07:25:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:25:15 INFO - "repository": "", 07:25:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:25:15 INFO - "buildid": "20160512043110", 07:25:15 INFO - "pgo_build": "True", 07:25:15 INFO - "basedir": "/builds/slave/test", 07:25:15 INFO - "buildnumber": 530, 07:25:15 INFO - "slavename": "talos-linux64-ix-060", 07:25:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:25:15 INFO - "platform": "ubuntu64_hw", 07:25:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:25:15 INFO - "branch": "mozilla-inbound", 07:25:15 INFO - "repo_path": "integration/mozilla-inbound", 07:25:15 INFO - "revision": "6f5d73b492f87b0594536c5d4116610b56617277", 07:25:15 INFO - "stage_platform": "linux64-pgo", 07:25:15 INFO - "builduid": "99f5a735d5374a5cbd2a3e955452512f", 07:25:15 INFO - "slavebuilddir": "test" 07:25:15 INFO - } 07:25:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:25:15 INFO - Running post-action listener: _resource_record_post_action 07:25:15 INFO - ##### 07:25:15 INFO - ##### Finished read-buildbot-config step (success) 07:25:15 INFO - ##### 07:25:15 INFO - ##### 07:25:15 INFO - ##### Running download-and-extract step. 07:25:15 INFO - ##### 07:25:15 INFO - Running pre-action listener: _resource_record_pre_action 07:25:15 INFO - Running main action method: download_and_extract 07:25:15 INFO - mkdir: /builds/slave/test/build/tests 07:25:15 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:25:15 INFO - https://queue.taskcluster.net/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:25:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:25:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:25:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/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:25:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/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:25:15 INFO - Downloaded 1361 bytes. 07:25:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:25:15 INFO - Using the following test package requirements: 07:25:15 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:25:15 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:25:15 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:25:15 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:15 INFO - u'jsshell-linux-x86_64.zip'], 07:25:15 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:25:15 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:25:15 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:25:15 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:25:15 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:25:15 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:25:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:25:15 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:25:15 INFO - https://queue.taskcluster.net/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:25:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:25:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:25:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/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:25:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/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:25:17 INFO - Downloaded 23904064 bytes. 07:25:17 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:25:17 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:25:18 INFO - Return code: 0 07:25:18 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:25: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:25:18 INFO - https://queue.taskcluster.net/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:25:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:25:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:25:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/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:25:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/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:25:19 INFO - Downloaded 23904064 bytes. 07:25:19 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:25:19 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:25:21 INFO - Return code: 0 07:25: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:25:21 INFO - https://queue.taskcluster.net/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:25:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:25:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:25:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/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:25:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/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:25:22 INFO - Downloaded 10840239 bytes. 07:25:22 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:25:22 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:25:22 INFO - Return code: 0 07:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:22 INFO - https://queue.taskcluster.net/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:25:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:25:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:25:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/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:25:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFNGOwmUSQGMJSOn_ClBKw/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:25:23 INFO - Downloaded 58338918 bytes. 07:25:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:25:23 INFO - mkdir: /builds/slave/test/properties 07:25:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:25:23 INFO - Writing to file /builds/slave/test/properties/build_url 07:25:23 INFO - Contents: 07:25:23 INFO - build_url:https://queue.taskcluster.net/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:25:24 INFO - Running post-action listener: _resource_record_post_action 07:25:24 INFO - Running post-action listener: set_extra_try_arguments 07:25:24 INFO - ##### 07:25:24 INFO - ##### Finished download-and-extract step (success) 07:25:24 INFO - ##### 07:25:24 INFO - ##### 07:25:24 INFO - ##### Running populate-webroot step. 07:25:24 INFO - ##### 07:25:24 INFO - Running pre-action listener: _resource_record_pre_action 07:25:24 INFO - Running main action method: populate_webroot 07:25:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:25:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:25:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:25:24 INFO - '--tppagecycles', 07:25:24 INFO - '7'], 07:25:24 INFO - 'tests': ['tsvgm']}}, 07:25:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:25:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:25:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:25:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:25:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:25:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:25:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:24 INFO - 'talos_options': ['--disable-e10s'], 07:25:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:24 INFO - 'talos_options': ['--disable-e10s'], 07:25:24 INFO - 'tests': ['damp', 'tps']}, 07:25:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:24 INFO - 'tests': ['damp', 'tps']}, 07:25:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:25:24 INFO - 'tests': ['dromaeo_dom']}, 07:25:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:25:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:25:24 INFO - 'tests': ['a11yr', 07:25:24 INFO - 'ts_paint', 07:25:24 INFO - 'tpaint', 07:25:24 INFO - 'sessionrestore', 07:25:24 INFO - 'sessionrestore_no_auto_restore', 07:25:24 INFO - 'tabpaint']}, 07:25:24 INFO - 'other-e10s': {'tests': ['a11yr', 07:25:24 INFO - 'ts_paint', 07:25:24 INFO - 'tpaint', 07:25:24 INFO - 'sessionrestore', 07:25:24 INFO - 'sessionrestore_no_auto_restore', 07:25:24 INFO - 'tabpaint']}, 07:25:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:25:24 INFO - 'ts_paint', 07:25:24 INFO - 'tpaint', 07:25:24 INFO - 'sessionrestore', 07:25:24 INFO - 'sessionrestore_no_auto_restore', 07:25:24 INFO - 'tabpaint']}, 07:25:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:25:24 INFO - 'ts_paint', 07:25:24 INFO - 'tpaint', 07:25:24 INFO - 'sessionrestore', 07:25:24 INFO - 'sessionrestore_no_auto_restore', 07:25:24 INFO - 'tabpaint']}, 07:25:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:25:24 INFO - 'tests': ['a11yr', 07:25:24 INFO - 'ts_paint', 07:25:24 INFO - 'tpaint', 07:25:24 INFO - 'sessionrestore', 07:25:24 INFO - 'sessionrestore_no_auto_restore', 07:25:24 INFO - 'tabpaint']}, 07:25:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:25:24 INFO - 'tests': ['a11yr', 07:25:24 INFO - 'ts_paint', 07:25:24 INFO - 'tpaint', 07:25:24 INFO - 'sessionrestore', 07:25:24 INFO - 'sessionrestore_no_auto_restore', 07:25:24 INFO - 'tabpaint']}, 07:25:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:25:24 INFO - 'tests': ['tsvgx', 07:25:24 INFO - 'tsvgr_opacity', 07:25:24 INFO - 'tart', 07:25:24 INFO - 'tscrollx', 07:25:24 INFO - 'cart']}, 07:25:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:25:24 INFO - 'tsvgr_opacity', 07:25:24 INFO - 'tart', 07:25:24 INFO - 'tscrollx', 07:25:24 INFO - 'cart']}, 07:25:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:24 INFO - 'talos_options': ['--disable-e10s'], 07:25:24 INFO - 'tests': ['tp5o']}, 07:25:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:24 INFO - 'tests': ['tp5o']}, 07:25:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:24 INFO - 'talos_options': ['--disable-e10s', 07:25:24 INFO - '--xperf_path', 07:25:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:24 INFO - 'tests': ['tp5n']}, 07:25:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:24 INFO - 'talos_options': ['--xperf_path', 07:25:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:24 INFO - 'tests': ['tp5n']}}, 07:25:24 INFO - 'talos.zip': {'path': '', 07:25:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:25:24 INFO - Running post-action listener: _resource_record_post_action 07:25:24 INFO - ##### 07:25:24 INFO - ##### Finished populate-webroot step (success) 07:25:24 INFO - ##### 07:25:24 INFO - ##### 07:25:24 INFO - ##### Running create-virtualenv step. 07:25:24 INFO - ##### 07:25:24 INFO - Running pre-action listener: _resource_record_pre_action 07:25:24 INFO - Running main action method: create_virtualenv 07:25:24 INFO - Creating virtualenv /builds/slave/test/build/venv 07:25:24 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:25:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:25:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:25:24 INFO - Using real prefix '/usr' 07:25:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:25:25 INFO - Installing distribute.............................................................................................................................................................................................done. 07:25:27 INFO - Installing pip.................done. 07:25:27 INFO - Return code: 0 07:25:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:25:27 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:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:27 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:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:27 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 0x7f7883f31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b20>, '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 0x1ef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', '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:25:27 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:25:27 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:25:27 INFO - Using env: {'DISPLAY': ':0', 07:25:27 INFO - 'HOME': '/home/cltbld', 07:25:27 INFO - 'LANG': 'en_US.UTF-8', 07:25:27 INFO - 'LANGUAGE': 'en_US:en', 07:25:27 INFO - 'LOGNAME': 'cltbld', 07:25:27 INFO - 'MAIL': '/var/mail/cltbld', 07:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:27 INFO - 'MOZ_NO_REMOTE': '1', 07:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:27 INFO - 'NO_EM_RESTART': '1', 07:25:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:27 INFO - 'PWD': '/builds/slave/test', 07:25:27 INFO - 'SHELL': '/bin/bash', 07:25:27 INFO - 'SHLVL': '1', 07:25:27 INFO - 'TERM': 'linux', 07:25:27 INFO - 'TMOUT': '86400', 07:25:27 INFO - 'USER': 'cltbld', 07:25:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', 07:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:27 INFO - '_': '/tools/buildbot/bin/python'} 07:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:27 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:25:27 INFO - Cleaning up... 07:25:27 INFO - Return code: 0 07:25:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:25:27 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:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:27 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:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:27 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7883f31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b20>, '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 0x1ef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', '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:25:27 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>=0.7.1'] in /builds/slave/test/build 07:25:27 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>=0.7.1 07:25:27 INFO - Using env: {'DISPLAY': ':0', 07:25:27 INFO - 'HOME': '/home/cltbld', 07:25:27 INFO - 'LANG': 'en_US.UTF-8', 07:25:27 INFO - 'LANGUAGE': 'en_US:en', 07:25:27 INFO - 'LOGNAME': 'cltbld', 07:25:27 INFO - 'MAIL': '/var/mail/cltbld', 07:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:27 INFO - 'MOZ_NO_REMOTE': '1', 07:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:27 INFO - 'NO_EM_RESTART': '1', 07:25:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:27 INFO - 'PWD': '/builds/slave/test', 07:25:27 INFO - 'SHELL': '/bin/bash', 07:25:27 INFO - 'SHLVL': '1', 07:25:27 INFO - 'TERM': 'linux', 07:25:27 INFO - 'TMOUT': '86400', 07:25:27 INFO - 'USER': 'cltbld', 07:25:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', 07:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:27 INFO - '_': '/tools/buildbot/bin/python'} 07:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:27 INFO - Downloading/unpacking psutil>=0.7.1 07:25: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:25: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:25: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:25: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:25: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:25: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:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:25:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:29 INFO - Installing collected packages: psutil 07:25:29 INFO - Running setup.py install for psutil 07:25:29 INFO - building 'psutil._psutil_linux' extension 07:25:29 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:25:29 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:25:29 INFO - building 'psutil._psutil_posix' extension 07:25:29 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:25:30 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:25:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:30 INFO - Successfully installed psutil 07:25:30 INFO - Cleaning up... 07:25:30 INFO - Return code: 0 07:25:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:25:30 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:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:30 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:25:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:30 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7883f31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b20>, '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 0x1ef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', '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:25:30 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.0.0'] in /builds/slave/test/build 07:25:30 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.0.0 07:25:30 INFO - Using env: {'DISPLAY': ':0', 07:25:30 INFO - 'HOME': '/home/cltbld', 07:25:30 INFO - 'LANG': 'en_US.UTF-8', 07:25:30 INFO - 'LANGUAGE': 'en_US:en', 07:25:30 INFO - 'LOGNAME': 'cltbld', 07:25:30 INFO - 'MAIL': '/var/mail/cltbld', 07:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:30 INFO - 'MOZ_NO_REMOTE': '1', 07:25:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:30 INFO - 'NO_EM_RESTART': '1', 07:25:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:30 INFO - 'PWD': '/builds/slave/test', 07:25:30 INFO - 'SHELL': '/bin/bash', 07:25:30 INFO - 'SHLVL': '1', 07:25:30 INFO - 'TERM': 'linux', 07:25:30 INFO - 'TMOUT': '86400', 07:25:30 INFO - 'USER': 'cltbld', 07:25:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', 07:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:30 INFO - '_': '/tools/buildbot/bin/python'} 07:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:25: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:25: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:25: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:25: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:25: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:25: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:25:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:25:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:25:32 INFO - Installing collected packages: mozsystemmonitor 07:25:32 INFO - Running setup.py install for mozsystemmonitor 07:25:32 INFO - Successfully installed mozsystemmonitor 07:25:32 INFO - Cleaning up... 07:25:32 INFO - Return code: 0 07:25:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:32 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 0x7f7883f31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b20>, '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 0x1ef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', '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:25:32 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:25:32 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:25:32 INFO - Using env: {'DISPLAY': ':0', 07:25:32 INFO - 'HOME': '/home/cltbld', 07:25:32 INFO - 'LANG': 'en_US.UTF-8', 07:25:32 INFO - 'LANGUAGE': 'en_US:en', 07:25:32 INFO - 'LOGNAME': 'cltbld', 07:25:32 INFO - 'MAIL': '/var/mail/cltbld', 07:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:32 INFO - 'MOZ_NO_REMOTE': '1', 07:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:32 INFO - 'NO_EM_RESTART': '1', 07:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:32 INFO - 'PWD': '/builds/slave/test', 07:25:32 INFO - 'SHELL': '/bin/bash', 07:25:32 INFO - 'SHLVL': '1', 07:25:32 INFO - 'TERM': 'linux', 07:25:32 INFO - 'TMOUT': '86400', 07:25:32 INFO - 'USER': 'cltbld', 07:25:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', 07:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:32 INFO - '_': '/tools/buildbot/bin/python'} 07:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:32 INFO - Downloading/unpacking blobuploader==1.2.4 07:25:32 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:25:32 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:25:32 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:25:32 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:25:32 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:25:32 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:25:34 INFO - Downloading blobuploader-1.2.4.tar.gz 07:25:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:25:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:25:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:25:35 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:25:35 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:25:35 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:25:35 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:25:35 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:25:35 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:25:35 INFO - Downloading docopt-0.6.1.tar.gz 07:25:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:25:35 INFO - Installing collected packages: blobuploader, requests, docopt 07:25:35 INFO - Running setup.py install for blobuploader 07:25:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:25:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:25:35 INFO - Running setup.py install for requests 07:25:35 INFO - Running setup.py install for docopt 07:25:35 INFO - Successfully installed blobuploader requests docopt 07:25:35 INFO - Cleaning up... 07:25:35 INFO - Return code: 0 07:25:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:35 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:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:35 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:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:35 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 0x7f7883f31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b20>, '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 0x1ef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', '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:25:35 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:25:35 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:25:35 INFO - Using env: {'DISPLAY': ':0', 07:25:35 INFO - 'HOME': '/home/cltbld', 07:25:35 INFO - 'LANG': 'en_US.UTF-8', 07:25:35 INFO - 'LANGUAGE': 'en_US:en', 07:25:35 INFO - 'LOGNAME': 'cltbld', 07:25:35 INFO - 'MAIL': '/var/mail/cltbld', 07:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:35 INFO - 'MOZ_NO_REMOTE': '1', 07:25:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:35 INFO - 'NO_EM_RESTART': '1', 07:25:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:35 INFO - 'PWD': '/builds/slave/test', 07:25:35 INFO - 'SHELL': '/bin/bash', 07:25:35 INFO - 'SHLVL': '1', 07:25:35 INFO - 'TERM': 'linux', 07:25:35 INFO - 'TMOUT': '86400', 07:25:35 INFO - 'USER': 'cltbld', 07:25:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', 07:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:35 INFO - '_': '/tools/buildbot/bin/python'} 07:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:36 INFO - Running setup.py (path:/tmp/pip-Ulfelr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:36 INFO - Running setup.py (path:/tmp/pip-RivGSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:36 INFO - Running setup.py (path:/tmp/pip-Y4HKx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:36 INFO - Running setup.py (path:/tmp/pip-WCs5ZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:36 INFO - Running setup.py (path:/tmp/pip-unXBRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:36 INFO - Running setup.py (path:/tmp/pip-iafRcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:36 INFO - Running setup.py (path:/tmp/pip-YCVSpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:36 INFO - Running setup.py (path:/tmp/pip-Gv8CzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:36 INFO - Running setup.py (path:/tmp/pip-vmeIQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:36 INFO - Running setup.py (path:/tmp/pip-GnpaVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:36 INFO - Running setup.py (path:/tmp/pip-UZc363-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:36 INFO - Running setup.py (path:/tmp/pip-4VSkYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:37 INFO - Running setup.py (path:/tmp/pip-k3tIOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:37 INFO - Running setup.py (path:/tmp/pip-eYYaq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:37 INFO - Running setup.py (path:/tmp/pip-XvA8Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:37 INFO - Running setup.py (path:/tmp/pip-lyiBbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:37 INFO - Running setup.py (path:/tmp/pip-Dqtkri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:25:37 INFO - Running setup.py install for manifestparser 07:25:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:25:37 INFO - Running setup.py install for mozcrash 07:25:37 INFO - Running setup.py install for mozdebug 07:25:37 INFO - Running setup.py install for mozdevice 07:25:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:25:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:25:37 INFO - Running setup.py install for mozfile 07:25:37 INFO - Running setup.py install for mozhttpd 07:25:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:25:37 INFO - Running setup.py install for mozinfo 07:25:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:25:38 INFO - Running setup.py install for mozInstall 07:25:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:25:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:25:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:25:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:25:38 INFO - Running setup.py install for mozleak 07:25:38 INFO - Running setup.py install for mozlog 07:25:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:25:38 INFO - Running setup.py install for moznetwork 07:25:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:25:38 INFO - Running setup.py install for mozprocess 07:25:38 INFO - Running setup.py install for mozprofile 07:25:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:25:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:25:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:25:38 INFO - Running setup.py install for mozrunner 07:25:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:25:38 INFO - Running setup.py install for mozscreenshot 07:25:38 INFO - Running setup.py install for moztest 07:25:39 INFO - Running setup.py install for mozversion 07:25:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:25:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:25:39 INFO - Cleaning up... 07:25:39 INFO - Return code: 0 07:25:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:39 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 0x7f7883f31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b20>, '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 0x1ef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', '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:25:39 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:25:39 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:25:39 INFO - Using env: {'DISPLAY': ':0', 07:25:39 INFO - 'HOME': '/home/cltbld', 07:25:39 INFO - 'LANG': 'en_US.UTF-8', 07:25:39 INFO - 'LANGUAGE': 'en_US:en', 07:25:39 INFO - 'LOGNAME': 'cltbld', 07:25:39 INFO - 'MAIL': '/var/mail/cltbld', 07:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:39 INFO - 'MOZ_NO_REMOTE': '1', 07:25:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:39 INFO - 'NO_EM_RESTART': '1', 07:25:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:39 INFO - 'PWD': '/builds/slave/test', 07:25:39 INFO - 'SHELL': '/bin/bash', 07:25:39 INFO - 'SHLVL': '1', 07:25:39 INFO - 'TERM': 'linux', 07:25:39 INFO - 'TMOUT': '86400', 07:25:39 INFO - 'USER': 'cltbld', 07:25:39 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', 07:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:39 INFO - '_': '/tools/buildbot/bin/python'} 07:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:39 INFO - Running setup.py (path:/tmp/pip-sNRwS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:39 INFO - Running setup.py (path:/tmp/pip-ojKkKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:39 INFO - Running setup.py (path:/tmp/pip-YDgcOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:39 INFO - Running setup.py (path:/tmp/pip-LoNSX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:39 INFO - Running setup.py (path:/tmp/pip-MP0xZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:39 INFO - Running setup.py (path:/tmp/pip-m4Zlcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:39 INFO - Running setup.py (path:/tmp/pip-1ChEom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:39 INFO - Running setup.py (path:/tmp/pip-6YUyTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:39 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:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:39 INFO - Running setup.py (path:/tmp/pip-RXuaUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:40 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:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:40 INFO - Running setup.py (path:/tmp/pip-yuOct5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:40 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:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:40 INFO - Running setup.py (path:/tmp/pip-4VkJS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:40 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:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:40 INFO - Running setup.py (path:/tmp/pip-VuHXHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:40 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:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:40 INFO - Running setup.py (path:/tmp/pip-0n9UmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:40 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:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:40 INFO - Running setup.py (path:/tmp/pip-ZIzGuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:40 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:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:40 INFO - Running setup.py (path:/tmp/pip-ocULeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:40 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:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:40 INFO - Running setup.py (path:/tmp/pip-NsFSfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:40 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:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:40 INFO - Running setup.py (path:/tmp/pip-mh_XtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:40 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:25:40 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:25:40 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:25:40 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:25:40 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:25:40 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:25:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:42 INFO - Downloading blessings-1.6.tar.gz 07:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:25:42 INFO - Installing collected packages: blessings 07:25:42 INFO - Running setup.py install for blessings 07:25:42 INFO - Successfully installed blessings 07:25:42 INFO - Cleaning up... 07:25:42 INFO - Return code: 0 07:25:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:25:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:42 INFO - Reading from file tmpfile_stdout 07:25:42 INFO - Current package versions: 07:25:42 INFO - argparse == 1.2.1 07:25:42 INFO - blessings == 1.6 07:25:42 INFO - blobuploader == 1.2.4 07:25:42 INFO - docopt == 0.6.1 07:25:42 INFO - manifestparser == 1.1 07:25:42 INFO - mozInstall == 1.12 07:25:42 INFO - mozcrash == 0.17 07:25:42 INFO - mozdebug == 0.1 07:25:42 INFO - mozdevice == 0.48 07:25:42 INFO - mozfile == 1.2 07:25:42 INFO - mozhttpd == 0.7 07:25:42 INFO - mozinfo == 0.9 07:25:42 INFO - mozleak == 0.1 07:25:42 INFO - mozlog == 3.2 07:25:42 INFO - moznetwork == 0.27 07:25:42 INFO - mozprocess == 0.22 07:25:42 INFO - mozprofile == 0.28 07:25:42 INFO - mozrunner == 6.11 07:25:42 INFO - mozscreenshot == 0.1 07:25:42 INFO - mozsystemmonitor == 0.0 07:25:42 INFO - moztest == 0.7 07:25:42 INFO - mozversion == 1.4 07:25:42 INFO - psutil == 3.1.1 07:25:42 INFO - requests == 1.2.3 07:25:42 INFO - wsgiref == 0.1.2 07:25:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:42 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 0x7f7883f31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b20>, '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 0x1ef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', '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:25:42 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:25:42 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:25:42 INFO - Using env: {'DISPLAY': ':0', 07:25:42 INFO - 'HOME': '/home/cltbld', 07:25:42 INFO - 'LANG': 'en_US.UTF-8', 07:25:42 INFO - 'LANGUAGE': 'en_US:en', 07:25:42 INFO - 'LOGNAME': 'cltbld', 07:25:42 INFO - 'MAIL': '/var/mail/cltbld', 07:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:42 INFO - 'MOZ_NO_REMOTE': '1', 07:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:42 INFO - 'NO_EM_RESTART': '1', 07:25:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:42 INFO - 'PWD': '/builds/slave/test', 07:25:42 INFO - 'SHELL': '/bin/bash', 07:25:42 INFO - 'SHLVL': '1', 07:25:42 INFO - 'TERM': 'linux', 07:25:42 INFO - 'TMOUT': '86400', 07:25:42 INFO - 'USER': 'cltbld', 07:25:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', 07:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:42 INFO - '_': '/tools/buildbot/bin/python'} 07:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:43 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:25:43 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:25:43 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:25:43 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:25:43 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:25:43 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:25:43 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:25:43 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:25:43 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:25:43 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:25:43 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:25:43 INFO - Cleaning up... 07:25:43 INFO - Return code: 0 07:25:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:25:43 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:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:43 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:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:43 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 0x7f7883f31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b20>, '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 0x1ef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', '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:25:43 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:25:43 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:25:43 INFO - Using env: {'DISPLAY': ':0', 07:25:43 INFO - 'HOME': '/home/cltbld', 07:25:43 INFO - 'LANG': 'en_US.UTF-8', 07:25:43 INFO - 'LANGUAGE': 'en_US:en', 07:25:43 INFO - 'LOGNAME': 'cltbld', 07:25:43 INFO - 'MAIL': '/var/mail/cltbld', 07:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:43 INFO - 'MOZ_NO_REMOTE': '1', 07:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:43 INFO - 'NO_EM_RESTART': '1', 07:25:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:43 INFO - 'PWD': '/builds/slave/test', 07:25:43 INFO - 'SHELL': '/bin/bash', 07:25:43 INFO - 'SHLVL': '1', 07:25:43 INFO - 'TERM': 'linux', 07:25:43 INFO - 'TMOUT': '86400', 07:25:43 INFO - 'USER': 'cltbld', 07:25:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', 07:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:43 INFO - '_': '/tools/buildbot/bin/python'} 07:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:43 INFO - Downloading/unpacking jsonschema 07:25:43 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:25:43 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:25:43 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:25:43 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:25:43 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:25:43 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:25:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:25:45 INFO - Downloading/unpacking functools32 (from jsonschema) 07:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:45 INFO - Downloading functools32-3.2.3-2.tar.gz 07:25:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:25:45 INFO - warning: no files found matching '*.txt' 07:25:45 INFO - no previously-included directories found matching 'build' 07:25:45 INFO - no previously-included directories found matching 'dist' 07:25:45 INFO - no previously-included directories found matching '.git*' 07:25:45 INFO - Installing collected packages: jsonschema, functools32 07:25:45 INFO - Running setup.py install for functools32 07:25:45 INFO - warning: no files found matching '*.txt' 07:25:45 INFO - no previously-included directories found matching 'build' 07:25:45 INFO - no previously-included directories found matching 'dist' 07:25:45 INFO - no previously-included directories found matching '.git*' 07:25:45 INFO - Successfully installed jsonschema functools32 07:25:45 INFO - Cleaning up... 07:25:45 INFO - Return code: 0 07:25:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7883f31f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e628e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef1b20>, '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 0x1ef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', '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:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:25:45 INFO - Using env: {'DISPLAY': ':0', 07:25:45 INFO - 'HOME': '/home/cltbld', 07:25:45 INFO - 'LANG': 'en_US.UTF-8', 07:25:45 INFO - 'LANGUAGE': 'en_US:en', 07:25:45 INFO - 'LOGNAME': 'cltbld', 07:25:45 INFO - 'MAIL': '/var/mail/cltbld', 07:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:45 INFO - 'MOZ_NO_REMOTE': '1', 07:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:45 INFO - 'NO_EM_RESTART': '1', 07:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:45 INFO - 'PWD': '/builds/slave/test', 07:25:45 INFO - 'SHELL': '/bin/bash', 07:25:45 INFO - 'SHLVL': '1', 07:25:45 INFO - 'TERM': 'linux', 07:25:45 INFO - 'TMOUT': '86400', 07:25:45 INFO - 'USER': 'cltbld', 07:25:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', 07:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:45 INFO - '_': '/tools/buildbot/bin/python'} 07:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:45 INFO - Downloading/unpacking flake8 07:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:25:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:25:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:25:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:25:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:25:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:25:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:25:48 INFO - no previously-included directories found matching 'docs/_build' 07:25:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:25:48 INFO - Running setup.py install for pep8 07:25:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:25:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:25:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:25:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:25:48 INFO - no previously-included directories found matching 'docs/_build' 07:25:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:25:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:25:48 INFO - Cleaning up... 07:25:48 INFO - Return code: 0 07:25:48 INFO - Running post-action listener: _resource_record_post_action 07:25:48 INFO - Running post-action listener: _start_resource_monitoring 07:25:48 INFO - Starting resource monitoring. 07:25:48 INFO - ##### 07:25:48 INFO - ##### Finished create-virtualenv step (success) 07:25:48 INFO - ##### 07:25:48 INFO - ##### 07:25:48 INFO - ##### Running install step. 07:25:48 INFO - ##### 07:25:48 INFO - Running pre-action listener: _resource_record_pre_action 07:25:48 INFO - Running main action method: install 07:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:49 INFO - Reading from file tmpfile_stdout 07:25:49 INFO - Detecting whether we're running mozinstall >=1.0... 07:25:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:25:49 INFO - Reading from file tmpfile_stdout 07:25:49 INFO - Output received: 07:25:49 INFO - Usage: mozinstall [options] installer 07:25:49 INFO - Options: 07:25:49 INFO - -h, --help show this help message and exit 07:25:49 INFO - -d DEST, --destination=DEST 07:25:49 INFO - Directory to install application into. [default: 07:25:49 INFO - "/builds/slave/test"] 07:25:49 INFO - --app=APP Application being installed. [default: firefox] 07:25:49 INFO - mkdir: /builds/slave/test/build/application 07:25:49 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:25:49 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:26:05 INFO - Reading from file tmpfile_stdout 07:26:05 INFO - Output received: 07:26:05 INFO - /builds/slave/test/build/application/firefox/firefox 07:26:05 INFO - Running post-action listener: _resource_record_post_action 07:26:05 INFO - ##### 07:26:05 INFO - ##### Finished install step (success) 07:26:05 INFO - ##### 07:26:05 INFO - ##### 07:26:05 INFO - ##### Running run-tests step. 07:26:05 INFO - ##### 07:26:05 INFO - Running pre-action listener: _resource_record_pre_action 07:26:05 INFO - Running main action method: run_tests 07:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:26:05 INFO - Python 2.7.3 07:26:05 INFO - Return code: 0 07:26:05 INFO - grabbing minidump binary from tooltool 07:26:05 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:26:05 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 0x1ef1b20>, '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 0x1ef2a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:26:05 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:26:05 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:26:05 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:26:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:26:05 INFO - Return code: 0 07:26:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:26:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:26:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:26:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:26:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:26:06 INFO - Return code: 0 07:26:06 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/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:26:06 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/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:26:06 INFO - Using env: {'DISPLAY': ':0', 07:26:06 INFO - 'HOME': '/home/cltbld', 07:26:06 INFO - 'LANG': 'en_US.UTF-8', 07:26:06 INFO - 'LANGUAGE': 'en_US:en', 07:26:06 INFO - 'LOGNAME': 'cltbld', 07:26:06 INFO - 'MAIL': '/var/mail/cltbld', 07:26:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:26:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:06 INFO - 'MOZ_NO_REMOTE': '1', 07:26:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:06 INFO - 'NO_EM_RESTART': '1', 07:26:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:06 INFO - 'PWD': '/builds/slave/test', 07:26:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:26:06 INFO - 'SHELL': '/bin/bash', 07:26:06 INFO - 'SHLVL': '1', 07:26:06 INFO - 'TERM': 'linux', 07:26:06 INFO - 'TMOUT': '86400', 07:26:06 INFO - 'USER': 'cltbld', 07:26:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163', 07:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:06 INFO - '_': '/tools/buildbot/bin/python'} 07:26:06 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/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:26:06 INFO - mozversion application_buildid: 20160512043110 07:26:06 INFO - mozversion application_changeset: 6f5d73b492f87b0594536c5d4116610b56617277 07:26:06 INFO - mozversion application_display_name: Nightly 07:26:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:26:06 INFO - mozversion application_name: Firefox 07:26:06 INFO - mozversion application_remotingname: firefox 07:26:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:26:06 INFO - mozversion application_vendor: Mozilla 07:26:06 INFO - mozversion application_version: 49.0a1 07:26:06 INFO - mozversion platform_buildid: 20160512043110 07:26:06 INFO - mozversion platform_changeset: 6f5d73b492f87b0594536c5d4116610b56617277 07:26:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:26:06 INFO - mozversion platform_version: 49.0a1 07:26:06 INFO - using testdate: 1463063166 07:26:06 INFO - actual date: 1463063166 07:26:06 INFO - starting webserver on 'localhost:37217' 07:26:06 INFO - SUITE-START | Running 2 tests 07:26:06 INFO - TEST-START | dromaeo_css 07:26:06 INFO - operating with platform_type : linux_ 07:26:06 INFO - Initialising browser for dromaeo_css test... 07:26:06 INFO - TEST-INFO | started process 6842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkXkBMm/profile http://localhost:37217/getInfo.html) 07:26:10 INFO - PROCESS | 6842 | 07:26:10 INFO - PROCESS | 6842 | (process:6911): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:26:11 INFO - PROCESS | 6842 | __metrics Screen width/height:1600/1200 07:26:11 INFO - PROCESS | 6842 | colorDepth:24 07:26:11 INFO - PROCESS | 6842 | Browser inner width/height: 1024/697 07:26:11 INFO - PROCESS | 6842 | __metrics 07:26:12 ERROR - PROCESS | 6842 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 07:26:12 INFO - TEST-INFO | 6842: exit 0 07:26:12 INFO - Browser initialized. 07:26:12 INFO - Running cycle 1/1 for dromaeo_css test... 07:26:12 INFO - TEST-INFO | started process 6962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkXkBMm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:14 INFO - PROCESS | 6962 | 07:26:14 INFO - PROCESS | 6962 | (process:7025): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:26:24 INFO - PROCESS | 6962 | RSS: Main: 163123200 07:26:24 INFO - PROCESS | 6962 | 07:27:14 INFO - PROCESS | 6962 | 1463063234307 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:29:22 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:37217/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37217/tests/dromaeo/cssquery-ext.html) 07:29:23 INFO - PROCESS | 6962 | RSS: Main: 165949440 07:29:23 INFO - PROCESS | 6962 | 07:32:25 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:37217/tests/dromaeo/cssquery-ext.html (next: http://localhost:37217/tests/dromaeo/cssquery-jquery.html) 07:32:25 INFO - PROCESS | 6962 | RSS: Main: 166248448 07:32:25 INFO - PROCESS | 6962 | 07:35:27 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:37217/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37217/tests/dromaeo/cssquery-mootools.html) 07:35:28 INFO - PROCESS | 6962 | RSS: Main: 167784448 07:35:28 INFO - PROCESS | 6962 | 07:38:30 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:37217/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37217/tests/dromaeo/cssquery-prototype.html) 07:38:30 INFO - PROCESS | 6962 | RSS: Main: 164970496 07:38:30 INFO - PROCESS | 6962 | 07:41:33 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:37217/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37217/tests/dromaeo/cssquery-yui.html) 07:41:33 INFO - PROCESS | 6962 | RSS: Main: 166264832 07:41:33 INFO - PROCESS | 6962 | 07:44:36 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:37217/tests/dromaeo/cssquery-yui.html (next: http://localhost:37217/tests/dromaeo/cssquery-dojo.html) 07:44:36 INFO - PROCESS | 6962 | RSS: Main: 168120320 07:44:36 INFO - PROCESS | 6962 | 07:44:36 INFO - PROCESS | 6962 | __start_tp_report 07:44:36 INFO - PROCESS | 6962 | _x_x_mozilla_page_load 07:44:36 INFO - PROCESS | 6962 | _x_x_mozilla_page_load_details 07:44:36 INFO - PROCESS | 6962 | |i|pagename|runs| 07:44:36 INFO - PROCESS | 6962 | |0;dojo.html;3198.0405878236525;3221.8550165242564;3242.0760083376235;3249.75626827988;3253.121657152569;5515.779368825247;5521.4478552144765;5523.972380138103;5535.667859928407;5555.722213889305;5424.105022671254;5524.116141417364;5583.3858275589655;5613.270274864262;5692.544596432286;4900.534449227318;4961.107000739866;5022.096022715928;5070.797168113271;5078.415982162043;914.4837431917621;4897.240927656219;4912.680675756083;5097.617678674096;5106.463821298766;4953.851384458454;4956.330895329121;4972.776225069862;4979.10376132296;4986.800527978877;4954.455009948902;4968.354113965198;4981.800727970877;4992.700437973697;5004.624653150991;4986.87532811679;5007.223880298523;5070.923936140961;5085.364329458817;5090.9236361454605;5472.26124473195;5510.9448905511235;5521.4478552144865;5533.6956467394275;5567.914256719901;5669.886602267973;5863.472287494146;5871.6183448075735;5873.1190321451695;5949;6030.155778191057;6101.481374083208;6111.47019340724;6112.052631842072;6140.293866205398;5654.349749778746;5667.093265077568;5674.829755107395;5677.148427735872;5680;5906.468417842415;6055.545834062463;6076.969615151985;6203.4416902479;6225.62646241227;5832.591718579743;5838.562107841929;5845.123231515222;5845.473907348359;5849;5983.431574000463;5990.670513121733;5992.221011268594;5998.820035398945;5999.430054144849;5819.127130930395;5859.560532960045;5881.176635271066;5892.204552385373;5961.910571341434;5847.298324201123;5893.616914900518;5904;5907.261592300963;5910.113482977587;4369.344598310216;4442.8667139985855;4456.821727130879;4464.419625448671;4509.7970591323465;3881.7476864003747;3938;3959;3974.82113304902;3988.8205030773684;5630.887382252332;5640.830775076754;5667.4615911488345;5706.9714651426475;5735.1684005818925;5882.588218824641;6014.097885317237;6017.518598512196;6018.699065046818;6023.307319658208;5667.773289068474;5706.3152421709665;5728.684922329228;5733.799317023884;5736.799212027642;5082.695038297714;5105.387353517602;5136.409312929061;5143;5202.609804264695;5951.851203719942;6118.908216376758;6169.413905678954;6206.410391012847;6211.192544969125;5800.0429929062075;6003.609765365412;6006.189164462917;6022.2171117754415;6037.516998640011;6164.691765411621;6189.783357582463;6214.9067763984485;6218.782342618168;6219.751209951552;5756.827295181151;5840.123981402823;5844.853878653068;5919.792807251725;5926.4666180044005;6008.399160083956;6011.579189456871;6016.909746353896;6021.849453763691;6054.969725151523;5753.71231438418;5815.709214539341;5824.242848429677;5830.912536312044;5836.824895253149;5606.299212598426;5737.942620573908;5762.740676669644;5799.391063938395;5800.477956983723;5569.164625306236;5706.686132262766;5713.257276554022;5723.084306510938;5731.541476681772;5824.767009319579;5838.416158384128;5867.149263356875;5876.1773351731645;5885.440883116097;5535.723213839373;5686.658800471985;5715.5713321500225;5748.770049197985;5762.942370576408 07:44:36 INFO - PROCESS | 6962 | |1;ext.html;604.6855635069763;660.7291010685618;664.8803215421225;674.190970834998;675.2639622811134;38374;42094.36858447126;42133.578664213426;42134.57865421345;42173.367399489034;42304.365434518506;42681.57318426815;42737.78631106848;42798.572014279845;42846.357304640456;8837;8939.731808045737;8950.239229665487;8979.506127163037;8995.28037756978;8812.471251724884;8884.73345799627;8930.106989301083;8969.372143949926;8972.50651214183;8900.51047192404;8945.59744811485;8950.731478055668;8960.372773905829;8965.058668839776;8845.601947912359;8900.688475903346;8923.955380223122;8957.104289571056;8969.910300896972;8761;8798.51608161551;8805.515696636683;8816.69141580048;8828.8675669865;40300.59699402998;40788.592114078776;40792.59207407918;40848.59151408478;40855.38716919249;3250.431174544469;3329.034579971805;3341.899743007714;3505.8071806050657;3869.9806500967316;31460.37079258402;32064.35871282561;32068.679313207034;32115.197120072185;32294.838525807456;4441.311596702516;4445.444319460067;4446.750758422473;4458.487273963503;4501.684882058257;324360.37819810986;326302;327123;327709;328064;55855.44144558503;56899.99999999917;56902.14646780302;56928.43071569314;56962.715186423804;36940.26119477595;37633.24733505314;37698.62301377006;60765.39234607686;60842;17097.316107355815;17228.741568876478;17337.479875603753;17367.826321736873;17383.47849564515;13167.814896659347;13272.933635331761;13338.933305333605;13345.399457024263;13428.060035797596;19579.11893964775;19680;19714.605707885763;19716.605667886848;19723.40829775109;7277.598392530453;7300.269973002657;7426.665800038903;7537.849243015218;7582.128055273603;1032.2825636182781;1087.8477013218155;1101.8705826527873;1169.5263418315596;1202.6091520255952;31952.680473195436;32433.027009189762;32670.346593068007;32775.50836737451;33130.66869331324;1117.5966691236501;1144.4106285263097;1163.953441862316;1166.4517676691942;1185.51986445488;16939.576510587332;17293.74059389085;17378.565535861704;17449.912750436168;17479.825201748074;426946;430519;431493;434206;434519;56134;57546.424535754944;57609.423905760406;57804;57851.132233016535;1441.54591303739;1446.696193799314;1447.160646824839;1451.1945870042016;1461.7807328900537;29965.886915372528;31081.53377699291;31193.68806311908;31733.682663173073;31833.681663183997;49734;49811.501884982135;50027.249591256885;50133;50204;368508;369029;370539;371515;371851;27959.161225163276;27994.720052800025;28026.43947121087;28299.15102546927;28487.715122848505;47942.041159177315;48300.27549586829;48366;48685.2697209535;49136;40274;40476.79761601173;40842.387364188966;40914;42005.159896801284;39264;40284.3957340646;41083.46769192608;41157.382639261035;41246.38130427986;41527.58472415237;42192.78903605462;42815.571844281156;43118.78440607777;45181.77409113065;35810.64189358177;36717.63282367249;36855.81572092122;37463.43804842875;37882.0529486754;28765.56851647269;28954.85522572458;29005.274868128465;29260.41479170362;29517.704822951495 07:44:36 INFO - PROCESS | 6962 | |2;jquery.html;403.5036904607333;408.1205003218066;410.3147743268741;411.2638377304624;424.6539070657414;13926.79109813351;17712.64574708505;19044.809551904476;19766.30817921373;19830.30593929211;18934.337298194565;19150.425487235407;19357.225710971543;19892.303769368074;20007.699884501744;5635.070213414792;5651.745671444794;5841.7371218295275;5854.853628659296;5874.118882167688;5786.739596718136;5813.593048486608;5819.418058194168;5826.096954971965;5840.036393994986;5576.358718747335;5817.389174136718;5819.447152520504;5823.475887170154;5825.30096388434;5552;5748.913766293509;5770.394108618577;5772.278465191851;5791.594588378815;5140.074786538422;5180.792768289264;5183.118869792144;5195.090859099642;5202.297689811865;22527.436814079614;22743.31770046901;23109.306720798402;23236.41908952273;23268.534629307487;2301.9654705179437;2351.922876031573;2443.3769388805918;2518.3452302401506;2717.388587567801;14549.854501454956;14875.925620371938;15005.174715390649;15334.539963801104;15380.230988450532;1932.8357089647398;1934.8548858835502;2037.6841589553642;2076.397844625057;2121.713568668241;90193.54903225442;96338;97469.51265243629;98795;98862;9392.154706076486;9622.663206787729;9725.9027409725;10037.899621003842;10147;12332.630021099201;12374.381280935917;12420.130590858735;12447.128700991025;12524.499020039279;7174.3184397482155;7266.128064632172;7377.963110184414;7389.556626602313;7456.105267367951;7215.530990485601;7286.70853165878;7397.519161254501;7411;7651.579163145969;3737.8131093445218;3902.5316961964745;3919.235749028969;4031.4355990161403;4295.935560966588;2002.8698134621202;2032.1972820736023;2056.4961584411917;2087.279888438486;2099.821515171197;922.418876108061;973.493783232715;1008.2740426892625;1028.4240825137947;1095.8411030400548;19029.238830446902;19303;19425.708614370797;19426.4172074838;19531.414057578295;993.2897977945803;1005.1154983614373;1026.9948650256702;1058.4813441413653;1060.6393826099163;9671.516424178904;10836.512356943957;10969.890301097046;11016.11871050314;11100.777984440267;492980;504109;510947;511078;524812;72324.93725439275;88314;88492.55753721319;90312.54843725871;91069.54465227631;1040.3549799124592;1061.6814955513314;1065.3448129400363;1082.9675109746563;1084.5553323137633;17242.482725518254;17582.91208543949;17663.64672706513;17895.37366192177;17940.372086976895;38748.225035499694;39503.407448888865;39754;41227.58772412237;42075.1584968305;56161.157582635475;57325.84707841109;57460.71269643792;58762.70618646879;59044.40955590389;5727.856803579777;6488.480921526361;7427.851442971002;7737.497062690907;7953.16491768356;10817.567297308335;11288.492017859051;13236.205827650372;13396.799048014092;13822.93088534551;11824.940875295913;11833.763324733629;11976.281423114293;12074.577389791666;12185.451654675739;11405;11579.189456737948;11596.246243994114;11734.70663233426;12214.877851221729;11639.41802909868;11816.586419475621;12036.939815300868;12454.813177802522;12913.225206487641;7613.08642962848;8197.46716463428;8381;8382.874256886029;8395.160483951557;11062.22564420483;11245.100391968786;11601.245919015237;11920.701982450508;12017 07:44:36 INFO - PROCESS | 6962 | |3;mootools.html;1343.899207559433;1457.9343929523175;1525.2678714217175;1788.1685016467331;1818.2363407368903;8088.91911080889;8735.519546424945;8829.646814127427;9335.113164249402;9365;8970.596323165457;9035.277177825774;9035.819283614324;9070.591823367948;9124.726258212264;2378.9524209515844;2409.4578719788083;2414.5653782319177;2419.794317483016;2421.0315873650593;2331.5803155432013;2370.7510711375317;2373.95252094958;2388.844725092872;2390.5577468168444;2344.648302754592;2361.633946738258;2372.28831350595;2393.150431596784;2406.278116565032;2297.6553516972504;2306.1928325086255;2306.7693230676964;2315.154968436517;2338.7193536775526;2353.623420252751;2360.6459031145296;2360.7875291223872;2369.7867191952637;2386.6539351793895;9006.459612423276;9107.271418286522;9141.131592498701;9188.40275382098;9209.079092090804;5452.863678408032;5544.944550554484;5577.079781835992;5578.079616863253;5584.636998595079;3591.5813253764877;3684.1894783147663;3714.9257014859822;3738.906527336811;3746.3256613809504;1164.0920082335792;1202.9218100823507;1221.993890030553;1223.1376879300071;1225.6997035726304;11735.295882247006;11920.821187682192;11930.164888457812;11935.403229838561;11949.880501194964;4685.484596694361;4700.318453824177;4826.58973987208;4844.4186697596515;4864.246041863516;10545.314554554083;10601.84097238542;10617.203709721802;10622.89377106219;10631;5339.439358867341;5427.538659213932;5440.347158341025;5454.59090568209;5501.312335958005;4425.446819147606;4961.107000739901;4999.600031997432;5102.642815002914;5156.458571849902;4148.522919864194;4151.875443736692;4207.474065741782;4233.153369326147;4314.288142456522;1308.13009348782;1332.5003123828565;1333.5399287245884;1372.3755691160497;1381.8756311931975;906.569379544711;986.958758509779;993.3989936088562;995.2684776689127;1005.3364779245662;5931.139984702194;5987.550933679991;6114.327423983358;6120.112583675342;6204.410580994799;979.7746518300688;1016.6797458800454;1017.9491025448698;1038.5586125896464;1068.2148620763733;4066.8576599818866;4096.959030409717;4214.494260688737;4233.5131459882505;4258.914821703611;10876;11142.442877856074;11379.487923043484;11456.427178641035;11552.537898484135;10619;10911.127109831194;11179.83230251547;11361.091112711129;11447.771044579062;8389.874151887727;8426.07313195548;8485.957570212233;8528.104549022388;8534.274586660204;6076.483498902466;6114;6217.7823776169425;6231.875362492816;6339.461145802474;10408.739781505523;10470.214733894836;10584.4707764613;10696.786064278827;10756.623518176826;10270.589176432859;10746.612513219925;10885.23803333759;10976.176786740867;10994.615188468366;7250.709971601077;7935.0874649416055;8136.593170341577;8193.098759136372;8318.251357377865;8976.86534701993;9046.185843274137;9053;9097.1812536872;9097.363184577016;8081.353491720531;8260.958695206486;8264;8304.501729896225;8371.623276952674;7745.961270193613;7790.220977902164;7812.804679883048;7893.289603935444;7899.447038707235;7297.598632075287;7308.378787802883;7346.449016323904;7412.11054673421;7504.399648028036;5192.27308176848;5214.582833373397;5316.415194328543;5347.652402593819;5406.053940560308;5201.193814958688;5214.478552144755;5238.68567885928;5264.815731449381;5376.924615077079 07:44:36 INFO - PROCESS | 6962 | |4;prototype.html;332.45398111190656;339.60760880390393;342.9691327780499;344.155099231387;347.260335485416;5470.17947307903;5596.916046259309;5658.603897727161;5676.687782171979;5756.338021127572;5593.8601534961645;5626.634268772527;5674.914876276859;5686.971565142178;5699.349802341911;4347.7173983690955;4349.565043495657;4357.803898824561;4370.6940514164025;4372.5627437256335;4067.1052368479036;4291.746832912714;4317.201317756209;4328.982689068066;4396.944733264009;4247.405363249148;4248.766317852533;4266.06146647737;4279.893002674927;4279.908623301054;4300.354946757996;4304.720193187449;4308.267594508941;4316.589923957219;4341;3617.7286703497343;3731.253749250161;3751.924961500782;3758.5113935188524;3769.4722738816586;5360.490753378462;5362.27609272751;5381.704006279653;5385.892282154374;5401.864953376158;4859.95140048602;4894.5105489451125;4896.608271338285;4912.631552633567;4916.975415122937;5653.802116925888;5755.65466072037;5792.304923409176;5816.941830581683;5840.15317778924;4118.661435033596;4120.361343991686;4120.958790412117;4163.188178305231;4203;5903.284489135046;6128.172696685935;6129.509639228851;6143.784967526115;6147.2930612979635;4206.233381979576;4225.936610950838;4236.110416812442;4242.32122860347;4252.893677658083;4274.081072569413;4308.698391112592;4317.978410107992;4326.6538676905775;4329.307310830252;4864.391951006124;4879.2922477132715;4890.633202509826;4933.284673722362;4944.1100601892;5711.143328500675;5780.566457515703;5855.94144058554;5870.853228669317;5873.735681894325;1467.882569394446;1470.4265336518765;1485.4503833581643;1485.4578079001087;1489.9925500372428;899.1143723432414;923.3582660051334;926.9212116970133;933.7852293972288;937.1659223291276;4993.675411098267;4993.825216117419;5039.496050394931;5074.209184948338;5074.847754567295;5248.291480650063;5297.231901374279;5319.117044557494;5326.573874090063;5348.893022139536;5013.774380152902;5018.197088465901;5020.636173763587;5334.866628334245;5810.94189058104;3235.822029788384;3240.8217548035086;3247.220667039893;3253.07287423088;3270.918227044343;6088.634681919099;6150.630962142286;6186.938130618726;6254.468370188494;6279.215098112736;6097.298810636834;6114.510839132859;6151.661658608819;6169.629822210682;6188.2883468400805;6225;6296.212973378328;6306.045126010951;6311.842203944938;6313.684315784192;5786.334571524329;6012.308584512837;6020.729067192075;6040.728167232573;6089.51283897296;5939.762409503572;5993.910091348721;5998.790042348497;6065.514758819372;6080.817575472743;5899.997000509838;6243.594166379171;6279.748810047547;6287.811365659038;6305.873882522232;4235.23765722173;4254.829806807817;4256.489221293465;4270.145970805914;4289.120730250229;5855;5864.44287792659;6058.121572371893;6150.446459818459;6152.600080994721;5765.8558536036935;5814.738336774771;5845.736941837713;5848.239728835224;5889.234399528034;5810.796622118206;5825.155352473783;5864.530837532901;5872.442117998783;5885.882282354414;5545.626055009561;5781.219535362672;5786.479216870502;5804.303483581997;5836.474717275466;5918.644881307136;5934.19888315072;5937.703114844154;5938.970305148447;5942.970285148546;5542;5788.855278618068;5810.854728631818;5816.069428891357;5861.912071318849 07:44:36 INFO - PROCESS | 6962 | |5;yui.html;769.8806684963829;837.5351679817701;839.0309192882223;848.8896443462356;857.524074138853;13033.869661303384;13704.314784260785;13983.091099078578;14011;14024.158550486978;13814.516491922785;13846.100003499765;13937.094088884216;13950.930245348785;13952.720945581083;698.7379732600275;836.3392919593514;846.5682501924001;847.474565769224;848.321342925657;822.6873787960567;833.5873742497472;833.6415341403194;844.4257904624852;844.4848642328175;878.1218781218781;879.5909901895617;879.6437442835662;882.1531329923281;890.6526454682679;867.761365624452;876.2114097312406;877.5085951866974;880.1198801198801;884.9247813935823;642.1299139665732;642.958207716497;645.3191882563893;646.5603389695005;647.718242564486;12366.814497782541;12484.188527745668;12504.74990500194;12544.937275313656;12596.55912043074;13868.375923083486;13919.095258808145;14121.576352709333;14244.786328205086;14254.928725356307;11629.534818607246;11641.126915481373;11678.182527223098;11751.236169649032;11937.40312984356;3804.8097595120134;3859.517560304962;3927.7643341399607;4009.458723072377;4013.1973605279063;55168.724156379365;55294.9999999996;55327.72336138294;55655.443445565434;55672.164917525864;10585.523651435704;10826.729331766612;10877.238593298393;10941.507632156572;11044.226904116795;19598;19677.50806229856;19886.105125269107;19908;20037;8436.114208008194;8475.830483390298;8541.743747687578;8666.653333866701;8739.737807865775;4698.694584851974;4747.525247475294;4823.855284341475;4842.031593681278;4912.852614421573;3361.647027062172;3423.281110966675;3432.5880894292845;3432.708219801345;3438.570178727659;680.7583307925714;686.800827759954;693.4729605499856;699.9020137180798;702.4836744992426;674.7301079568114;720.1466262478979;753.8002429356225;765.1545042727817;788.4520258420457;8964.327675424369;9042.547872606476;9187.402818816756;9422.623095076257;9778.511074446249;712.2841544247998;715.141829804237;725.3725527418745;750.5730793795365;810.4332088680329;4380.627646650007;4556.567126123013;4575.725456472623;4590.586847183769;4639.072185562901;57695.71152144212;57849;58438.70780646155;58734;60326.69836650876;54814.72592637011;55481.44518554763;56197.71901140468;56820.43179568234;58490.41509584935;49366.50633493619;49506.25740613894;49524.75237623789;49792.25311620328;51517;8350.373721970755;8472.237498624907;9612.807743845224;9797.363171393836;9800.607975680892;32987.505187422685;33163.50254746229;34476;34674.653253468154;35092.64907350894;42026.57973420226;42901.570984289756;44359.33460998023;44973;45288.77355613201;12313.076519260912;12402.75194496087;12518.311492867979;12530.686732831387;12879.871201288242;13317.558068157205;13486.460541578226;13652.112612680145;13796.793048104086;13951.441942322193;12878.291693956922;12915.870841291468;12947.482100716243;12982.480700772241;13066.346682665639;12522.186057906207;12617.684557886127;12872.742545148858;12944.611661650166;13260.734785304432;13109;13127.934360328138;13139.474421023053;13442.260675662932;13489.460421583026;10770.492131101808;10935.28920620157;11233;11315.151363647925;11529.077673785909;11072.833907491555;11152.386618736047;11347.773044538897;11390.088792896715;11428.37143957057 07:44:36 INFO - PROCESS | 6962 | __end_tp_report 07:44:36 INFO - PROCESS | 6962 | __start_cc_report 07:44:36 INFO - PROCESS | 6962 | _x_x_mozilla_cycle_collect,352 07:44:36 INFO - PROCESS | 6962 | __end_cc_report 07:44:36 INFO - PROCESS | 6962 | __startTimestamp1463064276447__endTimestamp 07:44:36 INFO - PROCESS | 6962 | 07:44:36 INFO - PROCESS | 6962 | ------- Summary: start ------- 07:44:36 INFO - PROCESS | 6962 | Number of tests: 6 07:44:36 INFO - PROCESS | 6962 | 07:44:36 INFO - PROCESS | 6962 | [#0] dojo.html Cycles:165 Average:5492.53 Median:5735.17 stddev:740.84 (12.9%) stddev-sans-first:720.91 07:44:36 INFO - PROCESS | 6962 | Values: 3198.0 3221.9 3242.1 3249.8 3253.1 5515.8 5521.4 5524.0 5535.7 5555.7 5424.1 5524.1 5583.4 5613.3 5692.5 4900.5 4961.1 5022.1 5070.8 5078.4 914.5 4897.2 4912.7 5097.6 5106.5 4953.9 4956.3 4972.8 4979.1 4986.8 4954.5 4968.4 4981.8 4992.7 5004.6 4986.9 5007.2 5070.9 5085.4 5090.9 5472.3 5510.9 5521.4 5533.7 5567.9 5669.9 5863.5 5871.6 5873.1 5949.0 6030.2 6101.5 6111.5 6112.1 6140.3 5654.3 5667.1 5674.8 5677.1 5680.0 5906.5 6055.5 6077.0 6203.4 6225.6 5832.6 5838.6 5845.1 5845.5 5849.0 5983.4 5990.7 5992.2 5998.8 5999.4 5819.1 5859.6 5881.2 5892.2 5961.9 5847.3 5893.6 5904.0 5907.3 5910.1 4369.3 4442.9 4456.8 4464.4 4509.8 3881.7 3938.0 3959.0 3974.8 3988.8 5630.9 5640.8 5667.5 5707.0 5735.2 5882.6 6014.1 6017.5 6018.7 6023.3 5667.8 5706.3 5728.7 5733.8 5736.8 5082.7 5105.4 5136.4 5143.0 5202.6 5951.9 6118.9 6169.4 6206.4 6211.2 5800.0 6003.6 6006.2 6022.2 6037.5 6164.7 6189.8 6214.9 6218.8 6219.8 5756.8 5840.1 5844.9 5919.8 5926.5 6008.4 6011.6 6016.9 6021.8 6055.0 5753.7 5815.7 5824.2 5830.9 5836.8 5606.3 5737.9 5762.7 5799.4 5800.5 5569.2 5706.7 5713.3 5723.1 5731.5 5824.8 5838.4 5867.1 5876.2 5885.4 5535.7 5686.7 5715.6 5748.8 5762.9 07:44:36 INFO - PROCESS | 6962 | 07:44:36 INFO - PROCESS | 6962 | [#1] ext.html Cycles:180 Average:54414.22 Median:40817.49 stddev:99615.73 (244.1%) stddev-sans-first:99813.25 07:44:36 INFO - PROCESS | 6962 | Values: 604.7 660.7 664.9 674.2 675.3 38374.0 42094.4 42133.6 42134.6 42173.4 42304.4 42681.6 42737.8 42798.6 42846.4 8837.0 8939.7 8950.2 8979.5 8995.3 8812.5 8884.7 8930.1 8969.4 8972.5 8900.5 8945.6 8950.7 8960.4 8965.1 8845.6 8900.7 8924.0 8957.1 8969.9 8761.0 8798.5 8805.5 8816.7 8828.9 40300.6 40788.6 40792.6 40848.6 40855.4 3250.4 3329.0 3341.9 3505.8 3870.0 31460.4 32064.4 32068.7 32115.2 32294.8 4441.3 4445.4 4446.8 4458.5 4501.7 324360.4 326302.0 327123.0 327709.0 328064.0 55855.4 56900.0 56902.1 56928.4 56962.7 36940.3 37633.2 37698.6 60765.4 60842.0 17097.3 17228.7 17337.5 17367.8 17383.5 13167.8 13272.9 13338.9 13345.4 13428.1 19579.1 19680.0 19714.6 19716.6 19723.4 7277.6 7300.3 7426.7 7537.8 7582.1 1032.3 1087.8 1101.9 1169.5 1202.6 31952.7 32433.0 32670.3 32775.5 33130.7 1117.6 1144.4 1164.0 1166.5 1185.5 16939.6 17293.7 17378.6 17449.9 17479.8 426946.0 430519.0 431493.0 434206.0 434519.0 56134.0 57546.4 57609.4 57804.0 57851.1 1441.5 1446.7 1447.2 1451.2 1461.8 29965.9 31081.5 31193.7 31733.7 31833.7 49734.0 49811.5 50027.2 50133.0 50204.0 368508.0 369029.0 370539.0 371515.0 371851.0 27959.2 27994.7 28026.4 28299.2 28487.7 47942.0 48300.3 48366.0 48685.3 49136.0 40274.0 40476.8 40842.4 40914.0 42005.2 39264.0 40284.4 41083.5 41157.4 41246.4 41527.6 42192.8 42815.6 43118.8 45181.8 35810.6 36717.6 36855.8 37463.4 37882.1 28765.6 28954.9 29005.3 29260.4 29517.7 07:44:36 INFO - PROCESS | 6962 | 07:44:36 INFO - PROCESS | 6962 | [#2] jquery.html Cycles:180 Average:29636.72 Median:2480.86 stddev:84018.79 (3386.7%) stddev-sans-first:84225.81 07:44:36 INFO - PROCESS | 6962 | Values: 403.5 408.1 410.3 411.3 424.7 13926.8 17712.6 19044.8 19766.3 19830.3 18934.3 19150.4 19357.2 19892.3 20007.7 5635.1 5651.7 5841.7 5854.9 5874.1 5786.7 5813.6 5819.4 5826.1 5840.0 5576.4 5817.4 5819.4 5823.5 5825.3 5552.0 5748.9 5770.4 5772.3 5791.6 5140.1 5180.8 5183.1 5195.1 5202.3 22527.4 22743.3 23109.3 23236.4 23268.5 2302.0 2351.9 2443.4 2518.3 2717.4 14549.9 14875.9 15005.2 15334.5 15380.2 1932.8 1934.9 2037.7 2076.4 2121.7 90193.5 96338.0 97469.5 98795.0 98862.0 9392.2 9622.7 9725.9 10037.9 10147.0 12332.6 12374.4 12420.1 12447.1 12524.5 7174.3 7266.1 7378.0 7389.6 7456.1 7215.5 7286.7 7397.5 7411.0 7651.6 3737.8 3902.5 3919.2 4031.4 4295.9 2002.9 2032.2 2056.5 2087.3 2099.8 922.4 973.5 1008.3 1028.4 1095.8 19029.2 19303.0 19425.7 19426.4 19531.4 993.3 1005.1 1027.0 1058.5 1060.6 9671.5 10836.5 10969.9 11016.1 11100.8 492980.0 504109.0 510947.0 511078.0 524812.0 72324.9 88314.0 88492.6 90312.5 91069.5 1040.4 1061.7 1065.3 1083.0 1084.6 17242.5 17582.9 17663.6 17895.4 17940.4 38748.2 39503.4 39754.0 41227.6 42075.2 56161.2 57325.8 57460.7 58762.7 59044.4 5727.9 6488.5 7427.9 7737.5 7953.2 10817.6 11288.5 13236.2 13396.8 13822.9 11824.9 11833.8 11976.3 12074.6 12185.5 11405.0 11579.2 11596.2 11734.7 12214.9 11639.4 11816.6 12036.9 12454.8 12913.2 7613.1 8197.5 8381.0 8382.9 8395.2 11062.2 11245.1 11601.2 11920.7 12017.0 07:44:36 INFO - PROCESS | 6962 | 07:44:36 INFO - PROCESS | 6962 | [#3] mootools.html Cycles:180 Average:5994.85 Median:4555.47 stddev:3374.33 (74.1%) stddev-sans-first:3365.69 07:44:36 INFO - PROCESS | 6962 | Values: 1343.9 1457.9 1525.3 1788.2 1818.2 8088.9 8735.5 8829.6 9335.1 9365.0 8970.6 9035.3 9035.8 9070.6 9124.7 2379.0 2409.5 2414.6 2419.8 2421.0 2331.6 2370.8 2374.0 2388.8 2390.6 2344.6 2361.6 2372.3 2393.2 2406.3 2297.7 2306.2 2306.8 2315.2 2338.7 2353.6 2360.6 2360.8 2369.8 2386.7 9006.5 9107.3 9141.1 9188.4 9209.1 5452.9 5544.9 5577.1 5578.1 5584.6 3591.6 3684.2 3714.9 3738.9 3746.3 1164.1 1202.9 1222.0 1223.1 1225.7 11735.3 11920.8 11930.2 11935.4 11949.9 4685.5 4700.3 4826.6 4844.4 4864.2 10545.3 10601.8 10617.2 10622.9 10631.0 5339.4 5427.5 5440.3 5454.6 5501.3 4425.4 4961.1 4999.6 5102.6 5156.5 4148.5 4151.9 4207.5 4233.2 4314.3 1308.1 1332.5 1333.5 1372.4 1381.9 906.6 987.0 993.4 995.3 1005.3 5931.1 5987.6 6114.3 6120.1 6204.4 979.8 1016.7 1017.9 1038.6 1068.2 4066.9 4097.0 4214.5 4233.5 4258.9 10876.0 11142.4 11379.5 11456.4 11552.5 10619.0 10911.1 11179.8 11361.1 11447.8 8389.9 8426.1 8486.0 8528.1 8534.3 6076.5 6114.0 6217.8 6231.9 6339.5 10408.7 10470.2 10584.5 10696.8 10756.6 10270.6 10746.6 10885.2 10976.2 10994.6 7250.7 7935.1 8136.6 8193.1 8318.3 8976.9 9046.2 9053.0 9097.2 9097.4 8081.4 8261.0 8264.0 8304.5 8371.6 7746.0 7790.2 7812.8 7893.3 7899.4 7297.6 7308.4 7346.4 7412.1 7504.4 5192.3 5214.6 5316.4 5347.7 5406.1 5201.2 5214.5 5238.7 5264.8 5376.9 07:44:36 INFO - PROCESS | 6962 | 07:44:36 INFO - PROCESS | 6962 | [#4] prototype.html Cycles:180 Average:4877.89 Median:5543.81 stddev:1450.32 (26.2%) stddev-sans-first:1413.69 07:44:36 INFO - PROCESS | 6962 | Values: 332.5 339.6 343.0 344.2 347.3 5470.2 5596.9 5658.6 5676.7 5756.3 5593.9 5626.6 5674.9 5687.0 5699.3 4347.7 4349.6 4357.8 4370.7 4372.6 4067.1 4291.7 4317.2 4329.0 4396.9 4247.4 4248.8 4266.1 4279.9 4279.9 4300.4 4304.7 4308.3 4316.6 4341.0 3617.7 3731.3 3751.9 3758.5 3769.5 5360.5 5362.3 5381.7 5385.9 5401.9 4860.0 4894.5 4896.6 4912.6 4917.0 5653.8 5755.7 5792.3 5816.9 5840.2 4118.7 4120.4 4121.0 4163.2 4203.0 5903.3 6128.2 6129.5 6143.8 6147.3 4206.2 4225.9 4236.1 4242.3 4252.9 4274.1 4308.7 4318.0 4326.7 4329.3 4864.4 4879.3 4890.6 4933.3 4944.1 5711.1 5780.6 5855.9 5870.9 5873.7 1467.9 1470.4 1485.5 1485.5 1490.0 899.1 923.4 926.9 933.8 937.2 4993.7 4993.8 5039.5 5074.2 5074.8 5248.3 5297.2 5319.1 5326.6 5348.9 5013.8 5018.2 5020.6 5334.9 5810.9 3235.8 3240.8 3247.2 3253.1 3270.9 6088.6 6150.6 6186.9 6254.5 6279.2 6097.3 6114.5 6151.7 6169.6 6188.3 6225.0 6296.2 6306.0 6311.8 6313.7 5786.3 6012.3 6020.7 6040.7 6089.5 5939.8 5993.9 5998.8 6065.5 6080.8 5900.0 6243.6 6279.7 6287.8 6305.9 4235.2 4254.8 4256.5 4270.1 4289.1 5855.0 5864.4 6058.1 6150.4 6152.6 5765.9 5814.7 5845.7 5848.2 5889.2 5810.8 5825.2 5864.5 5872.4 5885.9 5545.6 5781.2 5786.5 5804.3 5836.5 5918.6 5934.2 5937.7 5939.0 5943.0 5542.0 5788.9 5810.9 5816.1 5861.9 07:44:36 INFO - PROCESS | 6962 | 07:44:36 INFO - PROCESS | 6962 | [#5] yui.html Cycles:180 Average:14817.84 Median:24922.67 stddev:16861.51 (67.7%) stddev-sans-first:16875.80 07:44:36 INFO - PROCESS | 6962 | Values: 769.9 837.5 839.0 848.9 857.5 13033.9 13704.3 13983.1 14011.0 14024.2 13814.5 13846.1 13937.1 13950.9 13952.7 698.7 836.3 846.6 847.5 848.3 822.7 833.6 833.6 844.4 844.5 878.1 879.6 879.6 882.2 890.7 867.8 876.2 877.5 880.1 884.9 642.1 643.0 645.3 646.6 647.7 12366.8 12484.2 12504.7 12544.9 12596.6 13868.4 13919.1 14121.6 14244.8 14254.9 11629.5 11641.1 11678.2 11751.2 11937.4 3804.8 3859.5 3927.8 4009.5 4013.2 55168.7 55295.0 55327.7 55655.4 55672.2 10585.5 10826.7 10877.2 10941.5 11044.2 19598.0 19677.5 19886.1 19908.0 20037.0 8436.1 8475.8 8541.7 8666.7 8739.7 4698.7 4747.5 4823.9 4842.0 4912.9 3361.6 3423.3 3432.6 3432.7 3438.6 680.8 686.8 693.5 699.9 702.5 674.7 720.1 753.8 765.2 788.5 8964.3 9042.5 9187.4 9422.6 9778.5 712.3 715.1 725.4 750.6 810.4 4380.6 4556.6 4575.7 4590.6 4639.1 57695.7 57849.0 58438.7 58734.0 60326.7 54814.7 55481.4 56197.7 56820.4 58490.4 49366.5 49506.3 49524.8 49792.3 51517.0 8350.4 8472.2 9612.8 9797.4 9800.6 32987.5 33163.5 34476.0 34674.7 35092.6 42026.6 42901.6 44359.3 44973.0 45288.8 12313.1 12402.8 12518.3 12530.7 12879.9 13317.6 13486.5 13652.1 13796.8 13951.4 12878.3 12915.9 12947.5 12982.5 13066.3 12522.2 12617.7 12872.7 12944.6 13260.7 13109.0 13127.9 13139.5 13442.3 13489.5 10770.5 10935.3 11233.0 11315.2 11529.1 11072.8 11152.4 11347.8 11390.1 11428.4 07:44:36 INFO - PROCESS | 6962 | -------- Summary: end -------- 07:44:36 INFO - PROCESS | 6962 | 07:44:37 INFO - TEST-INFO | 6962: exit 0 07:44:37 INFO - TEST-OK | dromaeo_css | took 1110293ms 07:44:37 INFO - TEST-START | kraken 07:44:37 INFO - operating with platform_type : linux_ 07:44:37 INFO - Initialising browser for kraken test... 07:44:37 INFO - TEST-INFO | started process 7230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAjNnmP/profile http://localhost:37217/getInfo.html) 07:44:40 INFO - PROCESS | 7230 | 07:44:40 INFO - PROCESS | 7230 | (process:7301): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:44:41 INFO - PROCESS | 7230 | __metrics Screen width/height:1600/1200 07:44:41 INFO - PROCESS | 7230 | colorDepth:24 07:44:41 INFO - PROCESS | 7230 | Browser inner width/height: 1024/697 07:44:41 INFO - PROCESS | 7230 | __metrics 07:44:42 ERROR - PROCESS | 7230 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 07:44:43 INFO - TEST-INFO | 7230: exit 0 07:44:43 INFO - Browser initialized. 07:44:43 INFO - Running cycle 1/1 for kraken test... 07:44:43 INFO - TEST-INFO | started process 7352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAjNnmP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:44:45 INFO - PROCESS | 7352 | 07:44:45 INFO - PROCESS | 7352 | (process:7413): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:44:55 INFO - PROCESS | 7352 | RSS: Main: 163139584 07:44:55 INFO - PROCESS | 7352 | 07:44:57 INFO - PROCESS | 7352 | Cycle 1(1): loaded http://localhost:37217/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37217/tests/kraken/driver.html?testName=audio-beat-detection) 07:44:58 INFO - PROCESS | 7352 | RSS: Main: 167301120 07:44:58 INFO - PROCESS | 7352 | 07:45:01 INFO - PROCESS | 7352 | Cycle 1(1): loaded http://localhost:37217/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37217/tests/kraken/driver.html?testName=audio-dft) 07:45:01 INFO - PROCESS | 7352 | RSS: Main: 167800832 07:45:01 INFO - PROCESS | 7352 | 07:45:04 INFO - PROCESS | 7352 | Cycle 1(1): loaded http://localhost:37217/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37217/tests/kraken/driver.html?testName=audio-fft) 07:45:05 INFO - PROCESS | 7352 | RSS: Main: 162729984 07:45:05 INFO - PROCESS | 7352 | 07:45:07 INFO - PROCESS | 7352 | Cycle 1(1): loaded http://localhost:37217/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37217/tests/kraken/driver.html?testName=audio-oscillator) 07:45:08 INFO - PROCESS | 7352 | RSS: Main: 162660352 07:45:08 INFO - PROCESS | 7352 | 07:45:10 INFO - PROCESS | 7352 | Cycle 1(1): loaded http://localhost:37217/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37217/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:45:11 INFO - PROCESS | 7352 | RSS: Main: 163049472 07:45:11 INFO - PROCESS | 7352 | 07:45:14 INFO - PROCESS | 7352 | Cycle 1(1): loaded http://localhost:37217/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37217/tests/kraken/driver.html?testName=imaging-darkroom) 07:45:14 INFO - PROCESS | 7352 | RSS: Main: 163545088 07:45:14 INFO - PROCESS | 7352 | 07:45:18 INFO - PROCESS | 7352 | Cycle 1(1): loaded http://localhost:37217/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37217/tests/kraken/driver.html?testName=imaging-desaturate) 07:45:19 INFO - PROCESS | 7352 | RSS: Main: 162099200 07:45:19 INFO - PROCESS | 7352 | 07:45:21 INFO - PROCESS | 7352 | Cycle 1(1): loaded http://localhost:37217/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37217/tests/kraken/driver.html?testName=json-parse-financial) 07:45:22 INFO - PROCESS | 7352 | RSS: Main: 163074048 07:45:22 INFO - PROCESS | 7352 | 07:45:24 INFO - PROCESS | 7352 | Cycle 1(1): loaded http://localhost:37217/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37217/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:45:24 INFO - PROCESS | 7352 | RSS: Main: 163819520 07:45:24 INFO - PROCESS | 7352 | 07:45:26 INFO - PROCESS | 7352 | Cycle 1(1): loaded http://localhost:37217/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37217/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:45:27 INFO - PROCESS | 7352 | RSS: Main: 163373056 07:45:27 INFO - PROCESS | 7352 | 07:45:29 INFO - PROCESS | 7352 | Cycle 1(1): loaded http://localhost:37217/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37217/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:45:30 INFO - PROCESS | 7352 | RSS: Main: 163930112 07:45:30 INFO - PROCESS | 7352 | 07:45:32 INFO - PROCESS | 7352 | Cycle 1(1): loaded http://localhost:37217/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:45:33 INFO - PROCESS | 7352 | RSS: Main: 163491840 07:45:33 INFO - PROCESS | 7352 | 07:45:36 INFO - PROCESS | 7352 | Cycle 1(1): loaded http://localhost:37217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:45:37 INFO - PROCESS | 7352 | RSS: Main: 163315712 07:45:37 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | Cycle 1(1): loaded http://localhost:37217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37217/tests/kraken/driver.html?testName=ai-astar) 07:45:38 INFO - PROCESS | 7352 | RSS: Main: 165146624 07:45:38 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | __start_tp_report 07:45:38 INFO - PROCESS | 7352 | _x_x_mozilla_page_load 07:45:38 INFO - PROCESS | 7352 | _x_x_mozilla_page_load_details 07:45:38 INFO - PROCESS | 7352 | |i|pagename|runs| 07:45:38 INFO - PROCESS | 7352 | |0;ai-astar;107;110;103;112;111;111;106;110;110;111 07:45:38 INFO - PROCESS | 7352 | |1;audio-beat-detection;155;134;152;205;130;160;148;132;209;127 07:45:38 INFO - PROCESS | 7352 | |2;audio-dft;163;161;162;164;163;175;165;163;162;162 07:45:38 INFO - PROCESS | 7352 | |3;audio-fft;75;76;76;167;76;75;74;75;160;77 07:45:38 INFO - PROCESS | 7352 | |4;audio-oscillator;93;91;183;94;91;92;148;95;91;154 07:45:38 INFO - PROCESS | 7352 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;117;118 07:45:38 INFO - PROCESS | 7352 | |6;imaging-darkroom;146;147;147;147;146;147;147;147;148;147 07:45:38 INFO - PROCESS | 7352 | |7;imaging-desaturate;97;97;95;95;96;96;95;97;95;95 07:45:38 INFO - PROCESS | 7352 | |8;json-parse-financial;58;59;58;57;61;58;62;113;56;57 07:45:38 INFO - PROCESS | 7352 | |9;json-stringify-tinderbox;59;59;59;60;60;59;60;60;59;59 07:45:38 INFO - PROCESS | 7352 | |10;stanford-crypto-aes;85;80;81;80;81;84;79;80;79;79 07:45:38 INFO - PROCESS | 7352 | |11;stanford-crypto-ccm;125;131;144;143;125;123;137;125;206;131 07:45:38 INFO - PROCESS | 7352 | |12;stanford-crypto-pbkdf2;173;177;170;171;175;173;169;178;172;167 07:45:38 INFO - PROCESS | 7352 | |13;stanford-crypto-sha256-iterative;66;67;66;65;65;64;66;64;65;63 07:45:38 INFO - PROCESS | 7352 | __end_tp_report 07:45:38 INFO - PROCESS | 7352 | __start_cc_report 07:45:38 INFO - PROCESS | 7352 | _x_x_mozilla_cycle_collect,859 07:45:38 INFO - PROCESS | 7352 | __end_cc_report 07:45:38 INFO - PROCESS | 7352 | __startTimestamp1463064338983__endTimestamp 07:45:38 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | ------- Summary: start ------- 07:45:38 INFO - PROCESS | 7352 | Number of tests: 14 07:45:38 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:2.85 (2.6%) stddev-sans-first:2.92 07:45:38 INFO - PROCESS | 7352 | Values: 107.0 110.0 103.0 112.0 111.0 111.0 106.0 110.0 110.0 111.0 07:45:38 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | [#1] audio-beat-detection Cycles:10 Average:155.20 Median:153.50 stddev:29.59 (19.3%) stddev-sans-first:31.38 07:45:38 INFO - PROCESS | 7352 | Values: 155.0 134.0 152.0 205.0 130.0 160.0 148.0 132.0 209.0 127.0 07:45:38 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:4.03 (2.5%) stddev-sans-first:4.26 07:45:38 INFO - PROCESS | 7352 | Values: 163.0 161.0 162.0 164.0 163.0 175.0 165.0 163.0 162.0 162.0 07:45:38 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.50 stddev:37.15 (49.2%) stddev-sans-first:38.82 07:45:38 INFO - PROCESS | 7352 | Values: 75.0 76.0 76.0 167.0 76.0 75.0 74.0 75.0 160.0 77.0 07:45:38 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | [#4] audio-oscillator Cycles:10 Average:113.20 Median:91.50 stddev:34.61 (37.8%) stddev-sans-first:35.93 07:45:38 INFO - PROCESS | 7352 | Values: 93.0 91.0 183.0 94.0 91.0 92.0 148.0 95.0 91.0 154.0 07:45:38 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:45:38 INFO - PROCESS | 7352 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 07:45:38 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 07:45:38 INFO - PROCESS | 7352 | Values: 146.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 148.0 147.0 07:45:38 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.87 07:45:38 INFO - PROCESS | 7352 | Values: 97.0 97.0 95.0 95.0 96.0 96.0 95.0 97.0 95.0 95.0 07:45:38 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:58.00 stddev:17.35 (29.9%) stddev-sans-first:18.27 07:45:38 INFO - PROCESS | 7352 | Values: 58.0 59.0 58.0 57.0 61.0 58.0 62.0 113.0 56.0 57.0 07:45:38 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 07:45:38 INFO - PROCESS | 7352 | Values: 59.0 59.0 59.0 60.0 60.0 59.0 60.0 60.0 59.0 59.0 07:45:38 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.50 stddev:2.10 (2.6%) stddev-sans-first:1.58 07:45:38 INFO - PROCESS | 7352 | Values: 85.0 80.0 81.0 80.0 81.0 84.0 79.0 80.0 79.0 79.0 07:45:38 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:134.00 stddev:24.73 (18.5%) stddev-sans-first:25.71 07:45:38 INFO - PROCESS | 7352 | Values: 125.0 131.0 144.0 143.0 125.0 123.0 137.0 125.0 206.0 131.0 07:45:38 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:173.00 stddev:3.47 (2.0%) stddev-sans-first:3.68 07:45:38 INFO - PROCESS | 7352 | Values: 173.0 177.0 170.0 171.0 175.0 173.0 169.0 178.0 172.0 167.0 07:45:38 INFO - PROCESS | 7352 | 07:45:38 INFO - PROCESS | 7352 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.50 stddev:1.20 (1.8%) stddev-sans-first:1.22 07:45:38 INFO - PROCESS | 7352 | Values: 66.0 67.0 66.0 65.0 65.0 64.0 66.0 64.0 65.0 63.0 07:45:38 INFO - PROCESS | 7352 | -------- Summary: end -------- 07:45:38 INFO - PROCESS | 7352 | 07:45:39 INFO - TEST-INFO | 7352: exit 0 07:45:39 INFO - TEST-OK | kraken | took 62737ms 07:45:39 INFO - SUITE-END | took 1173s 07:45:40 INFO - Completed test suite (00:19:33) 07:45:40 INFO - javascript benchmark 07:45:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7245.873976993168, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3198.0405878236525, 3221.8550165242564, 3242.0760083376235, 3249.75626827988, 3253.121657152569, 5515.779368825247, 5521.4478552144765, 5523.972380138103, 5535.667859928407, 5555.722213889305, 5424.105022671254, 5524.116141417364, 5583.3858275589655, 5613.270274864262, 5692.544596432286, 4900.534449227318, 4961.107000739866, 5022.096022715928, 5070.797168113271, 5078.415982162043, 914.4837431917621, 4897.240927656219, 4912.680675756083, 5097.617678674096, 5106.463821298766, 4953.851384458454, 4956.330895329121, 4972.776225069862, 4979.10376132296, 4986.800527978877, 4954.455009948902, 4968.354113965198, 4981.800727970877, 4992.700437973697, 5004.624653150991, 4986.87532811679, 5007.223880298523, 5070.923936140961, 5085.364329458817, 5090.9236361454605, 5472.26124473195, 5510.9448905511235, 5521.4478552144865, 5533.6956467394275, 5567.914256719901, 5669.886602267973, 5863.472287494146, 5871.6183448075735, 5873.1190321451695, 5949.0, 6030.155778191057, 6101.481374083208, 6111.47019340724, 6112.052631842072, 6140.293866205398, 5654.349749778746, 5667.093265077568, 5674.829755107395, 5677.148427735872, 5680.0, 5906.468417842415, 6055.545834062463, 6076.969615151985, 6203.4416902479, 6225.62646241227, 5832.591718579743, 5838.562107841929, 5845.123231515222, 5845.473907348359, 5849.0, 5983.431574000463, 5990.670513121733, 5992.221011268594, 5998.820035398945, 5999.430054144849, 5819.127130930395, 5859.560532960045, 5881.176635271066, 5892.204552385373, 5961.910571341434, 5847.298324201123, 5893.616914900518, 5904.0, 5907.261592300963, 5910.113482977587, 4369.344598310216, 4442.8667139985855, 4456.821727130879, 4464.419625448671, 4509.7970591323465, 3881.7476864003747, 3938.0, 3959.0, 3974.82113304902, 3988.8205030773684, 5630.887382252332, 5640.830775076754, 5667.4615911488345, 5706.9714651426475, 5735.1684005818925, 5882.588218824641, 6014.097885317237, 6017.518598512196, 6018.699065046818, 6023.307319658208, 5667.773289068474, 5706.3152421709665, 5728.684922329228, 5733.799317023884, 5736.799212027642, 5082.695038297714, 5105.387353517602, 5136.409312929061, 5143.0, 5202.609804264695, 5951.851203719942, 6118.908216376758, 6169.413905678954, 6206.410391012847, 6211.192544969125, 5800.0429929062075, 6003.609765365412, 6006.189164462917, 6022.2171117754415, 6037.516998640011, 6164.691765411621, 6189.783357582463, 6214.9067763984485, 6218.782342618168, 6219.751209951552, 5756.827295181151, 5840.123981402823, 5844.853878653068, 5919.792807251725, 5926.4666180044005, 6008.399160083956, 6011.579189456871, 6016.909746353896, 6021.849453763691, 6054.969725151523, 5753.71231438418, 5815.709214539341, 5824.242848429677, 5830.912536312044, 5836.824895253149, 5606.299212598426, 5737.942620573908, 5762.740676669644, 5799.391063938395, 5800.477956983723, 5569.164625306236, 5706.686132262766, 5713.257276554022, 5723.084306510938, 5731.541476681772, 5824.767009319579, 5838.416158384128, 5867.149263356875, 5876.1773351731645, 5885.440883116097, 5535.723213839373, 5686.658800471985, 5715.5713321500225, 5748.770049197985, 5762.942370576408], "value": 5442.604843812572, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.6855635069763, 660.7291010685618, 664.8803215421225, 674.190970834998, 675.2639622811134, 38374.0, 42094.36858447126, 42133.578664213426, 42134.57865421345, 42173.367399489034, 42304.365434518506, 42681.57318426815, 42737.78631106848, 42798.572014279845, 42846.357304640456, 8837.0, 8939.731808045737, 8950.239229665487, 8979.506127163037, 8995.28037756978, 8812.471251724884, 8884.73345799627, 8930.106989301083, 8969.372143949926, 8972.50651214183, 8900.51047192404, 8945.59744811485, 8950.731478055668, 8960.372773905829, 8965.058668839776, 8845.601947912359, 8900.688475903346, 8923.955380223122, 8957.104289571056, 8969.910300896972, 8761.0, 8798.51608161551, 8805.515696636683, 8816.69141580048, 8828.8675669865, 40300.59699402998, 40788.592114078776, 40792.59207407918, 40848.59151408478, 40855.38716919249, 3250.431174544469, 3329.034579971805, 3341.899743007714, 3505.8071806050657, 3869.9806500967316, 31460.37079258402, 32064.35871282561, 32068.679313207034, 32115.197120072185, 32294.838525807456, 4441.311596702516, 4445.444319460067, 4446.750758422473, 4458.487273963503, 4501.684882058257, 324360.37819810986, 326302.0, 327123.0, 327709.0, 328064.0, 55855.44144558503, 56899.99999999917, 56902.14646780302, 56928.43071569314, 56962.715186423804, 36940.26119477595, 37633.24733505314, 37698.62301377006, 60765.39234607686, 60842.0, 17097.316107355815, 17228.741568876478, 17337.479875603753, 17367.826321736873, 17383.47849564515, 13167.814896659347, 13272.933635331761, 13338.933305333605, 13345.399457024263, 13428.060035797596, 19579.11893964775, 19680.0, 19714.605707885763, 19716.605667886848, 19723.40829775109, 7277.598392530453, 7300.269973002657, 7426.665800038903, 7537.849243015218, 7582.128055273603, 1032.2825636182781, 1087.8477013218155, 1101.8705826527873, 1169.5263418315596, 1202.6091520255952, 31952.680473195436, 32433.027009189762, 32670.346593068007, 32775.50836737451, 33130.66869331324, 1117.5966691236501, 1144.4106285263097, 1163.953441862316, 1166.4517676691942, 1185.51986445488, 16939.576510587332, 17293.74059389085, 17378.565535861704, 17449.912750436168, 17479.825201748074, 426946.0, 430519.0, 431493.0, 434206.0, 434519.0, 56134.0, 57546.424535754944, 57609.423905760406, 57804.0, 57851.132233016535, 1441.54591303739, 1446.696193799314, 1447.160646824839, 1451.1945870042016, 1461.7807328900537, 29965.886915372528, 31081.53377699291, 31193.68806311908, 31733.682663173073, 31833.681663183997, 49734.0, 49811.501884982135, 50027.249591256885, 50133.0, 50204.0, 368508.0, 369029.0, 370539.0, 371515.0, 371851.0, 27959.161225163276, 27994.720052800025, 28026.43947121087, 28299.15102546927, 28487.715122848505, 47942.041159177315, 48300.27549586829, 48366.0, 48685.2697209535, 49136.0, 40274.0, 40476.79761601173, 40842.387364188966, 40914.0, 42005.159896801284, 39264.0, 40284.3957340646, 41083.46769192608, 41157.382639261035, 41246.38130427986, 41527.58472415237, 42192.78903605462, 42815.571844281156, 43118.78440607777, 45181.77409113065, 35810.64189358177, 36717.63282367249, 36855.81572092122, 37463.43804842875, 37882.0529486754, 28765.56851647269, 28954.85522572458, 29005.274868128465, 29260.41479170362, 29517.704822951495], "value": 19927.409576067617, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.5036904607333, 408.1205003218066, 410.3147743268741, 411.2638377304624, 424.6539070657414, 13926.79109813351, 17712.64574708505, 19044.809551904476, 19766.30817921373, 19830.30593929211, 18934.337298194565, 19150.425487235407, 19357.225710971543, 19892.303769368074, 20007.699884501744, 5635.070213414792, 5651.745671444794, 5841.7371218295275, 5854.853628659296, 5874.118882167688, 5786.739596718136, 5813.593048486608, 5819.418058194168, 5826.096954971965, 5840.036393994986, 5576.358718747335, 5817.389174136718, 5819.447152520504, 5823.475887170154, 5825.30096388434, 5552.0, 5748.913766293509, 5770.394108618577, 5772.278465191851, 5791.594588378815, 5140.074786538422, 5180.792768289264, 5183.118869792144, 5195.090859099642, 5202.297689811865, 22527.436814079614, 22743.31770046901, 23109.306720798402, 23236.41908952273, 23268.534629307487, 2301.9654705179437, 2351.922876031573, 2443.3769388805918, 2518.3452302401506, 2717.388587567801, 14549.854501454956, 14875.925620371938, 15005.174715390649, 15334.539963801104, 15380.230988450532, 1932.8357089647398, 1934.8548858835502, 2037.6841589553642, 2076.397844625057, 2121.713568668241, 90193.54903225442, 96338.0, 97469.51265243629, 98795.0, 98862.0, 9392.154706076486, 9622.663206787729, 9725.9027409725, 10037.899621003842, 10147.0, 12332.630021099201, 12374.381280935917, 12420.130590858735, 12447.128700991025, 12524.499020039279, 7174.3184397482155, 7266.128064632172, 7377.963110184414, 7389.556626602313, 7456.105267367951, 7215.530990485601, 7286.70853165878, 7397.519161254501, 7411.0, 7651.579163145969, 3737.8131093445218, 3902.5316961964745, 3919.235749028969, 4031.4355990161403, 4295.935560966588, 2002.8698134621202, 2032.1972820736023, 2056.4961584411917, 2087.279888438486, 2099.821515171197, 922.418876108061, 973.493783232715, 1008.2740426892625, 1028.4240825137947, 1095.8411030400548, 19029.238830446902, 19303.0, 19425.708614370797, 19426.4172074838, 19531.414057578295, 993.2897977945803, 1005.1154983614373, 1026.9948650256702, 1058.4813441413653, 1060.6393826099163, 9671.516424178904, 10836.512356943957, 10969.890301097046, 11016.11871050314, 11100.777984440267, 492980.0, 504109.0, 510947.0, 511078.0, 524812.0, 72324.93725439275, 88314.0, 88492.55753721319, 90312.54843725871, 91069.54465227631, 1040.3549799124592, 1061.6814955513314, 1065.3448129400363, 1082.9675109746563, 1084.5553323137633, 17242.482725518254, 17582.91208543949, 17663.64672706513, 17895.37366192177, 17940.372086976895, 38748.225035499694, 39503.407448888865, 39754.0, 41227.58772412237, 42075.1584968305, 56161.157582635475, 57325.84707841109, 57460.71269643792, 58762.70618646879, 59044.40955590389, 5727.856803579777, 6488.480921526361, 7427.851442971002, 7737.497062690907, 7953.16491768356, 10817.567297308335, 11288.492017859051, 13236.205827650372, 13396.799048014092, 13822.93088534551, 11824.940875295913, 11833.763324733629, 11976.281423114293, 12074.577389791666, 12185.451654675739, 11405.0, 11579.189456737948, 11596.246243994114, 11734.70663233426, 12214.877851221729, 11639.41802909868, 11816.586419475621, 12036.939815300868, 12454.813177802522, 12913.225206487641, 7613.08642962848, 8197.46716463428, 8381.0, 8382.874256886029, 8395.160483951557, 11062.22564420483, 11245.100391968786, 11601.245919015237, 11920.701982450508, 12017.0], "value": 9169.070222629003, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.899207559433, 1457.9343929523175, 1525.2678714217175, 1788.1685016467331, 1818.2363407368903, 8088.91911080889, 8735.519546424945, 8829.646814127427, 9335.113164249402, 9365.0, 8970.596323165457, 9035.277177825774, 9035.819283614324, 9070.591823367948, 9124.726258212264, 2378.9524209515844, 2409.4578719788083, 2414.5653782319177, 2419.794317483016, 2421.0315873650593, 2331.5803155432013, 2370.7510711375317, 2373.95252094958, 2388.844725092872, 2390.5577468168444, 2344.648302754592, 2361.633946738258, 2372.28831350595, 2393.150431596784, 2406.278116565032, 2297.6553516972504, 2306.1928325086255, 2306.7693230676964, 2315.154968436517, 2338.7193536775526, 2353.623420252751, 2360.6459031145296, 2360.7875291223872, 2369.7867191952637, 2386.6539351793895, 9006.459612423276, 9107.271418286522, 9141.131592498701, 9188.40275382098, 9209.079092090804, 5452.863678408032, 5544.944550554484, 5577.079781835992, 5578.079616863253, 5584.636998595079, 3591.5813253764877, 3684.1894783147663, 3714.9257014859822, 3738.906527336811, 3746.3256613809504, 1164.0920082335792, 1202.9218100823507, 1221.993890030553, 1223.1376879300071, 1225.6997035726304, 11735.295882247006, 11920.821187682192, 11930.164888457812, 11935.403229838561, 11949.880501194964, 4685.484596694361, 4700.318453824177, 4826.58973987208, 4844.4186697596515, 4864.246041863516, 10545.314554554083, 10601.84097238542, 10617.203709721802, 10622.89377106219, 10631.0, 5339.439358867341, 5427.538659213932, 5440.347158341025, 5454.59090568209, 5501.312335958005, 4425.446819147606, 4961.107000739901, 4999.600031997432, 5102.642815002914, 5156.458571849902, 4148.522919864194, 4151.875443736692, 4207.474065741782, 4233.153369326147, 4314.288142456522, 1308.13009348782, 1332.5003123828565, 1333.5399287245884, 1372.3755691160497, 1381.8756311931975, 906.569379544711, 986.958758509779, 993.3989936088562, 995.2684776689127, 1005.3364779245662, 5931.139984702194, 5987.550933679991, 6114.327423983358, 6120.112583675342, 6204.410580994799, 979.7746518300688, 1016.6797458800454, 1017.9491025448698, 1038.5586125896464, 1068.2148620763733, 4066.8576599818866, 4096.959030409717, 4214.494260688737, 4233.5131459882505, 4258.914821703611, 10876.0, 11142.442877856074, 11379.487923043484, 11456.427178641035, 11552.537898484135, 10619.0, 10911.127109831194, 11179.83230251547, 11361.091112711129, 11447.771044579062, 8389.874151887727, 8426.07313195548, 8485.957570212233, 8528.104549022388, 8534.274586660204, 6076.483498902466, 6114.0, 6217.7823776169425, 6231.875362492816, 6339.461145802474, 10408.739781505523, 10470.214733894836, 10584.4707764613, 10696.786064278827, 10756.623518176826, 10270.589176432859, 10746.612513219925, 10885.23803333759, 10976.176786740867, 10994.615188468366, 7250.709971601077, 7935.0874649416055, 8136.593170341577, 8193.098759136372, 8318.251357377865, 8976.86534701993, 9046.185843274137, 9053.0, 9097.1812536872, 9097.363184577016, 8081.353491720531, 8260.958695206486, 8264.0, 8304.501729896225, 8371.623276952674, 7745.961270193613, 7790.220977902164, 7812.804679883048, 7893.289603935444, 7899.447038707235, 7297.598632075287, 7308.378787802883, 7346.449016323904, 7412.11054673421, 7504.399648028036, 5192.27308176848, 5214.582833373397, 5316.415194328543, 5347.652402593819, 5406.053940560308, 5201.193814958688, 5214.478552144755, 5238.68567885928, 5264.815731449381, 5376.924615077079], "value": 4808.771768747325, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.45398111190656, 339.60760880390393, 342.9691327780499, 344.155099231387, 347.260335485416, 5470.17947307903, 5596.916046259309, 5658.603897727161, 5676.687782171979, 5756.338021127572, 5593.8601534961645, 5626.634268772527, 5674.914876276859, 5686.971565142178, 5699.349802341911, 4347.7173983690955, 4349.565043495657, 4357.803898824561, 4370.6940514164025, 4372.5627437256335, 4067.1052368479036, 4291.746832912714, 4317.201317756209, 4328.982689068066, 4396.944733264009, 4247.405363249148, 4248.766317852533, 4266.06146647737, 4279.893002674927, 4279.908623301054, 4300.354946757996, 4304.720193187449, 4308.267594508941, 4316.589923957219, 4341.0, 3617.7286703497343, 3731.253749250161, 3751.924961500782, 3758.5113935188524, 3769.4722738816586, 5360.490753378462, 5362.27609272751, 5381.704006279653, 5385.892282154374, 5401.864953376158, 4859.95140048602, 4894.5105489451125, 4896.608271338285, 4912.631552633567, 4916.975415122937, 5653.802116925888, 5755.65466072037, 5792.304923409176, 5816.941830581683, 5840.15317778924, 4118.661435033596, 4120.361343991686, 4120.958790412117, 4163.188178305231, 4203.0, 5903.284489135046, 6128.172696685935, 6129.509639228851, 6143.784967526115, 6147.2930612979635, 4206.233381979576, 4225.936610950838, 4236.110416812442, 4242.32122860347, 4252.893677658083, 4274.081072569413, 4308.698391112592, 4317.978410107992, 4326.6538676905775, 4329.307310830252, 4864.391951006124, 4879.2922477132715, 4890.633202509826, 4933.284673722362, 4944.1100601892, 5711.143328500675, 5780.566457515703, 5855.94144058554, 5870.853228669317, 5873.735681894325, 1467.882569394446, 1470.4265336518765, 1485.4503833581643, 1485.4578079001087, 1489.9925500372428, 899.1143723432414, 923.3582660051334, 926.9212116970133, 933.7852293972288, 937.1659223291276, 4993.675411098267, 4993.825216117419, 5039.496050394931, 5074.209184948338, 5074.847754567295, 5248.291480650063, 5297.231901374279, 5319.117044557494, 5326.573874090063, 5348.893022139536, 5013.774380152902, 5018.197088465901, 5020.636173763587, 5334.866628334245, 5810.94189058104, 3235.822029788384, 3240.8217548035086, 3247.220667039893, 3253.07287423088, 3270.918227044343, 6088.634681919099, 6150.630962142286, 6186.938130618726, 6254.468370188494, 6279.215098112736, 6097.298810636834, 6114.510839132859, 6151.661658608819, 6169.629822210682, 6188.2883468400805, 6225.0, 6296.212973378328, 6306.045126010951, 6311.842203944938, 6313.684315784192, 5786.334571524329, 6012.308584512837, 6020.729067192075, 6040.728167232573, 6089.51283897296, 5939.762409503572, 5993.910091348721, 5998.790042348497, 6065.514758819372, 6080.817575472743, 5899.997000509838, 6243.594166379171, 6279.748810047547, 6287.811365659038, 6305.873882522232, 4235.23765722173, 4254.829806807817, 4256.489221293465, 4270.145970805914, 4289.120730250229, 5855.0, 5864.44287792659, 6058.121572371893, 6150.446459818459, 6152.600080994721, 5765.8558536036935, 5814.738336774771, 5845.736941837713, 5848.239728835224, 5889.234399528034, 5810.796622118206, 5825.155352473783, 5864.530837532901, 5872.442117998783, 5885.882282354414, 5545.626055009561, 5781.219535362672, 5786.479216870502, 5804.303483581997, 5836.474717275466, 5918.644881307136, 5934.19888315072, 5937.703114844154, 5938.970305148447, 5942.970285148546, 5542.0, 5788.855278618068, 5810.854728631818, 5816.069428891357, 5861.912071318849], "value": 4410.9472399734195, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.8806684963829, 837.5351679817701, 839.0309192882223, 848.8896443462356, 857.524074138853, 13033.869661303384, 13704.314784260785, 13983.091099078578, 14011.0, 14024.158550486978, 13814.516491922785, 13846.100003499765, 13937.094088884216, 13950.930245348785, 13952.720945581083, 698.7379732600275, 836.3392919593514, 846.5682501924001, 847.474565769224, 848.321342925657, 822.6873787960567, 833.5873742497472, 833.6415341403194, 844.4257904624852, 844.4848642328175, 878.1218781218781, 879.5909901895617, 879.6437442835662, 882.1531329923281, 890.6526454682679, 867.761365624452, 876.2114097312406, 877.5085951866974, 880.1198801198801, 884.9247813935823, 642.1299139665732, 642.958207716497, 645.3191882563893, 646.5603389695005, 647.718242564486, 12366.814497782541, 12484.188527745668, 12504.74990500194, 12544.937275313656, 12596.55912043074, 13868.375923083486, 13919.095258808145, 14121.576352709333, 14244.786328205086, 14254.928725356307, 11629.534818607246, 11641.126915481373, 11678.182527223098, 11751.236169649032, 11937.40312984356, 3804.8097595120134, 3859.517560304962, 3927.7643341399607, 4009.458723072377, 4013.1973605279063, 55168.724156379365, 55294.9999999996, 55327.72336138294, 55655.443445565434, 55672.164917525864, 10585.523651435704, 10826.729331766612, 10877.238593298393, 10941.507632156572, 11044.226904116795, 19598.0, 19677.50806229856, 19886.105125269107, 19908.0, 20037.0, 8436.114208008194, 8475.830483390298, 8541.743747687578, 8666.653333866701, 8739.737807865775, 4698.694584851974, 4747.525247475294, 4823.855284341475, 4842.031593681278, 4912.852614421573, 3361.647027062172, 3423.281110966675, 3432.5880894292845, 3432.708219801345, 3438.570178727659, 680.7583307925714, 686.800827759954, 693.4729605499856, 699.9020137180798, 702.4836744992426, 674.7301079568114, 720.1466262478979, 753.8002429356225, 765.1545042727817, 788.4520258420457, 8964.327675424369, 9042.547872606476, 9187.402818816756, 9422.623095076257, 9778.511074446249, 712.2841544247998, 715.141829804237, 725.3725527418745, 750.5730793795365, 810.4332088680329, 4380.627646650007, 4556.567126123013, 4575.725456472623, 4590.586847183769, 4639.072185562901, 57695.71152144212, 57849.0, 58438.70780646155, 58734.0, 60326.69836650876, 54814.72592637011, 55481.44518554763, 56197.71901140468, 56820.43179568234, 58490.41509584935, 49366.50633493619, 49506.25740613894, 49524.75237623789, 49792.25311620328, 51517.0, 8350.373721970755, 8472.237498624907, 9612.807743845224, 9797.363171393836, 9800.607975680892, 32987.505187422685, 33163.50254746229, 34476.0, 34674.653253468154, 35092.64907350894, 42026.57973420226, 42901.570984289756, 44359.33460998023, 44973.0, 45288.77355613201, 12313.076519260912, 12402.75194496087, 12518.311492867979, 12530.686732831387, 12879.871201288242, 13317.558068157205, 13486.460541578226, 13652.112612680145, 13796.793048104086, 13951.441942322193, 12878.291693956922, 12915.870841291468, 12947.482100716243, 12982.480700772241, 13066.346682665639, 12522.186057906207, 12617.684557886127, 12872.742545148858, 12944.611661650166, 13260.734785304432, 13109.0, 13127.934360328138, 13139.474421023053, 13442.260675662932, 13489.460421583026, 10770.492131101808, 10935.28920620157, 11233.0, 11315.151363647925, 11529.077673785909, 11072.833907491555, 11152.386618736047, 11347.773044538897, 11390.088792896715, 11428.37143957057], "value": 6860.476514483532, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 103.0, 112.0, 111.0, 111.0, 106.0, 110.0, 110.0, 111.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 134.0, 152.0, 205.0, 130.0, 160.0, 148.0, 132.0, 209.0, 127.0], "value": 155.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 164.0, 163.0, 175.0, 165.0, 163.0, 162.0, 162.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 167.0, 76.0, 75.0, 74.0, 75.0, 160.0, 77.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 183.0, 94.0, 91.0, 92.0, 148.0, 95.0, 91.0, 154.0], "value": 113.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0, 97.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 57.0, 61.0, 58.0, 62.0, 113.0, 56.0, 57.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 60.0, 60.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 81.0, 80.0, 81.0, 84.0, 79.0, 80.0, 79.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 131.0, 144.0, 143.0, 125.0, 123.0, 137.0, 125.0, 206.0, 131.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 177.0, 170.0, 171.0, 175.0, 173.0, 169.0, 178.0, 172.0, 167.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 65.0, 65.0, 64.0, 66.0, 64.0, 65.0, 63.0], "value": 65.1, "unit": "score"}]}]} 07:45:40 INFO - Return code: 0 07:45:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:45:40 ERROR - # TBPL SUCCESS # 07:45:40 INFO - Running post-action listener: _resource_record_post_action 07:45:40 INFO - ##### 07:45:40 INFO - ##### Finished run-tests step (success) 07:45:40 INFO - ##### 07:45:40 INFO - Running post-run listener: _resource_record_post_run 07:45:41 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 2351104; Write bytes: 540860416; Read time: 956; Write time: 438572 07:45:41 INFO - TinderboxPrint: CPU usage
13.4% 07:45:41 INFO - TinderboxPrint: I/O read bytes / time
2,351,104 / 956 07:45:41 INFO - TinderboxPrint: I/O write bytes / time
540,860,416 / 438,572 07:45:41 INFO - TinderboxPrint: CPU idle
8,227.8 (86.6%) 07:45:41 INFO - TinderboxPrint: CPU user
1,218.2 (12.8%) 07:45:41 INFO - TinderboxPrint: Swap in / out
0 / 0 07:45:41 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 251297792; Read time: 0; Write time: 249900 07:45:41 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 2351104; Write bytes: 285564928; Read time: 956; Write time: 188244 07:45:41 INFO - Running post-run listener: _upload_blobber_files 07:45:41 INFO - Blob upload gear active. 07:45:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:45:41 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:45:41 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:45:41 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:45:41 INFO - (blobuploader) - INFO - Open directory for files ... 07:45:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:45:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:45:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:42 INFO - (blobuploader) - INFO - Done attempting. 07:45:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:45:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:45:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:43 INFO - (blobuploader) - INFO - Done attempting. 07:45:43 INFO - (blobuploader) - INFO - Iteration through files over. 07:45:43 INFO - Return code: 0 07:45:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:45:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:45:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fbfbd99ec861971841d39bc8862530e286b4f5dbdcf21501649c9b1a69e1b1ea1df145f317abc9b5fbbfba786d889f24853a0ea5651ccd0999092af948dba2d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3413daf3745c54bd02d8da84809e8248983ff0ffc4630c1a843650cb88e6f6888f507524433c305a2dc602bd87e0eeba4e40525270e3d57e33af950ec13e37b4"} 07:45:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:45:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:45:43 INFO - Contents: 07:45:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fbfbd99ec861971841d39bc8862530e286b4f5dbdcf21501649c9b1a69e1b1ea1df145f317abc9b5fbbfba786d889f24853a0ea5651ccd0999092af948dba2d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3413daf3745c54bd02d8da84809e8248983ff0ffc4630c1a843650cb88e6f6888f507524433c305a2dc602bd87e0eeba4e40525270e3d57e33af950ec13e37b4"} 07:45:43 INFO - Running post-run listener: copy_logs_to_upload_dir 07:45:43 INFO - Copying logs to upload dir... 07:45:43 INFO - mkdir: /builds/slave/test/build/upload/logs 07:45:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.913151 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-05-12 07:45:42.633796) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 07:45:42.636989) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163 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/fbfbd99ec861971841d39bc8862530e286b4f5dbdcf21501649c9b1a69e1b1ea1df145f317abc9b5fbbfba786d889f24853a0ea5651ccd0999092af948dba2d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3413daf3745c54bd02d8da84809e8248983ff0ffc4630c1a843650cb88e6f6888f507524433c305a2dc602bd87e0eeba4e40525270e3d57e33af950ec13e37b4"} build_url:https://queue.taskcluster.net/v1/task/UFNGOwmUSQGMJSOn_ClBKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011084 build_url: 'https://queue.taskcluster.net/v1/task/UFNGOwmUSQGMJSOn_ClBKw/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/fbfbd99ec861971841d39bc8862530e286b4f5dbdcf21501649c9b1a69e1b1ea1df145f317abc9b5fbbfba786d889f24853a0ea5651ccd0999092af948dba2d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3413daf3745c54bd02d8da84809e8248983ff0ffc4630c1a843650cb88e6f6888f507524433c305a2dc602bd87e0eeba4e40525270e3d57e33af950ec13e37b4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 07:45:42.662793) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 07:45:42.663231) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1463063112.108572-35889163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 07:45:42.746366) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 07:45:42.746712) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 07:45:42.747042) ========= ========= Total master_lag: 0.17 =========