builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1464012137.93 results: success (0) buildid: 20160523043014 builduid: b62c6aac5bf143eabcbc637de749e5be revision: d3d23c5640717bfb9c72db8e951c462685991854 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 07:02:17.926236) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 07:02:17.936223) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 07:02:17.936598) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 07:02:18.026851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:02:18.027150) ========= 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=ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 07:02:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 592K=0.02s 2016-05-23 07:02:18 (592 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125436 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:02:18.176906) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:02:18.177242) ========= 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=ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020673 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:02:18.228192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 07:02:18.228542) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d3d23c5640717bfb9c72db8e951c462685991854 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d3d23c5640717bfb9c72db8e951c462685991854 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 07:02:18,553 truncating revision to first 12 chars 2016-05-23 07:02:18,553 Setting DEBUG logging. 2016-05-23 07:02:18,553 attempt 1/10 2016-05-23 07:02:18,553 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d3d23c564071?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 07:02:19,516 unpacking tar archive at: mozilla-inbound-d3d23c564071/testing/mozharness/ program finished with exit code 0 elapsedTime=1.260473 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 07:02:19.503940) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 07:02:19.504255) ========= script_repo_revision: d3d23c5640717bfb9c72db8e951c462685991854 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 07:02:19.504669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 07:02:19.504948) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 07:02:19.514720) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-23 07:02:19.515070) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:02:19 INFO - MultiFileLogger online at 20160523 07:02:19 in /builds/slave/test 07:02:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:02:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:02:19 INFO - {'append_to_log': False, 07:02:19 INFO - 'base_work_dir': '/builds/slave/test', 07:02:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:02:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:02:19 INFO - 'branch': 'Mozilla-Inbound', 07:02:19 INFO - 'buildbot_json_path': 'buildprops.json', 07:02:19 INFO - 'config_files': ('talos/linux_config.py',), 07:02:19 INFO - 'default_actions': ('clobber', 07:02:19 INFO - 'read-buildbot-config', 07:02:19 INFO - 'download-and-extract', 07:02:19 INFO - 'populate-webroot', 07:02:19 INFO - 'create-virtualenv', 07:02:19 INFO - 'install', 07:02:19 INFO - 'run-tests'), 07:02:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:02:19 INFO - 'download_minidump_stackwalk': True, 07:02:19 INFO - 'download_symbols': 'ondemand', 07:02:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:02:19 INFO - 'tooltool.py': '/tools/tooltool.py', 07:02:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:02:19 INFO - '/tools/misc-python/virtualenv.py')}, 07:02:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:02:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:02:19 INFO - 'installer_path': 'installer.exe', 07:02:19 INFO - 'log_level': 'info', 07:02:19 INFO - 'log_name': 'talos', 07:02:19 INFO - 'log_to_console': True, 07:02:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:02:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:02:19 INFO - 'opt_config_files': (), 07:02:19 INFO - 'pip_index': False, 07:02:19 INFO - 'sps_profile': False, 07:02:19 INFO - 'sps_profile_interval': 0, 07:02:19 INFO - 'suite': 'dromaeojs', 07:02:19 INFO - 'system_bits': '32', 07:02:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:02:19 INFO - 'title': 'talos-linux64-ix-035', 07:02:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:02:19 INFO - 'use_talos_json': True, 07:02:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:02:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:02:19 INFO - 'work_dir': 'build'} 07:02:19 INFO - ##### 07:02:19 INFO - ##### Running clobber step. 07:02:19 INFO - ##### 07:02:19 INFO - Running pre-action listener: _resource_record_pre_action 07:02:19 INFO - Running main action method: clobber 07:02:19 INFO - rmtree: /builds/slave/test/build 07:02:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:02:20 INFO - Running post-action listener: _resource_record_post_action 07:02:20 INFO - ##### 07:02:20 INFO - ##### Finished clobber step (success) 07:02:20 INFO - ##### 07:02:20 INFO - ##### 07:02:20 INFO - ##### Running read-buildbot-config step. 07:02:20 INFO - ##### 07:02:20 INFO - Running pre-action listener: _resource_record_pre_action 07:02:20 INFO - Running main action method: read_buildbot_config 07:02:20 INFO - Using buildbot properties: 07:02:20 INFO - { 07:02:20 INFO - "project": "", 07:02:20 INFO - "product": "firefox", 07:02:20 INFO - "script_repo_revision": "production", 07:02:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:02:20 INFO - "repository": "", 07:02:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:02:20 INFO - "buildid": "20160523043014", 07:02:20 INFO - "pgo_build": "True", 07:02:20 INFO - "basedir": "/builds/slave/test", 07:02:20 INFO - "buildnumber": 973, 07:02:20 INFO - "slavename": "talos-linux64-ix-035", 07:02:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:02:20 INFO - "platform": "ubuntu64_hw", 07:02:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:02:20 INFO - "branch": "mozilla-inbound", 07:02:20 INFO - "repo_path": "integration/mozilla-inbound", 07:02:20 INFO - "revision": "d3d23c5640717bfb9c72db8e951c462685991854", 07:02:20 INFO - "stage_platform": "linux64-pgo", 07:02:20 INFO - "builduid": "b62c6aac5bf143eabcbc637de749e5be", 07:02:20 INFO - "slavebuilddir": "test" 07:02:20 INFO - } 07:02:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:02:20 INFO - Running post-action listener: _resource_record_post_action 07:02:20 INFO - ##### 07:02:20 INFO - ##### Finished read-buildbot-config step (success) 07:02:20 INFO - ##### 07:02:20 INFO - ##### 07:02:20 INFO - ##### Running download-and-extract step. 07:02:20 INFO - ##### 07:02:20 INFO - Running pre-action listener: _resource_record_pre_action 07:02:20 INFO - Running main action method: download_and_extract 07:02:20 INFO - mkdir: /builds/slave/test/build/tests 07:02:20 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:02:20 INFO - https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:02:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:02:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:02:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:02:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:02:24 INFO - Downloaded 1361 bytes. 07:02:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:02:24 INFO - Using the following test package requirements: 07:02:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:02:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:02:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:02:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:02:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:02:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:02:24 INFO - u'jsshell-linux-x86_64.zip'], 07:02:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:02:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:02:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:02:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:02:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:02:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:02:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:02:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:02:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:02:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:02:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:02:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:02:24 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:02:24 INFO - https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:02:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:02:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:02:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:02:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:02:29 INFO - Downloaded 24412482 bytes. 07:02:29 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:02:29 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:02:30 INFO - Return code: 0 07:02:30 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:02: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:02:30 INFO - https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:02:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:02:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:02:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:02:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:02:35 INFO - Downloaded 24412482 bytes. 07:02:35 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:02:35 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:02:37 INFO - Return code: 0 07:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:37 INFO - https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:02:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:02:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:02:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:02:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:02:44 INFO - Downloaded 10840359 bytes. 07:02:44 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:02:44 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:02:44 INFO - Return code: 0 07:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:44 INFO - https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:02:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:02:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:02:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:02:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:02:46 INFO - Downloaded 58615786 bytes. 07:02:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:02:46 INFO - mkdir: /builds/slave/test/properties 07:02:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:02:46 INFO - Writing to file /builds/slave/test/properties/build_url 07:02:46 INFO - Contents: 07:02:46 INFO - build_url:https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:02:47 INFO - Running post-action listener: _resource_record_post_action 07:02:47 INFO - Running post-action listener: set_extra_try_arguments 07:02:47 INFO - ##### 07:02:47 INFO - ##### Finished download-and-extract step (success) 07:02:47 INFO - ##### 07:02:47 INFO - ##### 07:02:47 INFO - ##### Running populate-webroot step. 07:02:47 INFO - ##### 07:02:47 INFO - Running pre-action listener: _resource_record_pre_action 07:02:47 INFO - Running main action method: populate_webroot 07:02:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:02:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:02:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:02:47 INFO - '--tppagecycles', 07:02:47 INFO - '7'], 07:02:47 INFO - 'tests': ['tsvgm']}}, 07:02:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:02:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:02:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:02:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:02:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:02:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:02:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:47 INFO - 'talos_options': ['--disable-e10s'], 07:02:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:02:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:02:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:47 INFO - 'talos_options': ['--disable-e10s'], 07:02:47 INFO - 'tests': ['damp', 'tps']}, 07:02:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:47 INFO - 'tests': ['damp', 'tps']}, 07:02:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:02:47 INFO - 'tests': ['dromaeo_dom']}, 07:02:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:02:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:02:47 INFO - 'tests': ['a11yr', 07:02:47 INFO - 'ts_paint', 07:02:47 INFO - 'tpaint', 07:02:47 INFO - 'sessionrestore', 07:02:47 INFO - 'sessionrestore_no_auto_restore', 07:02:47 INFO - 'tabpaint']}, 07:02:47 INFO - 'other-e10s': {'tests': ['a11yr', 07:02:47 INFO - 'ts_paint', 07:02:47 INFO - 'tpaint', 07:02:47 INFO - 'sessionrestore', 07:02:47 INFO - 'sessionrestore_no_auto_restore', 07:02:47 INFO - 'tabpaint']}, 07:02:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:02:47 INFO - 'ts_paint', 07:02:47 INFO - 'tpaint', 07:02:47 INFO - 'sessionrestore', 07:02:47 INFO - 'sessionrestore_no_auto_restore', 07:02:47 INFO - 'tabpaint']}, 07:02:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:02:47 INFO - 'ts_paint', 07:02:47 INFO - 'tpaint', 07:02:47 INFO - 'sessionrestore', 07:02:47 INFO - 'sessionrestore_no_auto_restore', 07:02:47 INFO - 'tabpaint']}, 07:02:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:02:47 INFO - 'tests': ['a11yr', 07:02:47 INFO - 'ts_paint', 07:02:47 INFO - 'tpaint', 07:02:47 INFO - 'sessionrestore', 07:02:47 INFO - 'sessionrestore_no_auto_restore', 07:02:47 INFO - 'tabpaint']}, 07:02:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:02:47 INFO - 'tests': ['a11yr', 07:02:47 INFO - 'ts_paint', 07:02:47 INFO - 'tpaint', 07:02:47 INFO - 'sessionrestore', 07:02:47 INFO - 'sessionrestore_no_auto_restore', 07:02:47 INFO - 'tabpaint']}, 07:02:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:02:47 INFO - 'tests': ['tsvgx', 07:02:47 INFO - 'tsvgr_opacity', 07:02:47 INFO - 'tart', 07:02:47 INFO - 'tscrollx', 07:02:47 INFO - 'cart']}, 07:02:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:02:47 INFO - 'tsvgr_opacity', 07:02:47 INFO - 'tart', 07:02:47 INFO - 'tscrollx', 07:02:47 INFO - 'cart']}, 07:02:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:47 INFO - 'talos_options': ['--disable-e10s'], 07:02:47 INFO - 'tests': ['tp5o']}, 07:02:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:47 INFO - 'tests': ['tp5o']}, 07:02:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:47 INFO - 'talos_options': ['--disable-e10s', 07:02:47 INFO - '--xperf_path', 07:02:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:02:47 INFO - 'tests': ['tp5n']}, 07:02:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:47 INFO - 'talos_options': ['--xperf_path', 07:02:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:02:47 INFO - 'tests': ['tp5n']}}, 07:02:47 INFO - 'talos.zip': {'path': '', 07:02:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:02:47 INFO - Running post-action listener: _resource_record_post_action 07:02:47 INFO - ##### 07:02:47 INFO - ##### Finished populate-webroot step (success) 07:02:47 INFO - ##### 07:02:47 INFO - ##### 07:02:47 INFO - ##### Running create-virtualenv step. 07:02:47 INFO - ##### 07:02:47 INFO - Running pre-action listener: _resource_record_pre_action 07:02:47 INFO - Running main action method: create_virtualenv 07:02:47 INFO - Creating virtualenv /builds/slave/test/build/venv 07:02:47 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:02:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:02:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:02:47 INFO - Using real prefix '/usr' 07:02:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:02:47 INFO - Installing distribute.............................................................................................................................................................................................done. 07:02:49 INFO - Installing pip.................done. 07:02:49 INFO - Return code: 0 07:02:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:02:49 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:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:49 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:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:49 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 0x7fd622d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', '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:02:49 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:02:49 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:02:49 INFO - Using env: {'DISPLAY': ':0', 07:02:49 INFO - 'HOME': '/home/cltbld', 07:02:49 INFO - 'LANG': 'en_US.UTF-8', 07:02:49 INFO - 'LANGUAGE': 'en_US:en', 07:02:49 INFO - 'LOGNAME': 'cltbld', 07:02:49 INFO - 'MAIL': '/var/mail/cltbld', 07:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:49 INFO - 'MOZ_NO_REMOTE': '1', 07:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:49 INFO - 'NO_EM_RESTART': '1', 07:02:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:49 INFO - 'PWD': '/builds/slave/test', 07:02:49 INFO - 'SHELL': '/bin/bash', 07:02:49 INFO - 'SHLVL': '1', 07:02:49 INFO - 'TERM': 'linux', 07:02:49 INFO - 'TMOUT': '86400', 07:02:49 INFO - 'USER': 'cltbld', 07:02:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', 07:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:49 INFO - '_': '/tools/buildbot/bin/python'} 07:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:50 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:02:50 INFO - Cleaning up... 07:02:50 INFO - Return code: 0 07:02:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd622d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', '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:02:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:02:50 INFO - Using env: {'DISPLAY': ':0', 07:02:50 INFO - 'HOME': '/home/cltbld', 07:02:50 INFO - 'LANG': 'en_US.UTF-8', 07:02:50 INFO - 'LANGUAGE': 'en_US:en', 07:02:50 INFO - 'LOGNAME': 'cltbld', 07:02:50 INFO - 'MAIL': '/var/mail/cltbld', 07:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:50 INFO - 'MOZ_NO_REMOTE': '1', 07:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:50 INFO - 'NO_EM_RESTART': '1', 07:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:50 INFO - 'PWD': '/builds/slave/test', 07:02:50 INFO - 'SHELL': '/bin/bash', 07:02:50 INFO - 'SHLVL': '1', 07:02:50 INFO - 'TERM': 'linux', 07:02:50 INFO - 'TMOUT': '86400', 07:02:50 INFO - 'USER': 'cltbld', 07:02:50 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', 07:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:50 INFO - '_': '/tools/buildbot/bin/python'} 07:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:50 INFO - Downloading/unpacking psutil>=3.1.1 07:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:02:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:02:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:02:52 INFO - Installing collected packages: psutil 07:02:52 INFO - Running setup.py install for psutil 07:02:52 INFO - building 'psutil._psutil_linux' extension 07:02:52 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:02:52 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:02:52 INFO - building 'psutil._psutil_posix' extension 07:02:52 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:02:52 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:02:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:02:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:02:52 INFO - Successfully installed psutil 07:02:52 INFO - Cleaning up... 07:02:52 INFO - Return code: 0 07:02:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd622d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', '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:02:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:02:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:02:52 INFO - Using env: {'DISPLAY': ':0', 07:02:52 INFO - 'HOME': '/home/cltbld', 07:02:52 INFO - 'LANG': 'en_US.UTF-8', 07:02:52 INFO - 'LANGUAGE': 'en_US:en', 07:02:52 INFO - 'LOGNAME': 'cltbld', 07:02:52 INFO - 'MAIL': '/var/mail/cltbld', 07:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:52 INFO - 'MOZ_NO_REMOTE': '1', 07:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:52 INFO - 'NO_EM_RESTART': '1', 07:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:52 INFO - 'PWD': '/builds/slave/test', 07:02:52 INFO - 'SHELL': '/bin/bash', 07:02:52 INFO - 'SHLVL': '1', 07:02:52 INFO - 'TERM': 'linux', 07:02:52 INFO - 'TMOUT': '86400', 07:02:52 INFO - 'USER': 'cltbld', 07:02:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', 07:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:52 INFO - '_': '/tools/buildbot/bin/python'} 07:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:02:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:02:54 INFO - Installing collected packages: mozsystemmonitor 07:02:54 INFO - Running setup.py install for mozsystemmonitor 07:02:55 INFO - Successfully installed mozsystemmonitor 07:02:55 INFO - Cleaning up... 07:02:55 INFO - Return code: 0 07:02:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd622d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', '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:02:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:02:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:02:55 INFO - Using env: {'DISPLAY': ':0', 07:02:55 INFO - 'HOME': '/home/cltbld', 07:02:55 INFO - 'LANG': 'en_US.UTF-8', 07:02:55 INFO - 'LANGUAGE': 'en_US:en', 07:02:55 INFO - 'LOGNAME': 'cltbld', 07:02:55 INFO - 'MAIL': '/var/mail/cltbld', 07:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:55 INFO - 'MOZ_NO_REMOTE': '1', 07:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:55 INFO - 'NO_EM_RESTART': '1', 07:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:55 INFO - 'PWD': '/builds/slave/test', 07:02:55 INFO - 'SHELL': '/bin/bash', 07:02:55 INFO - 'SHLVL': '1', 07:02:55 INFO - 'TERM': 'linux', 07:02:55 INFO - 'TMOUT': '86400', 07:02:55 INFO - 'USER': 'cltbld', 07:02:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', 07:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:55 INFO - '_': '/tools/buildbot/bin/python'} 07:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:55 INFO - Downloading/unpacking blobuploader==1.2.4 07:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:57 INFO - Downloading blobuploader-1.2.4.tar.gz 07:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:02:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:02:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:57 INFO - Downloading docopt-0.6.1.tar.gz 07:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:02:57 INFO - Installing collected packages: blobuploader, requests, docopt 07:02:57 INFO - Running setup.py install for blobuploader 07:02:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:02:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:02:58 INFO - Running setup.py install for requests 07:02:58 INFO - Running setup.py install for docopt 07:02:58 INFO - Successfully installed blobuploader requests docopt 07:02:58 INFO - Cleaning up... 07:02:58 INFO - Return code: 0 07:02:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:02:58 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:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:58 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:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:58 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 0x7fd622d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', '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:02:58 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:02:58 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:02:58 INFO - Using env: {'DISPLAY': ':0', 07:02:58 INFO - 'HOME': '/home/cltbld', 07:02:58 INFO - 'LANG': 'en_US.UTF-8', 07:02:58 INFO - 'LANGUAGE': 'en_US:en', 07:02:58 INFO - 'LOGNAME': 'cltbld', 07:02:58 INFO - 'MAIL': '/var/mail/cltbld', 07:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:58 INFO - 'MOZ_NO_REMOTE': '1', 07:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:58 INFO - 'NO_EM_RESTART': '1', 07:02:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:58 INFO - 'PWD': '/builds/slave/test', 07:02:58 INFO - 'SHELL': '/bin/bash', 07:02:58 INFO - 'SHLVL': '1', 07:02:58 INFO - 'TERM': 'linux', 07:02:58 INFO - 'TMOUT': '86400', 07:02:58 INFO - 'USER': 'cltbld', 07:02:58 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', 07:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:58 INFO - '_': '/tools/buildbot/bin/python'} 07:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:02:58 INFO - Running setup.py (path:/tmp/pip-t2B4FG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:02:58 INFO - Running setup.py (path:/tmp/pip-_dz0YB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:02:58 INFO - Running setup.py (path:/tmp/pip-pSi2Gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:02:59 INFO - Running setup.py (path:/tmp/pip-41Iv6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:02:59 INFO - Running setup.py (path:/tmp/pip-AZjqd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:02:59 INFO - Running setup.py (path:/tmp/pip-Qi_R_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:02:59 INFO - Running setup.py (path:/tmp/pip-De_V1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:02:59 INFO - Running setup.py (path:/tmp/pip-CL9Po3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:02:59 INFO - Running setup.py (path:/tmp/pip-b9_7zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:02:59 INFO - Running setup.py (path:/tmp/pip-SO2GA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:02:59 INFO - Running setup.py (path:/tmp/pip-XqbQJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:02:59 INFO - Running setup.py (path:/tmp/pip-s9BHel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:02:59 INFO - Running setup.py (path:/tmp/pip-EwL2P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:02:59 INFO - Running setup.py (path:/tmp/pip-sCTZjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:02:59 INFO - Running setup.py (path:/tmp/pip-3iHG2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:02:59 INFO - Running setup.py (path:/tmp/pip-HyPCO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:02:59 INFO - Running setup.py (path:/tmp/pip-0KpOij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:03:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:03:00 INFO - Running setup.py install for manifestparser 07:03:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:03:00 INFO - Running setup.py install for mozcrash 07:03:00 INFO - Running setup.py install for mozdebug 07:03:00 INFO - Running setup.py install for mozdevice 07:03:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:03:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:03:00 INFO - Running setup.py install for mozfile 07:03:00 INFO - Running setup.py install for mozhttpd 07:03:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:03:00 INFO - Running setup.py install for mozinfo 07:03:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:03:00 INFO - Running setup.py install for mozInstall 07:03:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:03:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:03:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:03:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:03:00 INFO - Running setup.py install for mozleak 07:03:00 INFO - Running setup.py install for mozlog 07:03:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:03:01 INFO - Running setup.py install for moznetwork 07:03:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:03:01 INFO - Running setup.py install for mozprocess 07:03:01 INFO - Running setup.py install for mozprofile 07:03:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:03:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:03:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:03:01 INFO - Running setup.py install for mozrunner 07:03:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:03:01 INFO - Running setup.py install for mozscreenshot 07:03:01 INFO - Running setup.py install for moztest 07:03:01 INFO - Running setup.py install for mozversion 07:03:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:03:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:03:01 INFO - Cleaning up... 07:03:01 INFO - Return code: 0 07:03:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:01 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 0x7fd622d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', '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:03:01 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:03:01 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:03:01 INFO - Using env: {'DISPLAY': ':0', 07:03:01 INFO - 'HOME': '/home/cltbld', 07:03:01 INFO - 'LANG': 'en_US.UTF-8', 07:03:01 INFO - 'LANGUAGE': 'en_US:en', 07:03:01 INFO - 'LOGNAME': 'cltbld', 07:03:01 INFO - 'MAIL': '/var/mail/cltbld', 07:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:01 INFO - 'MOZ_NO_REMOTE': '1', 07:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:01 INFO - 'NO_EM_RESTART': '1', 07:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:01 INFO - 'PWD': '/builds/slave/test', 07:03:01 INFO - 'SHELL': '/bin/bash', 07:03:01 INFO - 'SHLVL': '1', 07:03:01 INFO - 'TERM': 'linux', 07:03:01 INFO - 'TMOUT': '86400', 07:03:01 INFO - 'USER': 'cltbld', 07:03:01 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', 07:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:01 INFO - '_': '/tools/buildbot/bin/python'} 07:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:03:02 INFO - Running setup.py (path:/tmp/pip-tLrdza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:03:02 INFO - Running setup.py (path:/tmp/pip-8EEB__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:03:02 INFO - Running setup.py (path:/tmp/pip-SkkG3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:03:02 INFO - Running setup.py (path:/tmp/pip-O6ey6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:03:02 INFO - Running setup.py (path:/tmp/pip-ydvUbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:03:02 INFO - Running setup.py (path:/tmp/pip-yyoZHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:03:02 INFO - Running setup.py (path:/tmp/pip-V5UWog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:03:02 INFO - Running setup.py (path:/tmp/pip-TJJdSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:03:02 INFO - Running setup.py (path:/tmp/pip-Am5Jfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:03:02 INFO - Running setup.py (path:/tmp/pip-BTSVyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:03:02 INFO - Running setup.py (path:/tmp/pip-f0Cotz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:03:02 INFO - Running setup.py (path:/tmp/pip-M4kQWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:03:02 INFO - Running setup.py (path:/tmp/pip-oUDkR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:03:02 INFO - Running setup.py (path:/tmp/pip-vYB8dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:03:03 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:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:03 INFO - Running setup.py (path:/tmp/pip-GP61T2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:03 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:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:03:03 INFO - Running setup.py (path:/tmp/pip-ZumjCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:03:03 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:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:03:03 INFO - Running setup.py (path:/tmp/pip-Kyzb8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:03:03 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:03:03 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:03:03 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:03:03 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:03:03 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:03:03 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:03:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:05 INFO - Downloading blessings-1.6.tar.gz 07:03:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:03:05 INFO - Installing collected packages: blessings 07:03:05 INFO - Running setup.py install for blessings 07:03:05 INFO - Successfully installed blessings 07:03:05 INFO - Cleaning up... 07:03:05 INFO - Return code: 0 07:03:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:03:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:03:05 INFO - Reading from file tmpfile_stdout 07:03:05 INFO - Current package versions: 07:03:05 INFO - argparse == 1.2.1 07:03:05 INFO - blessings == 1.6 07:03:05 INFO - blobuploader == 1.2.4 07:03:05 INFO - docopt == 0.6.1 07:03:05 INFO - manifestparser == 1.1 07:03:05 INFO - mozInstall == 1.12 07:03:05 INFO - mozcrash == 0.17 07:03:05 INFO - mozdebug == 0.1 07:03:05 INFO - mozdevice == 0.48 07:03:05 INFO - mozfile == 1.2 07:03:05 INFO - mozhttpd == 0.7 07:03:05 INFO - mozinfo == 0.9 07:03:05 INFO - mozleak == 0.1 07:03:05 INFO - mozlog == 3.2 07:03:05 INFO - moznetwork == 0.27 07:03:05 INFO - mozprocess == 0.22 07:03:05 INFO - mozprofile == 0.28 07:03:05 INFO - mozrunner == 6.11 07:03:05 INFO - mozscreenshot == 0.1 07:03:05 INFO - mozsystemmonitor == 0.3 07:03:05 INFO - moztest == 0.7 07:03:05 INFO - mozversion == 1.4 07:03:05 INFO - psutil == 3.1.1 07:03:05 INFO - requests == 1.2.3 07:03:05 INFO - wsgiref == 0.1.2 07:03:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:03: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:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03: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:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:05 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 0x7fd622d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', '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:03:05 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:03:05 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:03:05 INFO - Using env: {'DISPLAY': ':0', 07:03:05 INFO - 'HOME': '/home/cltbld', 07:03:05 INFO - 'LANG': 'en_US.UTF-8', 07:03:05 INFO - 'LANGUAGE': 'en_US:en', 07:03:05 INFO - 'LOGNAME': 'cltbld', 07:03:05 INFO - 'MAIL': '/var/mail/cltbld', 07:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:05 INFO - 'MOZ_NO_REMOTE': '1', 07:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:05 INFO - 'NO_EM_RESTART': '1', 07:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:05 INFO - 'PWD': '/builds/slave/test', 07:03:05 INFO - 'SHELL': '/bin/bash', 07:03:05 INFO - 'SHLVL': '1', 07:03:05 INFO - 'TERM': 'linux', 07:03:05 INFO - 'TMOUT': '86400', 07:03:05 INFO - 'USER': 'cltbld', 07:03:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', 07:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:05 INFO - '_': '/tools/buildbot/bin/python'} 07:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:05 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:03:05 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:03:05 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:03:05 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:03:05 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:03:05 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:03:05 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:03:05 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:03:05 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:03:05 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:03:05 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:03:05 INFO - Cleaning up... 07:03:05 INFO - Return code: 0 07:03:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:03: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:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03: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:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:05 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 0x7fd622d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', '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:03:05 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:03:05 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:03:05 INFO - Using env: {'DISPLAY': ':0', 07:03:05 INFO - 'HOME': '/home/cltbld', 07:03:05 INFO - 'LANG': 'en_US.UTF-8', 07:03:05 INFO - 'LANGUAGE': 'en_US:en', 07:03:05 INFO - 'LOGNAME': 'cltbld', 07:03:05 INFO - 'MAIL': '/var/mail/cltbld', 07:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:05 INFO - 'MOZ_NO_REMOTE': '1', 07:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:05 INFO - 'NO_EM_RESTART': '1', 07:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:05 INFO - 'PWD': '/builds/slave/test', 07:03:05 INFO - 'SHELL': '/bin/bash', 07:03:05 INFO - 'SHLVL': '1', 07:03:05 INFO - 'TERM': 'linux', 07:03:05 INFO - 'TMOUT': '86400', 07:03:05 INFO - 'USER': 'cltbld', 07:03:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', 07:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:05 INFO - '_': '/tools/buildbot/bin/python'} 07:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:06 INFO - Downloading/unpacking jsonschema 07:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:03:07 INFO - Downloading/unpacking functools32 (from jsonschema) 07:03:07 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:03:07 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:03:07 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:03:07 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:03:07 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:03:07 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:03:08 INFO - Downloading functools32-3.2.3-2.tar.gz 07:03:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:03:08 INFO - warning: no files found matching '*.txt' 07:03:08 INFO - no previously-included directories found matching 'build' 07:03:08 INFO - no previously-included directories found matching 'dist' 07:03:08 INFO - no previously-included directories found matching '.git*' 07:03:08 INFO - Installing collected packages: jsonschema, functools32 07:03:08 INFO - Running setup.py install for functools32 07:03:08 INFO - warning: no files found matching '*.txt' 07:03:08 INFO - no previously-included directories found matching 'build' 07:03:08 INFO - no previously-included directories found matching 'dist' 07:03:08 INFO - no previously-included directories found matching '.git*' 07:03:08 INFO - Successfully installed jsonschema functools32 07:03:08 INFO - Cleaning up... 07:03:08 INFO - Return code: 0 07:03:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:03:08 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:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:08 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:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:08 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 0x7fd622d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', '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:03:08 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:03:08 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:03:08 INFO - Using env: {'DISPLAY': ':0', 07:03:08 INFO - 'HOME': '/home/cltbld', 07:03:08 INFO - 'LANG': 'en_US.UTF-8', 07:03:08 INFO - 'LANGUAGE': 'en_US:en', 07:03:08 INFO - 'LOGNAME': 'cltbld', 07:03:08 INFO - 'MAIL': '/var/mail/cltbld', 07:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:08 INFO - 'MOZ_NO_REMOTE': '1', 07:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:08 INFO - 'NO_EM_RESTART': '1', 07:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:08 INFO - 'PWD': '/builds/slave/test', 07:03:08 INFO - 'SHELL': '/bin/bash', 07:03:08 INFO - 'SHLVL': '1', 07:03:08 INFO - 'TERM': 'linux', 07:03:08 INFO - 'TMOUT': '86400', 07:03:08 INFO - 'USER': 'cltbld', 07:03:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', 07:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:08 INFO - '_': '/tools/buildbot/bin/python'} 07:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:08 INFO - Downloading/unpacking flake8 07:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:03:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:03:10 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:03:10 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:03:10 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:03:10 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:03:10 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:03:10 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:03:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:03:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:03:10 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:03:10 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:03:10 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:03:10 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:03:10 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:03:10 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:03:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:03:10 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:03:10 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:03:10 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:03:10 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:03:10 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:03:10 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:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:03:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:03:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:03:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:03:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:03:11 INFO - no previously-included directories found matching 'docs/_build' 07:03:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:03:11 INFO - Running setup.py install for pep8 07:03:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:03:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:03:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:03:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:03:11 INFO - no previously-included directories found matching 'docs/_build' 07:03:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:03:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:03:11 INFO - Cleaning up... 07:03:11 INFO - Return code: 0 07:03:11 INFO - Running post-action listener: _resource_record_post_action 07:03:11 INFO - Running post-action listener: _start_resource_monitoring 07:03:11 INFO - Starting resource monitoring. 07:03:11 INFO - ##### 07:03:11 INFO - ##### Finished create-virtualenv step (success) 07:03:11 INFO - ##### 07:03:11 INFO - ##### 07:03:11 INFO - ##### Running install step. 07:03:11 INFO - ##### 07:03:11 INFO - Running pre-action listener: _resource_record_pre_action 07:03:11 INFO - Running main action method: install 07:03:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:03:11 INFO - Reading from file tmpfile_stdout 07:03:11 INFO - Detecting whether we're running mozinstall >=1.0... 07:03:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:03:11 INFO - Reading from file tmpfile_stdout 07:03:11 INFO - Output received: 07:03:11 INFO - Usage: mozinstall [options] installer 07:03:11 INFO - Options: 07:03:11 INFO - -h, --help show this help message and exit 07:03:11 INFO - -d DEST, --destination=DEST 07:03:11 INFO - Directory to install application into. [default: 07:03:11 INFO - "/builds/slave/test"] 07:03:11 INFO - --app=APP Application being installed. [default: firefox] 07:03:11 INFO - mkdir: /builds/slave/test/build/application 07:03:11 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:03:11 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:03:28 INFO - Reading from file tmpfile_stdout 07:03:28 INFO - Output received: 07:03:28 INFO - /builds/slave/test/build/application/firefox/firefox 07:03:28 INFO - Running post-action listener: _resource_record_post_action 07:03:28 INFO - ##### 07:03:28 INFO - ##### Finished install step (success) 07:03:28 INFO - ##### 07:03:28 INFO - ##### 07:03:28 INFO - ##### Running run-tests step. 07:03:28 INFO - ##### 07:03:28 INFO - Running pre-action listener: _resource_record_pre_action 07:03:28 INFO - Running main action method: run_tests 07:03:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:03:28 INFO - Python 2.7.3 07:03:28 INFO - Return code: 0 07:03:28 INFO - grabbing minidump binary from tooltool 07:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:28 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 0x285f9c0>, '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 0x28608c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2860d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:03:28 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:03:28 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:03:28 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:03:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:03:28 INFO - Return code: 0 07:03:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:03:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:03:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:03:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:03:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:03:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:03:29 INFO - Return code: 0 07:03:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:03:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:03:29 INFO - Using env: {'DISPLAY': ':0', 07:03:29 INFO - 'HOME': '/home/cltbld', 07:03:29 INFO - 'LANG': 'en_US.UTF-8', 07:03:29 INFO - 'LANGUAGE': 'en_US:en', 07:03:29 INFO - 'LOGNAME': 'cltbld', 07:03:29 INFO - 'MAIL': '/var/mail/cltbld', 07:03:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:03:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:03:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:29 INFO - 'MOZ_NO_REMOTE': '1', 07:03:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:03:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:29 INFO - 'NO_EM_RESTART': '1', 07:03:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:29 INFO - 'PWD': '/builds/slave/test', 07:03:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:03:29 INFO - 'SHELL': '/bin/bash', 07:03:29 INFO - 'SHLVL': '1', 07:03:29 INFO - 'TERM': 'linux', 07:03:29 INFO - 'TMOUT': '86400', 07:03:29 INFO - 'USER': 'cltbld', 07:03:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693', 07:03:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:29 INFO - '_': '/tools/buildbot/bin/python'} 07:03:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:03:29 INFO - mozversion application_buildid: 20160523043014 07:03:29 INFO - mozversion application_changeset: d3d23c5640717bfb9c72db8e951c462685991854 07:03:29 INFO - mozversion application_display_name: Nightly 07:03:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:03:29 INFO - mozversion application_name: Firefox 07:03:29 INFO - mozversion application_remotingname: firefox 07:03:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:03:29 INFO - mozversion application_vendor: Mozilla 07:03:29 INFO - mozversion application_version: 49.0a1 07:03:29 INFO - mozversion platform_buildid: 20160523043014 07:03:29 INFO - mozversion platform_changeset: d3d23c5640717bfb9c72db8e951c462685991854 07:03:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:03:29 INFO - mozversion platform_version: 49.0a1 07:03:29 INFO - using testdate: 1464012209 07:03:29 INFO - actual date: 1464012209 07:03:29 INFO - starting webserver on 'localhost:57879' 07:03:29 INFO - SUITE-START | Running 2 tests 07:03:29 INFO - TEST-START | dromaeo_css 07:03:29 INFO - operating with platform_type : linux_ 07:03:29 INFO - Initialising browser for dromaeo_css test... 07:03:29 INFO - TEST-INFO | started process 4963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFUI2v0/profile http://localhost:57879/getInfo.html) 07:03:33 INFO - PROCESS | 4963 | __metrics Screen width/height:1600/1200 07:03:33 INFO - PROCESS | 4963 | colorDepth:24 07:03:33 INFO - PROCESS | 4963 | Browser inner width/height: 1024/697 07:03:33 INFO - PROCESS | 4963 | __metrics 07:03:34 ERROR - PROCESS | 4963 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:03:35 INFO - TEST-INFO | 4963: exit 0 07:03:35 INFO - Browser initialized. 07:03:35 INFO - Running cycle 1/1 for dromaeo_css test... 07:03:35 INFO - TEST-INFO | started process 5045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFUI2v0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:03:47 INFO - PROCESS | 5045 | RSS: Main: 152780800 07:03:47 INFO - PROCESS | 5045 | 07:04:38 INFO - PROCESS | 5045 | 1464012278150 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:06:46 INFO - PROCESS | 5045 | Cycle 1(1): loaded http://localhost:57879/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57879/tests/dromaeo/cssquery-ext.html) 07:06:47 INFO - PROCESS | 5045 | RSS: Main: 267550720 07:06:47 INFO - PROCESS | 5045 | 07:09:49 INFO - PROCESS | 5045 | Cycle 1(1): loaded http://localhost:57879/tests/dromaeo/cssquery-ext.html (next: http://localhost:57879/tests/dromaeo/cssquery-jquery.html) 07:09:50 INFO - PROCESS | 5045 | RSS: Main: 236539904 07:09:50 INFO - PROCESS | 5045 | 07:12:52 INFO - PROCESS | 5045 | Cycle 1(1): loaded http://localhost:57879/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57879/tests/dromaeo/cssquery-mootools.html) 07:12:52 INFO - PROCESS | 5045 | RSS: Main: 250466304 07:12:52 INFO - PROCESS | 5045 | 07:15:54 INFO - PROCESS | 5045 | Cycle 1(1): loaded http://localhost:57879/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57879/tests/dromaeo/cssquery-prototype.html) 07:15:55 INFO - PROCESS | 5045 | RSS: Main: 239980544 07:15:55 INFO - PROCESS | 5045 | 07:18:57 INFO - PROCESS | 5045 | Cycle 1(1): loaded http://localhost:57879/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57879/tests/dromaeo/cssquery-yui.html) 07:18:58 INFO - PROCESS | 5045 | RSS: Main: 227753984 07:18:58 INFO - PROCESS | 5045 | 07:22:01 INFO - PROCESS | 5045 | Cycle 1(1): loaded http://localhost:57879/tests/dromaeo/cssquery-yui.html (next: http://localhost:57879/tests/dromaeo/cssquery-dojo.html) 07:22:01 INFO - PROCESS | 5045 | RSS: Main: 269856768 07:22:01 INFO - PROCESS | 5045 | 07:22:01 INFO - PROCESS | 5045 | __start_tp_report 07:22:01 INFO - PROCESS | 5045 | _x_x_mozilla_page_load 07:22:01 INFO - PROCESS | 5045 | _x_x_mozilla_page_load_details 07:22:01 INFO - PROCESS | 5045 | |i|pagename|runs| 07:22:01 INFO - PROCESS | 5045 | |0;dojo.html;3119.5476655884895;3122.687731226877;3143.2927591291955;3160.3679264147177;3183.029176101288;5271.630985830993;5332.733363331838;5361;5383.138697808351;5460.918086228699;5304.045271851065;5343.305370301855;5387.0303345397815;5416.4312747161575;5444.128939369702;4846.539578740032;4850.636202284834;4860.684055536397;4934.284528743348;4938.138203036366;4877.487863774306;4944.505549445063;4964.87587810304;4972.875678108058;5015.297858299841;4800.495947925488;4804;4895.926561101569;4931;4951.183054795973;4869.172240719086;4882.804687812483;4884.267359896008;4885.047415753929;4889.584385327252;4820.421549414058;4843.273508973647;4847.854564363075;4871.439784424766;4883.853484395474;5318.5213330800025;5366.570674346082;5371.033214021474;5373.75818088183;5378.139497680391;5570.554355651539;5710.229119068956;5757.596968212227;5765.962126817171;5765.971170144165;5644.85887852807;5684.2326285951285;5707.686077265748;5781.682007489587;5795.768169273224;5347.491988261109;5355.250264962909;5399.811006614749;5401.837944861661;5404.351477822647;5617.8033768817895;5758.424157584208;5955.225820643289;5968.253968253968;5968.552358573124;5560.082586373284;5575.4424557543925;5624.85937851557;5635.126555383922;5636.18275350072;5676.801311954062;5685.346185188673;5692.772289108472;5722.828315150552;5727.226824378656;5491.643043202179;5617.9719101404235;5660.660360378391;5705.429457054262;5718.313802343745;5744;5745.971270143623;5747.137929310553;5750.079987202028;5787.913181302284;4311.935320970188;4312.805923733439;4320.956790432118;4321.48142222929;4358.433403657505;3792.241551689673;3818.293615681108;3851.171998020439;3884.825182866721;3899.6100389960775;5419.295491586147;5423.918641220306;5434.538064264581;5435.320584926884;5438.755256013489;5756.251687280626;5758.309002919593;5759.280089988752;5803.88392232153;5817.360090390053;5360.6247562671015;5416.133418652997;5440.401555828856;5448.264484294648;5455;4933.72827095113;4938.160512712848;4962.925556116661;4976.62675299354;5025.120603894304;5720.342160651495;5993.31076926159;6009.038553831366;6013.819585412444;6015.30823955242;5662.631928924607;5714.114312281603;5729.28383952006;5758.078707406795;5781.624194427349;6006.549508786946;6007.729652165575;6008.609440386361;6013.699315034143;6014.849628759316;5521.917171242515;5605.831825045255;5637.802676906289;5643.463870932255;5647.1529270609735;5666.518345940642;5820.505257053029;5821.825345239649;5827.358990511125;5865.266841644794;5650.124230744241;5668.829935101953;5673.092305231144;5673.74468148926;5673.914891276551;5486.341639003345;5490.396056433709;5495.945040549544;5631.436856314336;5640;5427.972860135832;5429.402765695691;5433.212184233343;5439.374471935778;5476.972615136899;5534.889302214014;5592.608517403905;5625.043742563856;5625.746841392229;5644.322681278273;5406.0809662356705;5448.101063324666;5475.986942415666;5492.231087647652;5503.587230957774 07:22:01 INFO - PROCESS | 5045 | |1;ext.html;600.1597763131618;638.4573112854075;648.0926702616338;650.7234425369217;652.4617190817571;44107.55892441075;45489.31766023504;45542.77228613856;45613.087738245216;48999;46807.53192468074;47144;47152.52847471524;47300.76349618247;47418.762906185504;8750.562471876397;8961.103889611051;8982.550872456384;8985.640574377017;8996.820063598723;8842.867356989651;8915.777105572348;8929.598168082419;8931.95534022329;8932.776680582972;8997.640094396216;9017.2786177106;9022.819543609125;9024.639014439415;9055.501947392891;8940.329475289347;8976.102389761038;8984.371094023421;8988.23599993998;8993.190612844875;8866.290696744245;8945.329100317502;8963.10368963105;8966.641334346617;8969.058248883839;43447.34828977568;43818.56181438177;43878.561214387766;43942.34086488705;43972.3404148938;3298.2578919742864;3341.1814105544054;3360.7815491993188;3385.492176173569;3400.25194457219;33052.83473582641;33296.16759581005;33353.16617084568;33393;34978.65021349779;4213.831446742127;4215.484601854332;4219.662427005832;4243.193793179286;4246.766427846467;239216.99999999825;240571;240627;241595;241763;59460.70269648624;59500;59873.70063149656;59876.70061649751;60002;36170;36876.078098047765;36965.63034369622;38597.61402385996;63487;15089.320980555902;15241.3903443861;15246.542603721906;15253.16107614092;15257.771133433007;10914.945425272823;10971.615993440191;10988.560457581607;10995.285306455055;11007.944960275308;20202.595948080954;20382.490437738878;20403.795962040487;20508.282210122576;20541.178352865718;7116.679749411289;7386.834770272827;7497;7558.2441755823975;7607.4674772765375;929.7117893453051;1048.3500229857536;1121.2375584602548;1209.8366720492797;1225.712096942696;33406;33474;33575.66424335774;33666;34008;1075.8655168103987;1087.2986923434498;1100.7248187953012;1179.6991767099507;1185.727282724978;17055.232514536874;17358.392456264224;17549.29802807899;17573.912130439265;17605.7359139613;508277;508786;510684;511649;513009;59259;59741.103883441785;59766.70116649389;59786.10320845191;59826;1290.5805613175755;1359.8096266522696;1373.8969577281744;1377.1943413103247;1394.609509337367;32553;33483.4977475343;33789.66210337865;34207.10410012889;34451.13872153216;50521.74739126281;50589.74705126451;51003.74498127634;51147.48852511427;51157.48842511527;321581;321695;322487;323528;324003;25725.614115787903;28112.718872811827;28722;28757;28928.7107128926;48996.2650560249;49425.75287123541;49474;50242.24636630526;50355.748221260124;41633.58366416418;42360.78819605882;42367.36448953207;42958;43220;40283.3957490632;40861.182776344904;41126;41426.585734143475;41733.16533669249;37722.62277377301;37919.24161516699;38379.616203837606;38408;39792.801035994635;34095.31809363749;36987.63012369842;36989.815050924575;37514.437283440224;38077.61922380851;28653;28670.842727803934;28740.568891466228;29150.562741558468;29191.270218243862 07:22:01 INFO - PROCESS | 5045 | |2;jquery.html;387.89526827756487;390.8807813616847;401.63852532720546;411.4692047259036;422.6787641392541;17850.82149178508;18792.812071879278;19261.422157335266;19276.421707348785;19314;17966.64066718665;18191.54521136972;18580.442586722387;18667.81332186678;18692.906535467304;5634.774609015634;5767.480926716595;5825.155352473888;5828;5831.096180092092;5648.6893220872835;5652.9152062719095;5753.223314852504;5768.39431859655;5777.711114444282;5602.747876345574;5669.376368599451;5732.48407643312;5748;5757.65454072757;5686.4597863203135;5689.317281926154;5698.601097923147;5717.685527295997;5750.856228594298;4925.729084900329;5025.748712564357;5026.547610715017;5043.646944713835;5047.242913562958;22235;22447.21434749776;22458.43853903649;22559;22609;2141.336185782397;2694.730526947309;2879.2370021944203;2923.605313282701;2944.793864429491;9287.257019438497;9820.607175712963;9998.100170984646;10347.5343609537;10458.68623941283;1805.7562229099035;1930.5656227348875;1962.5093726568357;1968.9704654430195;2040.1635329514827;49888.75055624735;50399.496005039844;76475;76606.23393766047;77513.61243193805;9273.35086543949;9613.855792163124;9875.555599998017;9938.751531211778;10022.849657255147;13227.140235884637;13236.07347485686;13315.334233288297;13348.399322030531;13359.599212023655;7189.496735228484;7265.963670181615;7305.634718264066;7365.15300740411;7419.629018549051;7021.438284937193;7045;7123.964380178169;7144.285571442814;7148.106486689164;3958.841646334172;4012.8996775080273;4091.2226676931286;4111.60939710727;4191.769452680071;1861.2927087706585;1960.6862901935622;1976;2001.4295925661409;2015.8689685170416;455.46937817442307;460.41757177170905;465.76478878166307;998.3760149906309;1067.5676351077825;11110.944445277884;11347.489362978686;11673.182877198684;11692.123090768056;11722.70693232676;466.4612372709526;478.12264494652703;483.45369732202386;487.21071863581227;494.34746135101324;5893.823185304448;6279.937200627935;6309.179806625201;6328.145700330489;6387.840303992344;538465;539903;541649;552697;566402;92719.5364023189;94846.4776064518;94922;94958.5252073749;96708.51645741866;480.7139751847645;483.77746236731497;485.27936015017673;485.84210131708045;486.462458982826;10192.11445882514;10507.894921050998;10642.201834862572;10716.464176791285;10779.946100269448;37067.62932370642;40011;40435;40905.59094409018;41967.37048944207;56062.439375605725;56490.71754641201;57621.5259550342;58760;58821;8277.379196560161;8331.291840193651;8336.916630833613;8491.235788778793;8599.441036332619;9657.3239873211;11468.94265528667;12083.939580302042;12201.877981220074;12493;10792;10795.946020269848;10970.670879873616;11172.441377930909;11209;10876.836847447454;10915.617953371911;10949.069329107115;11002.724931876766;11069.225154239126;10753.677389678322;11053.613123540637;11129;11131.554737810397;11153.553857845594;8166.591670416574;8242.958785206036;8279.337652987868;8303.543305118277;8388.035375931846;10513.106385956973;10659.360438373722;10842.241043126905;10918.126549875831;11066.889331106908 07:22:01 INFO - PROCESS | 5045 | |3;mootools.html;1357.7759669654508;1492.4850926430377;1550.0699580251849;1658.3863970330979;1824.4617837737867;8823.867641985367;9151.13064258896;9201.539923003847;9371.953140234305;9384.343095983284;9082.182603565678;9249.583768730407;9274.48990305533;9294.395864268818;9302.302327325444;2095.6961240620103;2373.703287089114;2411.9517609647796;2444.535538247736;2445.963310550343;2475.665785119004;2480.851148931061;2483.453640199153;2486.29140694902;2492.67595212623;2359.1153317505937;2427.2232885476656;2429.842060266086;2434.7565243475688;2442.658027876099;2028.148177765342;2238.529908719171;2289.461976435536;2312.4681323295736;2320.385097949045;2357.846739961897;2371.1700904683394;2396.4727759892794;2398.4603464220586;2399.1363109280646;9334.579943902541;9447.338686291894;9470.95264523673;9473.952630236805;9481.09929556691;5422.783088676449;5489.533389661883;5547.944520554784;5549.500544950974;5552.555795536347;3441.63862794408;3455.8444869980913;3475.4960530722906;3566.821658917044;3575.6424357564297;1070.8019016481976;1085.5440714899762;1112.1769890281134;1116.8324751287291;1122.6519778868576;13423.932880335537;13450.192988420726;13468.32658367068;13477.123986940915;13498.797518037238;4811.422629284508;4852.636052296021;4862.343583616237;4895.04546613407;4988.700677959334;11013.944930275458;11022.50398732043;11025.117990560735;11041.723956901142;11044.392558409365;5572.498475137257;5583.413741557078;5585.553155747531;5588.832335029955;5591.30108736408;4414.404055452537;5029.949700502948;5163.819266325736;5168.9483105168465;5211.817586384458;4154.771487568152;4216;4230.280852255124;4268.125034367947;4293.484781826201;1306.73865226955;1324.086380397542;1335.2322414611638;1338.953136640213;1341.7316536692701;993.3841018568534;993.60752502761;1003.0821798054844;1004.7036124343336;1007;6095.969520152371;6289.622622642656;6319.715612797435;6341.397567231105;6451.064595633607;456.1378993701906;466.6803239780761;470.0387707138909;472.24676640757934;476.3402687278145;4222.282212023963;4232.217039847638;4281;4343.609075183185;4427.335899615084;11664.475098620582;11897.702557436134;12013.339266340436;12087.576934807415;12116.09129315305;11572.47923843429;11802.94098529519;11920.88079119215;11940;11941.283522988648;8571.142885711504;8746.912530874737;8787;8856.070112638208;8875.866861997076;6137.938620613737;6164.6745949621045;6236.75052997875;6266.248050234001;6332.430081292706;10696.304740191863;10721.571137154426;11007.394593297126;11098.5560577576;11109.111271098454;11052.171087168334;11111.11111111093;11320.09439244842;11343.659690209306;11410.258333208314;7431.925680743123;7912.169222231813;8138.552379619177;8330.666773329242;8433.746987590383;9154.908450915405;9156.496392698466;9222.354435189472;9250.658654495195;9255.537223138681;7589.58257295854;7866.7639970800965;7875.488093273919;7878.330341920771;7952.125266220595;7532.171461139161;7658.157602663591;7704.8459030820195;7705.267999540035;7828.569428681477;7405.8148546286775;7437.702491900263;7472.850542989001;7475.252474752481;7482.812929676802;5029.094762942559;5127.974360128175;5246.685198888079;5274.3670759509105;5347.786088556414;5313.149896016619;5318.149096144598;5362.276092727432;5401.1088170453;5550.666959982414 07:22:01 INFO - PROCESS | 5045 | |4;prototype.html;327.6059007947116;339.64676736194355;344.72594287541403;345.51110179096577;346.21236686538106;5008.373953255843;5166.1475856483685;5173.9482605173935;5227.111391063519;5238.947610523894;5217.373915130181;5262.079136151167;5272.551833094191;5277.815276465324;5289.735513224343;4106.28140075487;4133.710640255176;4149.896252593694;4159.584041595831;4172.603602657743;3901.6293452122004;3962.0491082140225;4082.8976176432493;4126.917461650765;4136.441580386654;4101.835926562934;4111.938320925188;4133.276676581601;4144.730592511492;4159.771212583307;4133.346661335475;4137.379393091045;4139.751614903085;4142.440770496005;4177.164567086565;3476.913077173091;3709.1654377765058;3719.2375563009787;3729.347364211252;3731.440283957401;5051.520105589963;5073.184382667618;5077.619178561623;5083.262926875619;5102.897942041139;4672.696274742131;4677.204875171229;4718.73500719653;4725.362076119714;4729.62163026957;5303.258194801294;5346.27825243591;5412.837614871521;5434.157705555645;5514.310711161105;3948.7630742155275;3952.565217826037;3960.2475529649564;3963.4847469829024;3976.880693579197;5688.658680479184;5711.7144142792695;5712.343080545749;5715.1713001614535;5745.9425405745405;4028.295048366524;4070.430139780433;4084.7549147051272;4097.713160078825;4101.507819061731;4001.2597669431248;4053.1488387438967;4063.8577649782114;4071.6131967463043;4085.8569950051606;4611;4625.306204069349;4647.302904564275;4659.301104834302;4665.2768820832825;5485.232067510552;5517.420670829585;5535.806246781343;5545.445455454423;5572.749226284827;1293.4567481657725;1329.528017553774;1397.9930100349434;1398.8531204223614;1402.4320150339129;889.2974550105473;899.2670973156856;913.5706218077493;914.7530166855045;929.2240978782792;4749.572538471485;4763.95236047642;4772.952270477251;4787.760611969387;4812.639052071108;4922.384701912261;4954;4980.601551875914;5003.674761140514;5006.4492905780335;4575.496695363508;4677.18149323867;4696.38946936896;4703.6942598730975;4798.66409351349;2655.9336016599354;2660.255128564005;2660.348214687414;2661.3612732944343;2670.5460071787843;5107.514786095315;5228.869278267997;5250.606204534675;5254.290670759398;5263.184206448007;4837.637177211724;4998.70007799526;5000.399952005782;5015.3730783652045;5082.848633847038;5156.845294641242;5183.170692689152;5209;5209.4009188943;5295.602829787781;4961.652684312064;4987.326710893983;5046.662634401813;5051.722155281494;5064.772085256099;4665.953340466687;4746.833860814855;4814.542618451242;4943.728094954812;5014.8465852853315;5116.539511443988;5184.585233181412;5213.76538055796;5239.29269548606;5258.763355649082;3683.7421380503106;3700.870469533661;3716.832742526539;3716.869909553153;3865.3622152345674;5401.297831281908;5629.324481062299;5651;5655.406182350794;5699;5418.593605479526;5431.696392865762;5442.23808666779;5477.72611369422;5515.255440515479;5246.819465620205;5487.807926722546;5495.835124946258;5503.862403439946;5516.531094856821;5381.569474441957;5394.703291319015;5395.379531353945;5403.8651883104985;5411.835265893674;5503.284573005483;5519.337679478488;5520.006398848246;5522.475364840334;5537.390887002507;5252.290940722954;5349.786008559614;5433.891322173456;5434.918476222781;5441.428649991693 07:22:01 INFO - PROCESS | 5045 | |5;yui.html;693.9132608423947;725.7097161135545;733.6845156582667;759.9050118735157;764.3541207679513;14172.50396236132;14213.857861421382;14272.072315299498;14278;14681.265936703163;13826.93086534566;14585.927070364633;14619;14619.830413566915;14631.122132672048;667.6895243711673;771.6874665760362;782.8903953446494;785.9410544209179;820.2658620534618;807.6527093349857;808.6805711743858;808.7573727881642;810.1372038778682;811.5820352518429;850.7575341027808;850.9404341696053;852.0669866496177;852.2415050604967;852.3479538153317;704.8167476456107;831.4055450352996;848.0798333807826;849.4605925237457;851.5614458553788;620;620.7548018532699;621.3506885304868;622.0203179991486;622.2688341199073;14468.493602723855;14502;14507.492237771627;14517.854821451756;14524.346404411826;13064.804027939588;13311.807659828184;13372.665683357896;13519.256440895746;13585.352622961458;11965.641030769091;11967.222130561486;11971.46128424223;12023.939880300542;12098;4352.448501849289;4367.3448982652535;4385.51759306476;4434.556544345572;4480.171168333869;55787.44212557863;56336.43663563353;56476.71761641165;57804.42195578032;59009.114863276656;10663.253572249869;10725.570977160982;10805.081568066802;10966.506507207196;11088.33469991803;20000.699989500168;20018.299359522345;20018.499537511678;20022.399328020183;20026.198952042047;7938.9206107939335;7997.680092796223;8044.954155959687;8069.6368663410285;8140.979630225502;4452.154090722753;4469.597736203757;4483.798229079699;4503.887402814956;4518.502964673883;3279.2293810954407;3373.207296285371;3374;3376.57792775903;3379.459286514146;614.5390956782413;629.6190804563265;630.2059405149545;635.6218050260088;641.172886975796;624.8406656302705;656.3370995294787;679.8028571714246;712.6757325416922;715.5492040014861;8370.623321950527;8429.157084291644;8457.957710211533;8477.788055298666;8693;676.4689718570899;703.357838267441;712.8924621523404;716.4662326566742;726.7093162734842;3668.3947148720695;3762.6237376262156;3789.962100379016;3937.125748502994;3950.1704642025497;63460;64956.67521662456;66989.33010669929;67099.66450167815;67131.32868671349;30966.22584435407;60178.69910650419;60181.39818601758;60473;61225;54726.179107314216;54831;54849.177262341094;55772.72113639406;55858.72070639702;8154.673813047411;8188.0993090758775;8196.918030819616;8315.792105197177;8404.915950840657;37354.252914941004;37640.62359376481;37669.62330376661;37765.05587360228;38229.61770382372;49532;49781;49969;50189;50580.49419505905;10815.56737730482;11147.498362573866;11238.943805280922;11296.526362868099;11582.305061696325;10698.518566664363;10792.676219713421;10838.67483975482;11011;11379.601713939972;10952.233343666185;11252.887471125185;11276.154288428237;11445.313281203154;12364.81452778227;10747.623833165802;10780.622678206226;10968.451577420938;11047.060999815105;11141.331520108819;10178.23663225276;10623.681289561326;11068.114550836075;11128.55485780592;11474.368909709712;9619.374740641835;9725.562349694139;9997.60009599637;10012.549435275285;10102.545385457524;9177.357584969255;9734;9859.556319965475;9879.802403952024;9887.093972555092 07:22:01 INFO - PROCESS | 5045 | __end_tp_report 07:22:01 INFO - PROCESS | 5045 | __start_cc_report 07:22:01 INFO - PROCESS | 5045 | _x_x_mozilla_cycle_collect,971 07:22:01 INFO - PROCESS | 5045 | __end_cc_report 07:22:01 INFO - PROCESS | 5045 | __startTimestamp1464013321456__endTimestamp 07:22:01 INFO - PROCESS | 5045 | 07:22:01 INFO - PROCESS | 5045 | ------- Summary: start ------- 07:22:01 INFO - PROCESS | 5045 | Number of tests: 6 07:22:01 INFO - PROCESS | 5045 | 07:22:01 INFO - PROCESS | 5045 | [#0] dojo.html Cycles:165 Average:5323.61 Median:5476.97 stddev:605.67 (11.1%) stddev-sans-first:582.33 07:22:01 INFO - PROCESS | 5045 | Values: 3119.5 3122.7 3143.3 3160.4 3183.0 5271.6 5332.7 5361.0 5383.1 5460.9 5304.0 5343.3 5387.0 5416.4 5444.1 4846.5 4850.6 4860.7 4934.3 4938.1 4877.5 4944.5 4964.9 4972.9 5015.3 4800.5 4804.0 4895.9 4931.0 4951.2 4869.2 4882.8 4884.3 4885.0 4889.6 4820.4 4843.3 4847.9 4871.4 4883.9 5318.5 5366.6 5371.0 5373.8 5378.1 5570.6 5710.2 5757.6 5766.0 5766.0 5644.9 5684.2 5707.7 5781.7 5795.8 5347.5 5355.3 5399.8 5401.8 5404.4 5617.8 5758.4 5955.2 5968.3 5968.6 5560.1 5575.4 5624.9 5635.1 5636.2 5676.8 5685.3 5692.8 5722.8 5727.2 5491.6 5618.0 5660.7 5705.4 5718.3 5744.0 5746.0 5747.1 5750.1 5787.9 4311.9 4312.8 4321.0 4321.5 4358.4 3792.2 3818.3 3851.2 3884.8 3899.6 5419.3 5423.9 5434.5 5435.3 5438.8 5756.3 5758.3 5759.3 5803.9 5817.4 5360.6 5416.1 5440.4 5448.3 5455.0 4933.7 4938.2 4962.9 4976.6 5025.1 5720.3 5993.3 6009.0 6013.8 6015.3 5662.6 5714.1 5729.3 5758.1 5781.6 6006.5 6007.7 6008.6 6013.7 6014.8 5521.9 5605.8 5637.8 5643.5 5647.2 5666.5 5820.5 5821.8 5827.4 5865.3 5650.1 5668.8 5673.1 5673.7 5673.9 5486.3 5490.4 5495.9 5631.4 5640.0 5428.0 5429.4 5433.2 5439.4 5477.0 5534.9 5592.6 5625.0 5625.7 5644.3 5406.1 5448.1 5476.0 5492.2 5503.6 07:22:01 INFO - PROCESS | 5045 | 07:22:01 INFO - PROCESS | 5045 | [#1] ext.html Cycles:180 Average:53276.31 Median:41276.29 stddev:99405.02 (240.8%) stddev-sans-first:99605.20 07:22:01 INFO - PROCESS | 5045 | Values: 600.2 638.5 648.1 650.7 652.5 44107.6 45489.3 45542.8 45613.1 48999.0 46807.5 47144.0 47152.5 47300.8 47418.8 8750.6 8961.1 8982.6 8985.6 8996.8 8842.9 8915.8 8929.6 8932.0 8932.8 8997.6 9017.3 9022.8 9024.6 9055.5 8940.3 8976.1 8984.4 8988.2 8993.2 8866.3 8945.3 8963.1 8966.6 8969.1 43447.3 43818.6 43878.6 43942.3 43972.3 3298.3 3341.2 3360.8 3385.5 3400.3 33052.8 33296.2 33353.2 33393.0 34978.7 4213.8 4215.5 4219.7 4243.2 4246.8 239217.0 240571.0 240627.0 241595.0 241763.0 59460.7 59500.0 59873.7 59876.7 60002.0 36170.0 36876.1 36965.6 38597.6 63487.0 15089.3 15241.4 15246.5 15253.2 15257.8 10914.9 10971.6 10988.6 10995.3 11007.9 20202.6 20382.5 20403.8 20508.3 20541.2 7116.7 7386.8 7497.0 7558.2 7607.5 929.7 1048.4 1121.2 1209.8 1225.7 33406.0 33474.0 33575.7 33666.0 34008.0 1075.9 1087.3 1100.7 1179.7 1185.7 17055.2 17358.4 17549.3 17573.9 17605.7 508277.0 508786.0 510684.0 511649.0 513009.0 59259.0 59741.1 59766.7 59786.1 59826.0 1290.6 1359.8 1373.9 1377.2 1394.6 32553.0 33483.5 33789.7 34207.1 34451.1 50521.7 50589.7 51003.7 51147.5 51157.5 321581.0 321695.0 322487.0 323528.0 324003.0 25725.6 28112.7 28722.0 28757.0 28928.7 48996.3 49425.8 49474.0 50242.2 50355.7 41633.6 42360.8 42367.4 42958.0 43220.0 40283.4 40861.2 41126.0 41426.6 41733.2 37722.6 37919.2 38379.6 38408.0 39792.8 34095.3 36987.6 36989.8 37514.4 38077.6 28653.0 28670.8 28740.6 29150.6 29191.3 07:22:01 INFO - PROCESS | 5045 | 07:22:01 INFO - PROCESS | 5045 | [#2] jquery.html Cycles:180 Average:29297.83 Median:466.11 stddev:90110.37 (19332.3%) stddev-sans-first:90337.01 07:22:01 INFO - PROCESS | 5045 | Values: 387.9 390.9 401.6 411.5 422.7 17850.8 18792.8 19261.4 19276.4 19314.0 17966.6 18191.5 18580.4 18667.8 18692.9 5634.8 5767.5 5825.2 5828.0 5831.1 5648.7 5652.9 5753.2 5768.4 5777.7 5602.7 5669.4 5732.5 5748.0 5757.7 5686.5 5689.3 5698.6 5717.7 5750.9 4925.7 5025.7 5026.5 5043.6 5047.2 22235.0 22447.2 22458.4 22559.0 22609.0 2141.3 2694.7 2879.2 2923.6 2944.8 9287.3 9820.6 9998.1 10347.5 10458.7 1805.8 1930.6 1962.5 1969.0 2040.2 49888.8 50399.5 76475.0 76606.2 77513.6 9273.4 9613.9 9875.6 9938.8 10022.8 13227.1 13236.1 13315.3 13348.4 13359.6 7189.5 7266.0 7305.6 7365.2 7419.6 7021.4 7045.0 7124.0 7144.3 7148.1 3958.8 4012.9 4091.2 4111.6 4191.8 1861.3 1960.7 1976.0 2001.4 2015.9 455.5 460.4 465.8 998.4 1067.6 11110.9 11347.5 11673.2 11692.1 11722.7 466.5 478.1 483.5 487.2 494.3 5893.8 6279.9 6309.2 6328.1 6387.8 538465.0 539903.0 541649.0 552697.0 566402.0 92719.5 94846.5 94922.0 94958.5 96708.5 480.7 483.8 485.3 485.8 486.5 10192.1 10507.9 10642.2 10716.5 10779.9 37067.6 40011.0 40435.0 40905.6 41967.4 56062.4 56490.7 57621.5 58760.0 58821.0 8277.4 8331.3 8336.9 8491.2 8599.4 9657.3 11468.9 12083.9 12201.9 12493.0 10792.0 10795.9 10970.7 11172.4 11209.0 10876.8 10915.6 10949.1 11002.7 11069.2 10753.7 11053.6 11129.0 11131.6 11153.6 8166.6 8243.0 8279.3 8303.5 8388.0 10513.1 10659.4 10842.2 10918.1 11066.9 07:22:01 INFO - PROCESS | 5045 | 07:22:01 INFO - PROCESS | 5045 | [#3] mootools.html Cycles:180 Average:6133.77 Median:468.36 stddev:3615.25 (771.9%) stddev-sans-first:3607.58 07:22:01 INFO - PROCESS | 5045 | Values: 1357.8 1492.5 1550.1 1658.4 1824.5 8823.9 9151.1 9201.5 9372.0 9384.3 9082.2 9249.6 9274.5 9294.4 9302.3 2095.7 2373.7 2412.0 2444.5 2446.0 2475.7 2480.9 2483.5 2486.3 2492.7 2359.1 2427.2 2429.8 2434.8 2442.7 2028.1 2238.5 2289.5 2312.5 2320.4 2357.8 2371.2 2396.5 2398.5 2399.1 9334.6 9447.3 9471.0 9474.0 9481.1 5422.8 5489.5 5547.9 5549.5 5552.6 3441.6 3455.8 3475.5 3566.8 3575.6 1070.8 1085.5 1112.2 1116.8 1122.7 13423.9 13450.2 13468.3 13477.1 13498.8 4811.4 4852.6 4862.3 4895.0 4988.7 11013.9 11022.5 11025.1 11041.7 11044.4 5572.5 5583.4 5585.6 5588.8 5591.3 4414.4 5029.9 5163.8 5168.9 5211.8 4154.8 4216.0 4230.3 4268.1 4293.5 1306.7 1324.1 1335.2 1339.0 1341.7 993.4 993.6 1003.1 1004.7 1007.0 6096.0 6289.6 6319.7 6341.4 6451.1 456.1 466.7 470.0 472.2 476.3 4222.3 4232.2 4281.0 4343.6 4427.3 11664.5 11897.7 12013.3 12087.6 12116.1 11572.5 11802.9 11920.9 11940.0 11941.3 8571.1 8746.9 8787.0 8856.1 8875.9 6137.9 6164.7 6236.8 6266.2 6332.4 10696.3 10721.6 11007.4 11098.6 11109.1 11052.2 11111.1 11320.1 11343.7 11410.3 7431.9 7912.2 8138.6 8330.7 8433.7 9154.9 9156.5 9222.4 9250.7 9255.5 7589.6 7866.8 7875.5 7878.3 7952.1 7532.2 7658.2 7704.8 7705.3 7828.6 7405.8 7437.7 7472.9 7475.3 7482.8 5029.1 5128.0 5246.7 5274.4 5347.8 5313.1 5318.1 5362.3 5401.1 5550.7 07:22:01 INFO - PROCESS | 5045 | 07:22:01 INFO - PROCESS | 5045 | [#4] prototype.html Cycles:180 Average:4457.69 Median:4999.55 stddev:1282.72 (25.7%) stddev-sans-first:1248.30 07:22:01 INFO - PROCESS | 5045 | Values: 327.6 339.6 344.7 345.5 346.2 5008.4 5166.1 5173.9 5227.1 5238.9 5217.4 5262.1 5272.6 5277.8 5289.7 4106.3 4133.7 4149.9 4159.6 4172.6 3901.6 3962.0 4082.9 4126.9 4136.4 4101.8 4111.9 4133.3 4144.7 4159.8 4133.3 4137.4 4139.8 4142.4 4177.2 3476.9 3709.2 3719.2 3729.3 3731.4 5051.5 5073.2 5077.6 5083.3 5102.9 4672.7 4677.2 4718.7 4725.4 4729.6 5303.3 5346.3 5412.8 5434.2 5514.3 3948.8 3952.6 3960.2 3963.5 3976.9 5688.7 5711.7 5712.3 5715.2 5745.9 4028.3 4070.4 4084.8 4097.7 4101.5 4001.3 4053.1 4063.9 4071.6 4085.9 4611.0 4625.3 4647.3 4659.3 4665.3 5485.2 5517.4 5535.8 5545.4 5572.7 1293.5 1329.5 1398.0 1398.9 1402.4 889.3 899.3 913.6 914.8 929.2 4749.6 4764.0 4773.0 4787.8 4812.6 4922.4 4954.0 4980.6 5003.7 5006.4 4575.5 4677.2 4696.4 4703.7 4798.7 2655.9 2660.3 2660.3 2661.4 2670.5 5107.5 5228.9 5250.6 5254.3 5263.2 4837.6 4998.7 5000.4 5015.4 5082.8 5156.8 5183.2 5209.0 5209.4 5295.6 4961.7 4987.3 5046.7 5051.7 5064.8 4666.0 4746.8 4814.5 4943.7 5014.8 5116.5 5184.6 5213.8 5239.3 5258.8 3683.7 3700.9 3716.8 3716.9 3865.4 5401.3 5629.3 5651.0 5655.4 5699.0 5418.6 5431.7 5442.2 5477.7 5515.3 5246.8 5487.8 5495.8 5503.9 5516.5 5381.6 5394.7 5395.4 5403.9 5411.8 5503.3 5519.3 5520.0 5522.5 5537.4 5252.3 5349.8 5433.9 5434.9 5441.4 07:22:01 INFO - PROCESS | 5045 | 07:22:01 INFO - PROCESS | 5045 | [#5] yui.html Cycles:180 Average:15072.25 Median:50079.00 stddev:18364.59 (36.7%) stddev-sans-first:18384.37 07:22:01 INFO - PROCESS | 5045 | Values: 693.9 725.7 733.7 759.9 764.4 14172.5 14213.9 14272.1 14278.0 14681.3 13826.9 14585.9 14619.0 14619.8 14631.1 667.7 771.7 782.9 785.9 820.3 807.7 808.7 808.8 810.1 811.6 850.8 850.9 852.1 852.2 852.3 704.8 831.4 848.1 849.5 851.6 620.0 620.8 621.4 622.0 622.3 14468.5 14502.0 14507.5 14517.9 14524.3 13064.8 13311.8 13372.7 13519.3 13585.4 11965.6 11967.2 11971.5 12023.9 12098.0 4352.4 4367.3 4385.5 4434.6 4480.2 55787.4 56336.4 56476.7 57804.4 59009.1 10663.3 10725.6 10805.1 10966.5 11088.3 20000.7 20018.3 20018.5 20022.4 20026.2 7938.9 7997.7 8045.0 8069.6 8141.0 4452.2 4469.6 4483.8 4503.9 4518.5 3279.2 3373.2 3374.0 3376.6 3379.5 614.5 629.6 630.2 635.6 641.2 624.8 656.3 679.8 712.7 715.5 8370.6 8429.2 8458.0 8477.8 8693.0 676.5 703.4 712.9 716.5 726.7 3668.4 3762.6 3790.0 3937.1 3950.2 63460.0 64956.7 66989.3 67099.7 67131.3 30966.2 60178.7 60181.4 60473.0 61225.0 54726.2 54831.0 54849.2 55772.7 55858.7 8154.7 8188.1 8196.9 8315.8 8404.9 37354.3 37640.6 37669.6 37765.1 38229.6 49532.0 49781.0 49969.0 50189.0 50580.5 10815.6 11147.5 11238.9 11296.5 11582.3 10698.5 10792.7 10838.7 11011.0 11379.6 10952.2 11252.9 11276.2 11445.3 12364.8 10747.6 10780.6 10968.5 11047.1 11141.3 10178.2 10623.7 11068.1 11128.6 11474.4 9619.4 9725.6 9997.6 10012.5 10102.5 9177.4 9734.0 9859.6 9879.8 9887.1 07:22:01 INFO - PROCESS | 5045 | -------- Summary: end -------- 07:22:01 INFO - PROCESS | 5045 | 07:22:02 INFO - TEST-INFO | 5045: exit 0 07:22:02 INFO - TEST-OK | dromaeo_css | took 1112518ms 07:22:02 INFO - TEST-START | kraken 07:22:02 INFO - operating with platform_type : linux_ 07:22:02 INFO - Initialising browser for kraken test... 07:22:02 INFO - TEST-INFO | started process 5226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcS1LiI/profile http://localhost:57879/getInfo.html) 07:22:06 INFO - PROCESS | 5226 | __metrics Screen width/height:1600/1200 07:22:06 INFO - PROCESS | 5226 | colorDepth:24 07:22:06 INFO - PROCESS | 5226 | Browser inner width/height: 1024/697 07:22:06 INFO - PROCESS | 5226 | __metrics 07:22:07 ERROR - PROCESS | 5226 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:22:07 INFO - TEST-INFO | 5226: exit 0 07:22:07 INFO - Browser initialized. 07:22:07 INFO - Running cycle 1/1 for kraken test... 07:22:07 INFO - TEST-INFO | started process 5307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcS1LiI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:22:19 INFO - PROCESS | 5307 | RSS: Main: 153690112 07:22:19 INFO - PROCESS | 5307 | 07:22:22 INFO - PROCESS | 5307 | Cycle 1(1): loaded http://localhost:57879/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57879/tests/kraken/driver.html?testName=audio-beat-detection) 07:22:23 INFO - PROCESS | 5307 | RSS: Main: 209682432 07:22:23 INFO - PROCESS | 5307 | 07:22:25 INFO - PROCESS | 5307 | Cycle 1(1): loaded http://localhost:57879/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57879/tests/kraken/driver.html?testName=audio-dft) 07:22:26 INFO - PROCESS | 5307 | RSS: Main: 198176768 07:22:26 INFO - PROCESS | 5307 | 07:22:29 INFO - PROCESS | 5307 | Cycle 1(1): loaded http://localhost:57879/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57879/tests/kraken/driver.html?testName=audio-fft) 07:22:30 INFO - PROCESS | 5307 | RSS: Main: 266059776 07:22:30 INFO - PROCESS | 5307 | 07:22:32 INFO - PROCESS | 5307 | Cycle 1(1): loaded http://localhost:57879/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57879/tests/kraken/driver.html?testName=audio-oscillator) 07:22:32 INFO - PROCESS | 5307 | RSS: Main: 175001600 07:22:32 INFO - PROCESS | 5307 | 07:22:35 INFO - PROCESS | 5307 | Cycle 1(1): loaded http://localhost:57879/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57879/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:22:35 INFO - PROCESS | 5307 | RSS: Main: 179326976 07:22:35 INFO - PROCESS | 5307 | 07:22:38 INFO - PROCESS | 5307 | Cycle 1(1): loaded http://localhost:57879/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57879/tests/kraken/driver.html?testName=imaging-darkroom) 07:22:39 INFO - PROCESS | 5307 | RSS: Main: 215257088 07:22:39 INFO - PROCESS | 5307 | 07:22:43 INFO - PROCESS | 5307 | Cycle 1(1): loaded http://localhost:57879/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57879/tests/kraken/driver.html?testName=imaging-desaturate) 07:22:43 INFO - PROCESS | 5307 | RSS: Main: 215986176 07:22:43 INFO - PROCESS | 5307 | 07:22:46 INFO - PROCESS | 5307 | Cycle 1(1): loaded http://localhost:57879/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57879/tests/kraken/driver.html?testName=json-parse-financial) 07:22:47 INFO - PROCESS | 5307 | RSS: Main: 216027136 07:22:47 INFO - PROCESS | 5307 | 07:22:48 INFO - PROCESS | 5307 | Cycle 1(1): loaded http://localhost:57879/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57879/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:22:49 INFO - PROCESS | 5307 | RSS: Main: 204283904 07:22:49 INFO - PROCESS | 5307 | 07:22:51 INFO - PROCESS | 5307 | Cycle 1(1): loaded http://localhost:57879/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57879/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:22:51 INFO - PROCESS | 5307 | RSS: Main: 204091392 07:22:51 INFO - PROCESS | 5307 | 07:22:53 INFO - PROCESS | 5307 | Cycle 1(1): loaded http://localhost:57879/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57879/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:22:54 INFO - PROCESS | 5307 | RSS: Main: 214646784 07:22:54 INFO - PROCESS | 5307 | 07:22:57 INFO - PROCESS | 5307 | Cycle 1(1): loaded http://localhost:57879/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57879/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:22:57 INFO - PROCESS | 5307 | RSS: Main: 223211520 07:22:57 INFO - PROCESS | 5307 | 07:23:00 INFO - PROCESS | 5307 | Cycle 1(1): loaded http://localhost:57879/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57879/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:23:01 INFO - PROCESS | 5307 | RSS: Main: 219598848 07:23:01 INFO - PROCESS | 5307 | 07:23:02 INFO - PROCESS | 5307 | Cycle 1(1): loaded http://localhost:57879/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57879/tests/kraken/driver.html?testName=ai-astar) 07:23:03 INFO - PROCESS | 5307 | RSS: Main: 265523200 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - PROCESS | 5307 | __start_tp_report 07:23:03 INFO - PROCESS | 5307 | _x_x_mozilla_page_load 07:23:03 INFO - PROCESS | 5307 | _x_x_mozilla_page_load_details 07:23:03 INFO - PROCESS | 5307 | |i|pagename|runs| 07:23:03 INFO - PROCESS | 5307 | |0;ai-astar;111;105;111;110;111;109;109;108;109;109 07:23:03 INFO - PROCESS | 5307 | |1;audio-beat-detection;167;130;126;183;124;129;150;129;167;126 07:23:03 INFO - PROCESS | 5307 | |2;audio-dft;160;160;161;160;161;161;162;160;161;160 07:23:03 INFO - PROCESS | 5307 | |3;audio-fft;73;74;74;112;74;75;74;74;96;75 07:23:03 INFO - PROCESS | 5307 | |4;audio-oscillator;92;91;122;91;94;92;139;92;92;144 07:23:03 INFO - PROCESS | 5307 | |5;imaging-gaussian-blur;116;117;116;116;116;117;117;116;117;117 07:23:03 INFO - PROCESS | 5307 | |6;imaging-darkroom;145;145;145;145;145;145;144;145;145;145 07:23:03 INFO - PROCESS | 5307 | |7;imaging-desaturate;94;95;95;95;95;95;94;96;95;95 07:23:03 INFO - PROCESS | 5307 | |8;json-parse-financial;55;54;53;53;55;54;54;70;52;51 07:23:03 INFO - PROCESS | 5307 | |9;json-stringify-tinderbox;62;62;62;63;63;63;63;62;63;63 07:23:03 INFO - PROCESS | 5307 | |10;stanford-crypto-aes;80;84;78;79;80;77;80;83;86;79 07:23:03 INFO - PROCESS | 5307 | |11;stanford-crypto-ccm;122;132;119;119;119;117;123;122;158;129 07:23:03 INFO - PROCESS | 5307 | |12;stanford-crypto-pbkdf2;161;160;166;162;160;163;158;158;160;158 07:23:03 INFO - PROCESS | 5307 | |13;stanford-crypto-sha256-iterative;64;62;63;62;61;62;63;62;62;60 07:23:03 INFO - PROCESS | 5307 | __end_tp_report 07:23:03 INFO - PROCESS | 5307 | __start_cc_report 07:23:03 INFO - PROCESS | 5307 | _x_x_mozilla_cycle_collect,1707 07:23:03 INFO - PROCESS | 5307 | __end_cc_report 07:23:03 INFO - PROCESS | 5307 | __startTimestamp1464013383045__endTimestamp 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - PROCESS | 5307 | ------- Summary: start ------- 07:23:03 INFO - PROCESS | 5307 | Number of tests: 14 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - PROCESS | 5307 | [#0] ai-astar Cycles:10 Average:109.20 Median:109.50 stddev:1.81 (1.7%) stddev-sans-first:1.80 07:23:03 INFO - PROCESS | 5307 | Values: 111.0 105.0 111.0 110.0 111.0 109.0 109.0 108.0 109.0 109.0 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - PROCESS | 5307 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:140.00 stddev:21.86 (15.6%) stddev-sans-first:21.41 07:23:03 INFO - PROCESS | 5307 | Values: 167.0 130.0 126.0 183.0 124.0 129.0 150.0 129.0 167.0 126.0 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - PROCESS | 5307 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 07:23:03 INFO - PROCESS | 5307 | Values: 160.0 160.0 161.0 160.0 161.0 161.0 162.0 160.0 161.0 160.0 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - PROCESS | 5307 | [#3] audio-fft Cycles:10 Average:80.10 Median:74.00 stddev:13.16 (17.8%) stddev-sans-first:13.71 07:23:03 INFO - PROCESS | 5307 | Values: 73.0 74.0 74.0 112.0 74.0 75.0 74.0 74.0 96.0 75.0 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - PROCESS | 5307 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:92.00 stddev:21.49 (23.4%) stddev-sans-first:22.28 07:23:03 INFO - PROCESS | 5307 | Values: 92.0 91.0 122.0 91.0 94.0 92.0 139.0 92.0 92.0 144.0 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - PROCESS | 5307 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:23:03 INFO - PROCESS | 5307 | Values: 116.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - PROCESS | 5307 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 07:23:03 INFO - PROCESS | 5307 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 144.0 145.0 145.0 145.0 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - PROCESS | 5307 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 07:23:03 INFO - PROCESS | 5307 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 95.0 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - PROCESS | 5307 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.00 stddev:5.38 (10.0%) stddev-sans-first:5.71 07:23:03 INFO - PROCESS | 5307 | Values: 55.0 54.0 53.0 53.0 55.0 54.0 54.0 70.0 52.0 51.0 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - PROCESS | 5307 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 07:23:03 INFO - PROCESS | 5307 | Values: 62.0 62.0 62.0 63.0 63.0 63.0 63.0 62.0 63.0 63.0 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - PROCESS | 5307 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:2.84 (3.5%) stddev-sans-first:3.00 07:23:03 INFO - PROCESS | 5307 | Values: 80.0 84.0 78.0 79.0 80.0 77.0 80.0 83.0 86.0 79.0 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - PROCESS | 5307 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:122.50 stddev:12.19 (10.0%) stddev-sans-first:12.85 07:23:03 INFO - PROCESS | 5307 | Values: 122.0 132.0 119.0 119.0 119.0 117.0 123.0 122.0 158.0 129.0 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - PROCESS | 5307 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:160.50 stddev:2.55 (1.6%) stddev-sans-first:2.70 07:23:03 INFO - PROCESS | 5307 | Values: 161.0 160.0 166.0 162.0 160.0 163.0 158.0 158.0 160.0 158.0 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - PROCESS | 5307 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.10 (1.8%) stddev-sans-first:0.93 07:23:03 INFO - PROCESS | 5307 | Values: 64.0 62.0 63.0 62.0 61.0 62.0 63.0 62.0 62.0 60.0 07:23:03 INFO - PROCESS | 5307 | -------- Summary: end -------- 07:23:03 INFO - PROCESS | 5307 | 07:23:03 INFO - TEST-INFO | 5307: exit 0 07:23:04 INFO - TEST-OK | kraken | took 61831ms 07:23:04 INFO - SUITE-END | took 1174s 07:23:04 INFO - Completed test suite (00:19:34) 07:23:04 INFO - javascript benchmark 07:23:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.5476655884895, 3122.687731226877, 3143.2927591291955, 3160.3679264147177, 3183.029176101288, 5271.630985830993, 5332.733363331838, 5361.0, 5383.138697808351, 5460.918086228699, 5304.045271851065, 5343.305370301855, 5387.0303345397815, 5416.4312747161575, 5444.128939369702, 4846.539578740032, 4850.636202284834, 4860.684055536397, 4934.284528743348, 4938.138203036366, 4877.487863774306, 4944.505549445063, 4964.87587810304, 4972.875678108058, 5015.297858299841, 4800.495947925488, 4804.0, 4895.926561101569, 4931.0, 4951.183054795973, 4869.172240719086, 4882.804687812483, 4884.267359896008, 4885.047415753929, 4889.584385327252, 4820.421549414058, 4843.273508973647, 4847.854564363075, 4871.439784424766, 4883.853484395474, 5318.5213330800025, 5366.570674346082, 5371.033214021474, 5373.75818088183, 5378.139497680391, 5570.554355651539, 5710.229119068956, 5757.596968212227, 5765.962126817171, 5765.971170144165, 5644.85887852807, 5684.2326285951285, 5707.686077265748, 5781.682007489587, 5795.768169273224, 5347.491988261109, 5355.250264962909, 5399.811006614749, 5401.837944861661, 5404.351477822647, 5617.8033768817895, 5758.424157584208, 5955.225820643289, 5968.253968253968, 5968.552358573124, 5560.082586373284, 5575.4424557543925, 5624.85937851557, 5635.126555383922, 5636.18275350072, 5676.801311954062, 5685.346185188673, 5692.772289108472, 5722.828315150552, 5727.226824378656, 5491.643043202179, 5617.9719101404235, 5660.660360378391, 5705.429457054262, 5718.313802343745, 5744.0, 5745.971270143623, 5747.137929310553, 5750.079987202028, 5787.913181302284, 4311.935320970188, 4312.805923733439, 4320.956790432118, 4321.48142222929, 4358.433403657505, 3792.241551689673, 3818.293615681108, 3851.171998020439, 3884.825182866721, 3899.6100389960775, 5419.295491586147, 5423.918641220306, 5434.538064264581, 5435.320584926884, 5438.755256013489, 5756.251687280626, 5758.309002919593, 5759.280089988752, 5803.88392232153, 5817.360090390053, 5360.6247562671015, 5416.133418652997, 5440.401555828856, 5448.264484294648, 5455.0, 4933.72827095113, 4938.160512712848, 4962.925556116661, 4976.62675299354, 5025.120603894304, 5720.342160651495, 5993.31076926159, 6009.038553831366, 6013.819585412444, 6015.30823955242, 5662.631928924607, 5714.114312281603, 5729.28383952006, 5758.078707406795, 5781.624194427349, 6006.549508786946, 6007.729652165575, 6008.609440386361, 6013.699315034143, 6014.849628759316, 5521.917171242515, 5605.831825045255, 5637.802676906289, 5643.463870932255, 5647.1529270609735, 5666.518345940642, 5820.505257053029, 5821.825345239649, 5827.358990511125, 5865.266841644794, 5650.124230744241, 5668.829935101953, 5673.092305231144, 5673.74468148926, 5673.914891276551, 5486.341639003345, 5490.396056433709, 5495.945040549544, 5631.436856314336, 5640.0, 5427.972860135832, 5429.402765695691, 5433.212184233343, 5439.374471935778, 5476.972615136899, 5534.889302214014, 5592.608517403905, 5625.043742563856, 5625.746841392229, 5644.322681278273, 5406.0809662356705, 5448.101063324666, 5475.986942415666, 5492.231087647652, 5503.587230957774], "value": 5282.841041585418, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.1597763131618, 638.4573112854075, 648.0926702616338, 650.7234425369217, 652.4617190817571, 44107.55892441075, 45489.31766023504, 45542.77228613856, 45613.087738245216, 48999.0, 46807.53192468074, 47144.0, 47152.52847471524, 47300.76349618247, 47418.762906185504, 8750.562471876397, 8961.103889611051, 8982.550872456384, 8985.640574377017, 8996.820063598723, 8842.867356989651, 8915.777105572348, 8929.598168082419, 8931.95534022329, 8932.776680582972, 8997.640094396216, 9017.2786177106, 9022.819543609125, 9024.639014439415, 9055.501947392891, 8940.329475289347, 8976.102389761038, 8984.371094023421, 8988.23599993998, 8993.190612844875, 8866.290696744245, 8945.329100317502, 8963.10368963105, 8966.641334346617, 8969.058248883839, 43447.34828977568, 43818.56181438177, 43878.561214387766, 43942.34086488705, 43972.3404148938, 3298.2578919742864, 3341.1814105544054, 3360.7815491993188, 3385.492176173569, 3400.25194457219, 33052.83473582641, 33296.16759581005, 33353.16617084568, 33393.0, 34978.65021349779, 4213.831446742127, 4215.484601854332, 4219.662427005832, 4243.193793179286, 4246.766427846467, 239216.99999999825, 240571.0, 240627.0, 241595.0, 241763.0, 59460.70269648624, 59500.0, 59873.70063149656, 59876.70061649751, 60002.0, 36170.0, 36876.078098047765, 36965.63034369622, 38597.61402385996, 63487.0, 15089.320980555902, 15241.3903443861, 15246.542603721906, 15253.16107614092, 15257.771133433007, 10914.945425272823, 10971.615993440191, 10988.560457581607, 10995.285306455055, 11007.944960275308, 20202.595948080954, 20382.490437738878, 20403.795962040487, 20508.282210122576, 20541.178352865718, 7116.679749411289, 7386.834770272827, 7497.0, 7558.2441755823975, 7607.4674772765375, 929.7117893453051, 1048.3500229857536, 1121.2375584602548, 1209.8366720492797, 1225.712096942696, 33406.0, 33474.0, 33575.66424335774, 33666.0, 34008.0, 1075.8655168103987, 1087.2986923434498, 1100.7248187953012, 1179.6991767099507, 1185.727282724978, 17055.232514536874, 17358.392456264224, 17549.29802807899, 17573.912130439265, 17605.7359139613, 508277.0, 508786.0, 510684.0, 511649.0, 513009.0, 59259.0, 59741.103883441785, 59766.70116649389, 59786.10320845191, 59826.0, 1290.5805613175755, 1359.8096266522696, 1373.8969577281744, 1377.1943413103247, 1394.609509337367, 32553.0, 33483.4977475343, 33789.66210337865, 34207.10410012889, 34451.13872153216, 50521.74739126281, 50589.74705126451, 51003.74498127634, 51147.48852511427, 51157.48842511527, 321581.0, 321695.0, 322487.0, 323528.0, 324003.0, 25725.614115787903, 28112.718872811827, 28722.0, 28757.0, 28928.7107128926, 48996.2650560249, 49425.75287123541, 49474.0, 50242.24636630526, 50355.748221260124, 41633.58366416418, 42360.78819605882, 42367.36448953207, 42958.0, 43220.0, 40283.3957490632, 40861.182776344904, 41126.0, 41426.585734143475, 41733.16533669249, 37722.62277377301, 37919.24161516699, 38379.616203837606, 38408.0, 39792.801035994635, 34095.31809363749, 36987.63012369842, 36989.815050924575, 37514.437283440224, 38077.61922380851, 28653.0, 28670.842727803934, 28740.568891466228, 29150.562741558468, 29191.270218243862], "value": 19741.05114248353, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.89526827756487, 390.8807813616847, 401.63852532720546, 411.4692047259036, 422.6787641392541, 17850.82149178508, 18792.812071879278, 19261.422157335266, 19276.421707348785, 19314.0, 17966.64066718665, 18191.54521136972, 18580.442586722387, 18667.81332186678, 18692.906535467304, 5634.774609015634, 5767.480926716595, 5825.155352473888, 5828.0, 5831.096180092092, 5648.6893220872835, 5652.9152062719095, 5753.223314852504, 5768.39431859655, 5777.711114444282, 5602.747876345574, 5669.376368599451, 5732.48407643312, 5748.0, 5757.65454072757, 5686.4597863203135, 5689.317281926154, 5698.601097923147, 5717.685527295997, 5750.856228594298, 4925.729084900329, 5025.748712564357, 5026.547610715017, 5043.646944713835, 5047.242913562958, 22235.0, 22447.21434749776, 22458.43853903649, 22559.0, 22609.0, 2141.336185782397, 2694.730526947309, 2879.2370021944203, 2923.605313282701, 2944.793864429491, 9287.257019438497, 9820.607175712963, 9998.100170984646, 10347.5343609537, 10458.68623941283, 1805.7562229099035, 1930.5656227348875, 1962.5093726568357, 1968.9704654430195, 2040.1635329514827, 49888.75055624735, 50399.496005039844, 76475.0, 76606.23393766047, 77513.61243193805, 9273.35086543949, 9613.855792163124, 9875.555599998017, 9938.751531211778, 10022.849657255147, 13227.140235884637, 13236.07347485686, 13315.334233288297, 13348.399322030531, 13359.599212023655, 7189.496735228484, 7265.963670181615, 7305.634718264066, 7365.15300740411, 7419.629018549051, 7021.438284937193, 7045.0, 7123.964380178169, 7144.285571442814, 7148.106486689164, 3958.841646334172, 4012.8996775080273, 4091.2226676931286, 4111.60939710727, 4191.769452680071, 1861.2927087706585, 1960.6862901935622, 1976.0, 2001.4295925661409, 2015.8689685170416, 455.46937817442307, 460.41757177170905, 465.76478878166307, 998.3760149906309, 1067.5676351077825, 11110.944445277884, 11347.489362978686, 11673.182877198684, 11692.123090768056, 11722.70693232676, 466.4612372709526, 478.12264494652703, 483.45369732202386, 487.21071863581227, 494.34746135101324, 5893.823185304448, 6279.937200627935, 6309.179806625201, 6328.145700330489, 6387.840303992344, 538465.0, 539903.0, 541649.0, 552697.0, 566402.0, 92719.5364023189, 94846.4776064518, 94922.0, 94958.5252073749, 96708.51645741866, 480.7139751847645, 483.77746236731497, 485.27936015017673, 485.84210131708045, 486.462458982826, 10192.11445882514, 10507.894921050998, 10642.201834862572, 10716.464176791285, 10779.946100269448, 37067.62932370642, 40011.0, 40435.0, 40905.59094409018, 41967.37048944207, 56062.439375605725, 56490.71754641201, 57621.5259550342, 58760.0, 58821.0, 8277.379196560161, 8331.291840193651, 8336.916630833613, 8491.235788778793, 8599.441036332619, 9657.3239873211, 11468.94265528667, 12083.939580302042, 12201.877981220074, 12493.0, 10792.0, 10795.946020269848, 10970.670879873616, 11172.441377930909, 11209.0, 10876.836847447454, 10915.617953371911, 10949.069329107115, 11002.724931876766, 11069.225154239126, 10753.677389678322, 11053.613123540637, 11129.0, 11131.554737810397, 11153.553857845594, 8166.591670416574, 8242.958785206036, 8279.337652987868, 8303.543305118277, 8388.035375931846, 10513.106385956973, 10659.360438373722, 10842.241043126905, 10918.126549875831, 11066.889331106908], "value": 8115.467055010565, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.7759669654508, 1492.4850926430377, 1550.0699580251849, 1658.3863970330979, 1824.4617837737867, 8823.867641985367, 9151.13064258896, 9201.539923003847, 9371.953140234305, 9384.343095983284, 9082.182603565678, 9249.583768730407, 9274.48990305533, 9294.395864268818, 9302.302327325444, 2095.6961240620103, 2373.703287089114, 2411.9517609647796, 2444.535538247736, 2445.963310550343, 2475.665785119004, 2480.851148931061, 2483.453640199153, 2486.29140694902, 2492.67595212623, 2359.1153317505937, 2427.2232885476656, 2429.842060266086, 2434.7565243475688, 2442.658027876099, 2028.148177765342, 2238.529908719171, 2289.461976435536, 2312.4681323295736, 2320.385097949045, 2357.846739961897, 2371.1700904683394, 2396.4727759892794, 2398.4603464220586, 2399.1363109280646, 9334.579943902541, 9447.338686291894, 9470.95264523673, 9473.952630236805, 9481.09929556691, 5422.783088676449, 5489.533389661883, 5547.944520554784, 5549.500544950974, 5552.555795536347, 3441.63862794408, 3455.8444869980913, 3475.4960530722906, 3566.821658917044, 3575.6424357564297, 1070.8019016481976, 1085.5440714899762, 1112.1769890281134, 1116.8324751287291, 1122.6519778868576, 13423.932880335537, 13450.192988420726, 13468.32658367068, 13477.123986940915, 13498.797518037238, 4811.422629284508, 4852.636052296021, 4862.343583616237, 4895.04546613407, 4988.700677959334, 11013.944930275458, 11022.50398732043, 11025.117990560735, 11041.723956901142, 11044.392558409365, 5572.498475137257, 5583.413741557078, 5585.553155747531, 5588.832335029955, 5591.30108736408, 4414.404055452537, 5029.949700502948, 5163.819266325736, 5168.9483105168465, 5211.817586384458, 4154.771487568152, 4216.0, 4230.280852255124, 4268.125034367947, 4293.484781826201, 1306.73865226955, 1324.086380397542, 1335.2322414611638, 1338.953136640213, 1341.7316536692701, 993.3841018568534, 993.60752502761, 1003.0821798054844, 1004.7036124343336, 1007.0, 6095.969520152371, 6289.622622642656, 6319.715612797435, 6341.397567231105, 6451.064595633607, 456.1378993701906, 466.6803239780761, 470.0387707138909, 472.24676640757934, 476.3402687278145, 4222.282212023963, 4232.217039847638, 4281.0, 4343.609075183185, 4427.335899615084, 11664.475098620582, 11897.702557436134, 12013.339266340436, 12087.576934807415, 12116.09129315305, 11572.47923843429, 11802.94098529519, 11920.88079119215, 11940.0, 11941.283522988648, 8571.142885711504, 8746.912530874737, 8787.0, 8856.070112638208, 8875.866861997076, 6137.938620613737, 6164.6745949621045, 6236.75052997875, 6266.248050234001, 6332.430081292706, 10696.304740191863, 10721.571137154426, 11007.394593297126, 11098.5560577576, 11109.111271098454, 11052.171087168334, 11111.11111111093, 11320.09439244842, 11343.659690209306, 11410.258333208314, 7431.925680743123, 7912.169222231813, 8138.552379619177, 8330.666773329242, 8433.746987590383, 9154.908450915405, 9156.496392698466, 9222.354435189472, 9250.658654495195, 9255.537223138681, 7589.58257295854, 7866.7639970800965, 7875.488093273919, 7878.330341920771, 7952.125266220595, 7532.171461139161, 7658.157602663591, 7704.8459030820195, 7705.267999540035, 7828.569428681477, 7405.8148546286775, 7437.702491900263, 7472.850542989001, 7475.252474752481, 7482.812929676802, 5029.094762942559, 5127.974360128175, 5246.685198888079, 5274.3670759509105, 5347.786088556414, 5313.149896016619, 5318.149096144598, 5362.276092727432, 5401.1088170453, 5550.666959982414], "value": 4766.807360359139, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.6059007947116, 339.64676736194355, 344.72594287541403, 345.51110179096577, 346.21236686538106, 5008.373953255843, 5166.1475856483685, 5173.9482605173935, 5227.111391063519, 5238.947610523894, 5217.373915130181, 5262.079136151167, 5272.551833094191, 5277.815276465324, 5289.735513224343, 4106.28140075487, 4133.710640255176, 4149.896252593694, 4159.584041595831, 4172.603602657743, 3901.6293452122004, 3962.0491082140225, 4082.8976176432493, 4126.917461650765, 4136.441580386654, 4101.835926562934, 4111.938320925188, 4133.276676581601, 4144.730592511492, 4159.771212583307, 4133.346661335475, 4137.379393091045, 4139.751614903085, 4142.440770496005, 4177.164567086565, 3476.913077173091, 3709.1654377765058, 3719.2375563009787, 3729.347364211252, 3731.440283957401, 5051.520105589963, 5073.184382667618, 5077.619178561623, 5083.262926875619, 5102.897942041139, 4672.696274742131, 4677.204875171229, 4718.73500719653, 4725.362076119714, 4729.62163026957, 5303.258194801294, 5346.27825243591, 5412.837614871521, 5434.157705555645, 5514.310711161105, 3948.7630742155275, 3952.565217826037, 3960.2475529649564, 3963.4847469829024, 3976.880693579197, 5688.658680479184, 5711.7144142792695, 5712.343080545749, 5715.1713001614535, 5745.9425405745405, 4028.295048366524, 4070.430139780433, 4084.7549147051272, 4097.713160078825, 4101.507819061731, 4001.2597669431248, 4053.1488387438967, 4063.8577649782114, 4071.6131967463043, 4085.8569950051606, 4611.0, 4625.306204069349, 4647.302904564275, 4659.301104834302, 4665.2768820832825, 5485.232067510552, 5517.420670829585, 5535.806246781343, 5545.445455454423, 5572.749226284827, 1293.4567481657725, 1329.528017553774, 1397.9930100349434, 1398.8531204223614, 1402.4320150339129, 889.2974550105473, 899.2670973156856, 913.5706218077493, 914.7530166855045, 929.2240978782792, 4749.572538471485, 4763.95236047642, 4772.952270477251, 4787.760611969387, 4812.639052071108, 4922.384701912261, 4954.0, 4980.601551875914, 5003.674761140514, 5006.4492905780335, 4575.496695363508, 4677.18149323867, 4696.38946936896, 4703.6942598730975, 4798.66409351349, 2655.9336016599354, 2660.255128564005, 2660.348214687414, 2661.3612732944343, 2670.5460071787843, 5107.514786095315, 5228.869278267997, 5250.606204534675, 5254.290670759398, 5263.184206448007, 4837.637177211724, 4998.70007799526, 5000.399952005782, 5015.3730783652045, 5082.848633847038, 5156.845294641242, 5183.170692689152, 5209.0, 5209.4009188943, 5295.602829787781, 4961.652684312064, 4987.326710893983, 5046.662634401813, 5051.722155281494, 5064.772085256099, 4665.953340466687, 4746.833860814855, 4814.542618451242, 4943.728094954812, 5014.8465852853315, 5116.539511443988, 5184.585233181412, 5213.76538055796, 5239.29269548606, 5258.763355649082, 3683.7421380503106, 3700.870469533661, 3716.832742526539, 3716.869909553153, 3865.3622152345674, 5401.297831281908, 5629.324481062299, 5651.0, 5655.406182350794, 5699.0, 5418.593605479526, 5431.696392865762, 5442.23808666779, 5477.72611369422, 5515.255440515479, 5246.819465620205, 5487.807926722546, 5495.835124946258, 5503.862403439946, 5516.531094856821, 5381.569474441957, 5394.703291319015, 5395.379531353945, 5403.8651883104985, 5411.835265893674, 5503.284573005483, 5519.337679478488, 5520.006398848246, 5522.475364840334, 5537.390887002507, 5252.290940722954, 5349.786008559614, 5433.891322173456, 5434.918476222781, 5441.428649991693], "value": 4053.981264589472, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.9132608423947, 725.7097161135545, 733.6845156582667, 759.9050118735157, 764.3541207679513, 14172.50396236132, 14213.857861421382, 14272.072315299498, 14278.0, 14681.265936703163, 13826.93086534566, 14585.927070364633, 14619.0, 14619.830413566915, 14631.122132672048, 667.6895243711673, 771.6874665760362, 782.8903953446494, 785.9410544209179, 820.2658620534618, 807.6527093349857, 808.6805711743858, 808.7573727881642, 810.1372038778682, 811.5820352518429, 850.7575341027808, 850.9404341696053, 852.0669866496177, 852.2415050604967, 852.3479538153317, 704.8167476456107, 831.4055450352996, 848.0798333807826, 849.4605925237457, 851.5614458553788, 620.0, 620.7548018532699, 621.3506885304868, 622.0203179991486, 622.2688341199073, 14468.493602723855, 14502.0, 14507.492237771627, 14517.854821451756, 14524.346404411826, 13064.804027939588, 13311.807659828184, 13372.665683357896, 13519.256440895746, 13585.352622961458, 11965.641030769091, 11967.222130561486, 11971.46128424223, 12023.939880300542, 12098.0, 4352.448501849289, 4367.3448982652535, 4385.51759306476, 4434.556544345572, 4480.171168333869, 55787.44212557863, 56336.43663563353, 56476.71761641165, 57804.42195578032, 59009.114863276656, 10663.253572249869, 10725.570977160982, 10805.081568066802, 10966.506507207196, 11088.33469991803, 20000.699989500168, 20018.299359522345, 20018.499537511678, 20022.399328020183, 20026.198952042047, 7938.9206107939335, 7997.680092796223, 8044.954155959687, 8069.6368663410285, 8140.979630225502, 4452.154090722753, 4469.597736203757, 4483.798229079699, 4503.887402814956, 4518.502964673883, 3279.2293810954407, 3373.207296285371, 3374.0, 3376.57792775903, 3379.459286514146, 614.5390956782413, 629.6190804563265, 630.2059405149545, 635.6218050260088, 641.172886975796, 624.8406656302705, 656.3370995294787, 679.8028571714246, 712.6757325416922, 715.5492040014861, 8370.623321950527, 8429.157084291644, 8457.957710211533, 8477.788055298666, 8693.0, 676.4689718570899, 703.357838267441, 712.8924621523404, 716.4662326566742, 726.7093162734842, 3668.3947148720695, 3762.6237376262156, 3789.962100379016, 3937.125748502994, 3950.1704642025497, 63460.0, 64956.67521662456, 66989.33010669929, 67099.66450167815, 67131.32868671349, 30966.22584435407, 60178.69910650419, 60181.39818601758, 60473.0, 61225.0, 54726.179107314216, 54831.0, 54849.177262341094, 55772.72113639406, 55858.72070639702, 8154.673813047411, 8188.0993090758775, 8196.918030819616, 8315.792105197177, 8404.915950840657, 37354.252914941004, 37640.62359376481, 37669.62330376661, 37765.05587360228, 38229.61770382372, 49532.0, 49781.0, 49969.0, 50189.0, 50580.49419505905, 10815.56737730482, 11147.498362573866, 11238.943805280922, 11296.526362868099, 11582.305061696325, 10698.518566664363, 10792.676219713421, 10838.67483975482, 11011.0, 11379.601713939972, 10952.233343666185, 11252.887471125185, 11276.154288428237, 11445.313281203154, 12364.81452778227, 10747.623833165802, 10780.622678206226, 10968.451577420938, 11047.060999815105, 11141.331520108819, 10178.23663225276, 10623.681289561326, 11068.114550836075, 11128.55485780592, 11474.368909709712, 9619.374740641835, 9725.562349694139, 9997.60009599637, 10012.549435275285, 10102.545385457524, 9177.357584969255, 9734.0, 9859.556319965475, 9879.802403952024, 9887.093972555092], "value": 6594.394264251319, "unit": "score"}], "name": "dromaeo_css", "value": 6899.431146341723, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 111.0, 110.0, 111.0, 109.0, 109.0, 108.0, 109.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 130.0, 126.0, 183.0, 124.0, 129.0, 150.0, 129.0, 167.0, 126.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 161.0, 161.0, 162.0, 160.0, 161.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 112.0, 74.0, 75.0, 74.0, 74.0, 96.0, 75.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 122.0, 91.0, 94.0, 92.0, 139.0, 92.0, 92.0, 144.0], "value": 104.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0], "value": 144.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 53.0, 55.0, 54.0, 54.0, 70.0, 52.0, 51.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 78.0, 79.0, 80.0, 77.0, 80.0, 83.0, 86.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 132.0, 119.0, 119.0, 119.0, 117.0, 123.0, 122.0, 158.0, 129.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 166.0, 162.0, 160.0, 163.0, 158.0, 158.0, 160.0, 158.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 62.0, 61.0, 62.0, 63.0, 62.0, 62.0, 60.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1501.1999999999996, "alertThreshold": 2.0}]} 07:23:04 INFO - Return code: 0 07:23:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:23:04 ERROR - # TBPL SUCCESS # 07:23:04 INFO - Running post-action listener: _resource_record_post_action 07:23:04 INFO - ##### 07:23:04 INFO - ##### Finished run-tests step (success) 07:23:04 INFO - ##### 07:23:04 INFO - Running post-run listener: _resource_record_post_run 07:23:04 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401420288; Read time: 16; Write time: 308268 07:23:04 INFO - TinderboxPrint: CPU usage
13.2% 07:23:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:23:04 INFO - TinderboxPrint: I/O write bytes / time
401,420,288 / 308,268 07:23:04 INFO - TinderboxPrint: CPU idle
8,258.9 (86.8%) 07:23:04 INFO - TinderboxPrint: CPU user
1,213.5 (12.8%) 07:23:04 INFO - TinderboxPrint: Swap in / out
0 / 0 07:23:04 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109281280; Read time: 0; Write time: 89044 07:23:04 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292139008; Read time: 16; Write time: 219224 07:23:05 INFO - Running post-run listener: _upload_blobber_files 07:23:05 INFO - Blob upload gear active. 07:23:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:23:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:23:05 INFO - (blobuploader) - INFO - Open directory for files ... 07:23:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:23:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:23:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:06 INFO - (blobuploader) - INFO - Done attempting. 07:23:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:23:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:23:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:10 INFO - (blobuploader) - INFO - Done attempting. 07:23:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:23:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:23:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:10 INFO - (blobuploader) - INFO - Done attempting. 07:23:10 INFO - (blobuploader) - INFO - Iteration through files over. 07:23:10 INFO - Return code: 0 07:23:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:23:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:23:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5ed98eb02a93cb74ae972e9f0679a2ae69f03affc0f529d9fc43d7bb2130a2f685afe442c4696b7b300c0fbd993499bae5b949b42a61f8f6f03d7c9d8d1c126b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5c9e2c027228bfe806534ac8cc4541bd26c9d8951d11456b59a0a4ccf635281f9349977bb4bd256e0413d9f4dae314eba609127b0426dc4073309b87cb65dddd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a8be17d3fb97b84237a84325ff4de19a951c082e632ea704c550fb20fdb50d9dedc92b08534aa8df5e6ff234c7ed930905174b5f6130ed35525a329366701431"} 07:23:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:23:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:23:10 INFO - Contents: 07:23:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5ed98eb02a93cb74ae972e9f0679a2ae69f03affc0f529d9fc43d7bb2130a2f685afe442c4696b7b300c0fbd993499bae5b949b42a61f8f6f03d7c9d8d1c126b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5c9e2c027228bfe806534ac8cc4541bd26c9d8951d11456b59a0a4ccf635281f9349977bb4bd256e0413d9f4dae314eba609127b0426dc4073309b87cb65dddd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a8be17d3fb97b84237a84325ff4de19a951c082e632ea704c550fb20fdb50d9dedc92b08534aa8df5e6ff234c7ed930905174b5f6130ed35525a329366701431"} 07:23:10 INFO - Running post-run listener: copy_logs_to_upload_dir 07:23:10 INFO - Copying logs to upload dir... 07:23:10 INFO - mkdir: /builds/slave/test/build/upload/logs 07:23:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.099567 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-23 07:23:10.623802) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 07:23:10.626868) ========= 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=ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5ed98eb02a93cb74ae972e9f0679a2ae69f03affc0f529d9fc43d7bb2130a2f685afe442c4696b7b300c0fbd993499bae5b949b42a61f8f6f03d7c9d8d1c126b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5c9e2c027228bfe806534ac8cc4541bd26c9d8951d11456b59a0a4ccf635281f9349977bb4bd256e0413d9f4dae314eba609127b0426dc4073309b87cb65dddd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a8be17d3fb97b84237a84325ff4de19a951c082e632ea704c550fb20fdb50d9dedc92b08534aa8df5e6ff234c7ed930905174b5f6130ed35525a329366701431"} build_url:https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011173 build_url: 'https://queue.taskcluster.net/v1/task/fyFyRteBSeOjpmNS6-0cNA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5ed98eb02a93cb74ae972e9f0679a2ae69f03affc0f529d9fc43d7bb2130a2f685afe442c4696b7b300c0fbd993499bae5b949b42a61f8f6f03d7c9d8d1c126b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5c9e2c027228bfe806534ac8cc4541bd26c9d8951d11456b59a0a4ccf635281f9349977bb4bd256e0413d9f4dae314eba609127b0426dc4073309b87cb65dddd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a8be17d3fb97b84237a84325ff4de19a951c082e632ea704c550fb20fdb50d9dedc92b08534aa8df5e6ff234c7ed930905174b5f6130ed35525a329366701431"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 07:23:10.651087) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:23:10.651392) ========= 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=ed14279e38b05397cf4aa391000001a4-1464009320.74081-1285485693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:23:10.735257) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 07:23:10.735581) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 07:23:10.735859) ========= ========= Total master_lag: 0.17 =========