builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1463694182.29 results: success (0) buildid: 20160519103123 builduid: 24a9d2b567574f4b9771af108d437b28 revision: a32fdbf877e09609cf4894cf6fa27711795839e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 14:43:02.288504) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 14:43:02.288938) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 14:43:02.289215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 14:43:02.308198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 14:43:02.308527) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 14:43:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-05-19 14:43:02 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071305 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 14:43:02.394068) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 14:43:02.394425) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018320 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 14:43:02.448187) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 14:43:02.451573) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a32fdbf877e09609cf4894cf6fa27711795839e2 --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 a32fdbf877e09609cf4894cf6fa27711795839e2 --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=a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 14:43:02,762 truncating revision to first 12 chars 2016-05-19 14:43:02,762 Setting DEBUG logging. 2016-05-19 14:43:02,762 attempt 1/10 2016-05-19 14:43:02,762 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/a32fdbf877e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 14:43:03,894 unpacking tar archive at: mozilla-inbound-a32fdbf877e0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.397927 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 14:43:03.862661) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 14:43:03.862977) ========= script_repo_revision: a32fdbf877e09609cf4894cf6fa27711795839e2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 14:43:03.863382) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 14:43:03.863667) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 14:43:03.871339) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-19 14:43:03.871738) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:43:04 INFO - MultiFileLogger online at 20160519 14:43:04 in /builds/slave/test 14:43:04 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 14:43:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:43:04 INFO - {'append_to_log': False, 14:43:04 INFO - 'base_work_dir': '/builds/slave/test', 14:43:04 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 14:43:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:43:04 INFO - 'branch': 'Mozilla-Inbound', 14:43:04 INFO - 'buildbot_json_path': 'buildprops.json', 14:43:04 INFO - 'config_files': ('talos/linux_config.py',), 14:43:04 INFO - 'default_actions': ('clobber', 14:43:04 INFO - 'read-buildbot-config', 14:43:04 INFO - 'download-and-extract', 14:43:04 INFO - 'populate-webroot', 14:43:04 INFO - 'create-virtualenv', 14:43:04 INFO - 'install', 14:43:04 INFO - 'run-tests'), 14:43:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:43:04 INFO - 'download_minidump_stackwalk': True, 14:43:04 INFO - 'download_symbols': 'ondemand', 14:43:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:43:04 INFO - 'tooltool.py': '/tools/tooltool.py', 14:43:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:43:04 INFO - '/tools/misc-python/virtualenv.py')}, 14:43:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:43:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:43:04 INFO - 'installer_path': 'installer.exe', 14:43:04 INFO - 'log_level': 'info', 14:43:04 INFO - 'log_name': 'talos', 14:43:04 INFO - 'log_to_console': True, 14:43:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:43:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:43:04 INFO - 'opt_config_files': (), 14:43:04 INFO - 'pip_index': False, 14:43:04 INFO - 'sps_profile': False, 14:43:04 INFO - 'sps_profile_interval': 0, 14:43:04 INFO - 'suite': 'dromaeojs', 14:43:04 INFO - 'system_bits': '32', 14:43:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:43:04 INFO - 'title': 'talos-linux64-ix-062', 14:43:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:43:04 INFO - 'use_talos_json': True, 14:43:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:43:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:43:04 INFO - 'work_dir': 'build'} 14:43:04 INFO - ##### 14:43:04 INFO - ##### Running clobber step. 14:43:04 INFO - ##### 14:43:04 INFO - Running pre-action listener: _resource_record_pre_action 14:43:04 INFO - Running main action method: clobber 14:43:04 INFO - rmtree: /builds/slave/test/build 14:43:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:43:05 INFO - Running post-action listener: _resource_record_post_action 14:43:05 INFO - ##### 14:43:05 INFO - ##### Finished clobber step (success) 14:43:05 INFO - ##### 14:43:05 INFO - ##### 14:43:05 INFO - ##### Running read-buildbot-config step. 14:43:05 INFO - ##### 14:43:05 INFO - Running pre-action listener: _resource_record_pre_action 14:43:05 INFO - Running main action method: read_buildbot_config 14:43:05 INFO - Using buildbot properties: 14:43:05 INFO - { 14:43:05 INFO - "project": "", 14:43:05 INFO - "product": "firefox", 14:43:05 INFO - "script_repo_revision": "production", 14:43:05 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 14:43:05 INFO - "repository": "", 14:43:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 14:43:05 INFO - "buildid": "20160519103123", 14:43:05 INFO - "pgo_build": "True", 14:43:05 INFO - "basedir": "/builds/slave/test", 14:43:05 INFO - "buildnumber": 1027, 14:43:05 INFO - "slavename": "talos-linux64-ix-062", 14:43:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:43:05 INFO - "platform": "ubuntu64_hw", 14:43:05 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 14:43:05 INFO - "branch": "mozilla-inbound", 14:43:05 INFO - "repo_path": "integration/mozilla-inbound", 14:43:05 INFO - "revision": "a32fdbf877e09609cf4894cf6fa27711795839e2", 14:43:05 INFO - "stage_platform": "linux64-pgo", 14:43:05 INFO - "builduid": "24a9d2b567574f4b9771af108d437b28", 14:43:05 INFO - "slavebuilddir": "test" 14:43:05 INFO - } 14:43:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:43:05 INFO - Running post-action listener: _resource_record_post_action 14:43:05 INFO - ##### 14:43:05 INFO - ##### Finished read-buildbot-config step (success) 14:43:05 INFO - ##### 14:43:05 INFO - ##### 14:43:05 INFO - ##### Running download-and-extract step. 14:43:05 INFO - ##### 14:43:05 INFO - Running pre-action listener: _resource_record_pre_action 14:43:05 INFO - Running main action method: download_and_extract 14:43:05 INFO - mkdir: /builds/slave/test/build/tests 14:43: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')]} 14:43:05 INFO - https://queue.taskcluster.net/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:43:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:43:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:43:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/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 14:43:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/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 14:43:05 INFO - Downloaded 1361 bytes. 14:43:05 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:43:05 INFO - Using the following test package requirements: 14:43:05 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:43:05 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:43:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:43:05 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:43:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:43:05 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:43:05 INFO - u'jsshell-linux-x86_64.zip'], 14:43:05 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:43:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:43:05 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:43:05 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:43:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:43:05 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:43:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:43:05 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:43:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:43:05 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:43:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:43:05 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:43: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')]} 14:43:05 INFO - https://queue.taskcluster.net/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:43:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:43:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:43:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/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 14:43:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/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 14:43:07 INFO - Downloaded 24388430 bytes. 14:43:07 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'] 14:43:07 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 14:43:08 INFO - Return code: 0 14:43:08 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 14:43: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')]} 14:43:08 INFO - https://queue.taskcluster.net/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:43:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:43:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:43:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/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 14:43:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/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 14:43:10 INFO - Downloaded 24388430 bytes. 14:43:10 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'] 14:43:10 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 14:43:11 INFO - Return code: 0 14:43:11 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')]} 14:43:11 INFO - https://queue.taskcluster.net/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:43:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:43:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:43:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/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 14:43:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/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 14:43:12 INFO - Downloaded 10840359 bytes. 14:43:12 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'] 14:43:12 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 14:43:12 INFO - Return code: 0 14:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:43:12 INFO - https://queue.taskcluster.net/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:43:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:43:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:43:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/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 14:43:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AavsB14NQw-64R7QRxI35Q/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 14:43:15 INFO - Downloaded 58607867 bytes. 14:43:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:43:15 INFO - mkdir: /builds/slave/test/properties 14:43:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:43:15 INFO - Writing to file /builds/slave/test/properties/build_url 14:43:15 INFO - Contents: 14:43:15 INFO - build_url:https://queue.taskcluster.net/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:43:16 INFO - Running post-action listener: _resource_record_post_action 14:43:16 INFO - Running post-action listener: set_extra_try_arguments 14:43:16 INFO - ##### 14:43:16 INFO - ##### Finished download-and-extract step (success) 14:43:16 INFO - ##### 14:43:16 INFO - ##### 14:43:16 INFO - ##### Running populate-webroot step. 14:43:16 INFO - ##### 14:43:16 INFO - Running pre-action listener: _resource_record_pre_action 14:43:16 INFO - Running main action method: populate_webroot 14:43:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:43:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:43:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:43:16 INFO - '--tppagecycles', 14:43:16 INFO - '7'], 14:43:16 INFO - 'tests': ['tsvgm']}}, 14:43:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:43:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:43:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:43:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:43:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:43:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:43:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:16 INFO - 'talos_options': ['--disable-e10s'], 14:43:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:43:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:43:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:16 INFO - 'talos_options': ['--disable-e10s'], 14:43:16 INFO - 'tests': ['damp', 'tps']}, 14:43:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:16 INFO - 'tests': ['damp', 'tps']}, 14:43:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:43:16 INFO - 'tests': ['dromaeo_dom']}, 14:43:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:43:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:43:16 INFO - 'tests': ['a11yr', 14:43:16 INFO - 'ts_paint', 14:43:16 INFO - 'tpaint', 14:43:16 INFO - 'sessionrestore', 14:43:16 INFO - 'sessionrestore_no_auto_restore', 14:43:16 INFO - 'tabpaint']}, 14:43:16 INFO - 'other-e10s': {'tests': ['a11yr', 14:43:16 INFO - 'ts_paint', 14:43:16 INFO - 'tpaint', 14:43:16 INFO - 'sessionrestore', 14:43:16 INFO - 'sessionrestore_no_auto_restore', 14:43:16 INFO - 'tabpaint']}, 14:43:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:43:16 INFO - 'ts_paint', 14:43:16 INFO - 'tpaint', 14:43:16 INFO - 'sessionrestore', 14:43:16 INFO - 'sessionrestore_no_auto_restore', 14:43:16 INFO - 'tabpaint']}, 14:43:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:43:16 INFO - 'ts_paint', 14:43:16 INFO - 'tpaint', 14:43:16 INFO - 'sessionrestore', 14:43:16 INFO - 'sessionrestore_no_auto_restore', 14:43:16 INFO - 'tabpaint']}, 14:43:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:43:16 INFO - 'tests': ['a11yr', 14:43:16 INFO - 'ts_paint', 14:43:16 INFO - 'tpaint', 14:43:16 INFO - 'sessionrestore', 14:43:16 INFO - 'sessionrestore_no_auto_restore', 14:43:16 INFO - 'tabpaint']}, 14:43:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:43:16 INFO - 'tests': ['a11yr', 14:43:16 INFO - 'ts_paint', 14:43:16 INFO - 'tpaint', 14:43:16 INFO - 'sessionrestore', 14:43:16 INFO - 'sessionrestore_no_auto_restore', 14:43:16 INFO - 'tabpaint']}, 14:43:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:43:16 INFO - 'tests': ['tsvgx', 14:43:16 INFO - 'tsvgr_opacity', 14:43:16 INFO - 'tart', 14:43:16 INFO - 'tscrollx', 14:43:16 INFO - 'cart']}, 14:43:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:43:16 INFO - 'tsvgr_opacity', 14:43:16 INFO - 'tart', 14:43:16 INFO - 'tscrollx', 14:43:16 INFO - 'cart']}, 14:43:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:16 INFO - 'talos_options': ['--disable-e10s'], 14:43:16 INFO - 'tests': ['tp5o']}, 14:43:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:16 INFO - 'tests': ['tp5o']}, 14:43:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:16 INFO - 'talos_options': ['--disable-e10s', 14:43:16 INFO - '--xperf_path', 14:43:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:43:16 INFO - 'tests': ['tp5n']}, 14:43:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:43:16 INFO - 'talos_options': ['--xperf_path', 14:43:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:43:16 INFO - 'tests': ['tp5n']}}, 14:43:16 INFO - 'talos.zip': {'path': '', 14:43:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:43:16 INFO - Running post-action listener: _resource_record_post_action 14:43:16 INFO - ##### 14:43:16 INFO - ##### Finished populate-webroot step (success) 14:43:16 INFO - ##### 14:43:16 INFO - ##### 14:43:16 INFO - ##### Running create-virtualenv step. 14:43:16 INFO - ##### 14:43:16 INFO - Running pre-action listener: _resource_record_pre_action 14:43:16 INFO - Running main action method: create_virtualenv 14:43:16 INFO - Creating virtualenv /builds/slave/test/build/venv 14:43:16 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 14:43:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:43:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:43:16 INFO - Using real prefix '/usr' 14:43:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:43:16 INFO - Installing distribute.............................................................................................................................................................................................done. 14:43:18 INFO - Installing pip.................done. 14:43:18 INFO - Return code: 0 14:43:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:18 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 0x7f679da92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c42770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd19c0>, '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 0x2cd28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', '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 14:43:18 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 14:43:18 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 14:43:18 INFO - Using env: {'DISPLAY': ':0', 14:43:18 INFO - 'HOME': '/home/cltbld', 14:43:18 INFO - 'LANG': 'en_US.UTF-8', 14:43:18 INFO - 'LANGUAGE': 'en_US:en', 14:43:18 INFO - 'LOGNAME': 'cltbld', 14:43:18 INFO - 'MAIL': '/var/mail/cltbld', 14:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:18 INFO - 'MOZ_NO_REMOTE': '1', 14:43:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:18 INFO - 'NO_EM_RESTART': '1', 14:43:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:18 INFO - 'PWD': '/builds/slave/test', 14:43:18 INFO - 'SHELL': '/bin/bash', 14:43:18 INFO - 'SHLVL': '1', 14:43:18 INFO - 'TERM': 'linux', 14:43:18 INFO - 'TMOUT': '86400', 14:43:18 INFO - 'USER': 'cltbld', 14:43:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', 14:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:18 INFO - '_': '/tools/buildbot/bin/python'} 14:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:19 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 14:43:19 INFO - Cleaning up... 14:43:19 INFO - Return code: 0 14:43:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:43:19 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')]} 14:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:19 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')]} 14:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:19 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 0x7f679da92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c42770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd19c0>, '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 0x2cd28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', '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 14:43:19 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 14:43:19 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 14:43:19 INFO - Using env: {'DISPLAY': ':0', 14:43:19 INFO - 'HOME': '/home/cltbld', 14:43:19 INFO - 'LANG': 'en_US.UTF-8', 14:43:19 INFO - 'LANGUAGE': 'en_US:en', 14:43:19 INFO - 'LOGNAME': 'cltbld', 14:43:19 INFO - 'MAIL': '/var/mail/cltbld', 14:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:19 INFO - 'MOZ_NO_REMOTE': '1', 14:43:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:19 INFO - 'NO_EM_RESTART': '1', 14:43:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:19 INFO - 'PWD': '/builds/slave/test', 14:43:19 INFO - 'SHELL': '/bin/bash', 14:43:19 INFO - 'SHLVL': '1', 14:43:19 INFO - 'TERM': 'linux', 14:43:19 INFO - 'TMOUT': '86400', 14:43:19 INFO - 'USER': 'cltbld', 14:43:19 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', 14:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:19 INFO - '_': '/tools/buildbot/bin/python'} 14:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:19 INFO - Downloading/unpacking psutil>=3.1.1 14:43:19 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 14:43:19 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 14:43:19 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 14:43:19 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 14:43:19 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 14:43:19 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 14:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:43:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:43:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:43:21 INFO - Installing collected packages: psutil 14:43:21 INFO - Running setup.py install for psutil 14:43:21 INFO - building 'psutil._psutil_linux' extension 14:43:21 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 14:43:21 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 14:43:21 INFO - building 'psutil._psutil_posix' extension 14:43:21 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 14:43:21 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 14:43:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:43:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:43:21 INFO - Successfully installed psutil 14:43:21 INFO - Cleaning up... 14:43:21 INFO - Return code: 0 14:43:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:21 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 0x7f679da92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c42770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd19c0>, '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 0x2cd28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', '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 14:43:21 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 14:43:21 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 14:43:21 INFO - Using env: {'DISPLAY': ':0', 14:43:21 INFO - 'HOME': '/home/cltbld', 14:43:21 INFO - 'LANG': 'en_US.UTF-8', 14:43:21 INFO - 'LANGUAGE': 'en_US:en', 14:43:21 INFO - 'LOGNAME': 'cltbld', 14:43:21 INFO - 'MAIL': '/var/mail/cltbld', 14:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:21 INFO - 'MOZ_NO_REMOTE': '1', 14:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:21 INFO - 'NO_EM_RESTART': '1', 14:43:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:21 INFO - 'PWD': '/builds/slave/test', 14:43:21 INFO - 'SHELL': '/bin/bash', 14:43:21 INFO - 'SHLVL': '1', 14:43:21 INFO - 'TERM': 'linux', 14:43:21 INFO - 'TMOUT': '86400', 14:43:21 INFO - 'USER': 'cltbld', 14:43:21 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', 14:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:21 INFO - '_': '/tools/buildbot/bin/python'} 14:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:43:22 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 14:43:22 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 14:43:22 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 14:43:22 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 14:43:22 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 14:43:22 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 14:43:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:43:23 INFO - Installing collected packages: mozsystemmonitor 14:43:23 INFO - Running setup.py install for mozsystemmonitor 14:43:24 INFO - Successfully installed mozsystemmonitor 14:43:24 INFO - Cleaning up... 14:43:24 INFO - Return code: 0 14:43:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:43: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')]} 14:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43: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')]} 14:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:24 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 0x7f679da92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c42770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd19c0>, '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 0x2cd28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', '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 14:43:24 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 14:43:24 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 14:43:24 INFO - Using env: {'DISPLAY': ':0', 14:43:24 INFO - 'HOME': '/home/cltbld', 14:43:24 INFO - 'LANG': 'en_US.UTF-8', 14:43:24 INFO - 'LANGUAGE': 'en_US:en', 14:43:24 INFO - 'LOGNAME': 'cltbld', 14:43:24 INFO - 'MAIL': '/var/mail/cltbld', 14:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:24 INFO - 'MOZ_NO_REMOTE': '1', 14:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:24 INFO - 'NO_EM_RESTART': '1', 14:43:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:24 INFO - 'PWD': '/builds/slave/test', 14:43:24 INFO - 'SHELL': '/bin/bash', 14:43:24 INFO - 'SHLVL': '1', 14:43:24 INFO - 'TERM': 'linux', 14:43:24 INFO - 'TMOUT': '86400', 14:43:24 INFO - 'USER': 'cltbld', 14:43:24 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', 14:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:24 INFO - '_': '/tools/buildbot/bin/python'} 14:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:24 INFO - Downloading/unpacking blobuploader==1.2.4 14:43:24 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 14:43:24 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 14:43:24 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 14:43:24 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 14:43:24 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 14:43:24 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 14:43:26 INFO - Downloading blobuploader-1.2.4.tar.gz 14:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:43:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:43:26 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 14:43:26 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 14:43:26 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 14:43:26 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 14:43:26 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 14:43:26 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 14:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:43:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:43:26 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 14:43:26 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 14:43:26 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 14:43:26 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 14:43:26 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 14:43:26 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 14:43:26 INFO - Downloading docopt-0.6.1.tar.gz 14:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:43:27 INFO - Installing collected packages: blobuploader, requests, docopt 14:43:27 INFO - Running setup.py install for blobuploader 14:43:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:43:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:43:27 INFO - Running setup.py install for requests 14:43:27 INFO - Running setup.py install for docopt 14:43:27 INFO - Successfully installed blobuploader requests docopt 14:43:27 INFO - Cleaning up... 14:43:27 INFO - Return code: 0 14:43:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:27 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 0x7f679da92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c42770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd19c0>, '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 0x2cd28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', '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 14:43:27 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 14:43:27 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 14:43:27 INFO - Using env: {'DISPLAY': ':0', 14:43:27 INFO - 'HOME': '/home/cltbld', 14:43:27 INFO - 'LANG': 'en_US.UTF-8', 14:43:27 INFO - 'LANGUAGE': 'en_US:en', 14:43:27 INFO - 'LOGNAME': 'cltbld', 14:43:27 INFO - 'MAIL': '/var/mail/cltbld', 14:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:27 INFO - 'MOZ_NO_REMOTE': '1', 14:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:27 INFO - 'NO_EM_RESTART': '1', 14:43:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:27 INFO - 'PWD': '/builds/slave/test', 14:43:27 INFO - 'SHELL': '/bin/bash', 14:43:27 INFO - 'SHLVL': '1', 14:43:27 INFO - 'TERM': 'linux', 14:43:27 INFO - 'TMOUT': '86400', 14:43:27 INFO - 'USER': 'cltbld', 14:43:27 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', 14:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:27 INFO - '_': '/tools/buildbot/bin/python'} 14:43:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:43:27 INFO - Running setup.py (path:/tmp/pip-aunqvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:43:27 INFO - Running setup.py (path:/tmp/pip-x0b1sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:43:27 INFO - Running setup.py (path:/tmp/pip-CBRFBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:43:28 INFO - Running setup.py (path:/tmp/pip-LVP6nL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:43:28 INFO - Running setup.py (path:/tmp/pip-P_nDSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:43:28 INFO - Running setup.py (path:/tmp/pip-jr8ZP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:43:28 INFO - Running setup.py (path:/tmp/pip-3M66Ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:43:28 INFO - Running setup.py (path:/tmp/pip-3EeROh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:43:28 INFO - Running setup.py (path:/tmp/pip-3LQz6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:43:28 INFO - Running setup.py (path:/tmp/pip-thPgPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:43:28 INFO - Running setup.py (path:/tmp/pip-Qq3Fuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:43:28 INFO - Running setup.py (path:/tmp/pip-npvGWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:43:28 INFO - Running setup.py (path:/tmp/pip-opXrCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:43:28 INFO - Running setup.py (path:/tmp/pip-NbPdPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:28 INFO - Running setup.py (path:/tmp/pip-VGkVMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:43:28 INFO - Running setup.py (path:/tmp/pip-kdtbm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:43:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:43:28 INFO - Running setup.py (path:/tmp/pip-ov5sNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:43:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:43:29 INFO - Running setup.py install for manifestparser 14:43:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:43:29 INFO - Running setup.py install for mozcrash 14:43:29 INFO - Running setup.py install for mozdebug 14:43:29 INFO - Running setup.py install for mozdevice 14:43:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:43:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:43:29 INFO - Running setup.py install for mozfile 14:43:29 INFO - Running setup.py install for mozhttpd 14:43:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:43:29 INFO - Running setup.py install for mozinfo 14:43:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:43:29 INFO - Running setup.py install for mozInstall 14:43:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:43:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:43:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:43:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:43:29 INFO - Running setup.py install for mozleak 14:43:29 INFO - Running setup.py install for mozlog 14:43:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:43:30 INFO - Running setup.py install for moznetwork 14:43:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:43:30 INFO - Running setup.py install for mozprocess 14:43:30 INFO - Running setup.py install for mozprofile 14:43:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:43:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:43:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:43:30 INFO - Running setup.py install for mozrunner 14:43:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:43:30 INFO - Running setup.py install for mozscreenshot 14:43:30 INFO - Running setup.py install for moztest 14:43:30 INFO - Running setup.py install for mozversion 14:43:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:43:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:43:30 INFO - Cleaning up... 14:43:30 INFO - Return code: 0 14:43:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43: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')]} 14:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43: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')]} 14:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:30 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 0x7f679da92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c42770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd19c0>, '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 0x2cd28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', '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 14:43:30 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 14:43:30 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 14:43:30 INFO - Using env: {'DISPLAY': ':0', 14:43:30 INFO - 'HOME': '/home/cltbld', 14:43:30 INFO - 'LANG': 'en_US.UTF-8', 14:43:30 INFO - 'LANGUAGE': 'en_US:en', 14:43:30 INFO - 'LOGNAME': 'cltbld', 14:43:30 INFO - 'MAIL': '/var/mail/cltbld', 14:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:30 INFO - 'MOZ_NO_REMOTE': '1', 14:43:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:30 INFO - 'NO_EM_RESTART': '1', 14:43:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:30 INFO - 'PWD': '/builds/slave/test', 14:43:30 INFO - 'SHELL': '/bin/bash', 14:43:30 INFO - 'SHLVL': '1', 14:43:30 INFO - 'TERM': 'linux', 14:43:30 INFO - 'TMOUT': '86400', 14:43:30 INFO - 'USER': 'cltbld', 14:43:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', 14:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:30 INFO - '_': '/tools/buildbot/bin/python'} 14:43:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:43:31 INFO - Running setup.py (path:/tmp/pip-NSHkj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:43:31 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)) 14:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:43:31 INFO - Running setup.py (path:/tmp/pip-DgHxlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:43:31 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)) 14:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:43:31 INFO - Running setup.py (path:/tmp/pip-IGVOHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:43:31 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)) 14:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:43:31 INFO - Running setup.py (path:/tmp/pip-EVi8le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:43:31 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)) 14:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:43:31 INFO - Running setup.py (path:/tmp/pip-srr0sD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:43:31 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)) 14:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:43:31 INFO - Running setup.py (path:/tmp/pip-WRlZtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:43:31 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)) 14:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:43:31 INFO - Running setup.py (path:/tmp/pip-KFzhgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:43:31 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)) 14:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:43:31 INFO - Running setup.py (path:/tmp/pip-C6U4GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:43:31 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)) 14:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:43:31 INFO - Running setup.py (path:/tmp/pip-Mh8nVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:43:31 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)) 14:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:43:31 INFO - Running setup.py (path:/tmp/pip-EwNrjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:43:31 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)) 14:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:43:31 INFO - Running setup.py (path:/tmp/pip-sfw4do-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:43:31 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)) 14:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:43:31 INFO - Running setup.py (path:/tmp/pip-a1RXwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:43:31 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)) 14:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:43:31 INFO - Running setup.py (path:/tmp/pip-WrOQUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:43:32 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)) 14:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:43:32 INFO - Running setup.py (path:/tmp/pip-WbMi0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:43:32 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)) 14:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:32 INFO - Running setup.py (path:/tmp/pip-iZ9UwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:43:32 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)) 14:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:43:32 INFO - Running setup.py (path:/tmp/pip-q1EvS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:43:32 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)) 14:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:43:32 INFO - Running setup.py (path:/tmp/pip-wEDxZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:43:32 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)) 14:43:32 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)) 14:43:32 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)) 14:43:32 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)) 14:43:32 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)) 14:43:32 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)) 14:43:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:34 INFO - Downloading blessings-1.6.tar.gz 14:43:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:43:34 INFO - Installing collected packages: blessings 14:43:34 INFO - Running setup.py install for blessings 14:43:34 INFO - Successfully installed blessings 14:43:34 INFO - Cleaning up... 14:43:34 INFO - Return code: 0 14:43:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:43:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:43:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:43:34 INFO - Reading from file tmpfile_stdout 14:43:34 INFO - Current package versions: 14:43:34 INFO - argparse == 1.2.1 14:43:34 INFO - blessings == 1.6 14:43:34 INFO - blobuploader == 1.2.4 14:43:34 INFO - docopt == 0.6.1 14:43:34 INFO - manifestparser == 1.1 14:43:34 INFO - mozInstall == 1.12 14:43:34 INFO - mozcrash == 0.17 14:43:34 INFO - mozdebug == 0.1 14:43:34 INFO - mozdevice == 0.48 14:43:34 INFO - mozfile == 1.2 14:43:34 INFO - mozhttpd == 0.7 14:43:34 INFO - mozinfo == 0.9 14:43:34 INFO - mozleak == 0.1 14:43:34 INFO - mozlog == 3.2 14:43:34 INFO - moznetwork == 0.27 14:43:34 INFO - mozprocess == 0.22 14:43:34 INFO - mozprofile == 0.28 14:43:34 INFO - mozrunner == 6.11 14:43:34 INFO - mozscreenshot == 0.1 14:43:34 INFO - mozsystemmonitor == 0.3 14:43:34 INFO - moztest == 0.7 14:43:34 INFO - mozversion == 1.4 14:43:34 INFO - psutil == 3.1.1 14:43:34 INFO - requests == 1.2.3 14:43:34 INFO - wsgiref == 0.1.2 14:43:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:43:34 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')]} 14:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:34 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')]} 14:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:34 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 0x7f679da92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c42770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd19c0>, '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 0x2cd28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', '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 14:43:34 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 14:43:34 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 14:43:34 INFO - Using env: {'DISPLAY': ':0', 14:43:34 INFO - 'HOME': '/home/cltbld', 14:43:34 INFO - 'LANG': 'en_US.UTF-8', 14:43:34 INFO - 'LANGUAGE': 'en_US:en', 14:43:34 INFO - 'LOGNAME': 'cltbld', 14:43:34 INFO - 'MAIL': '/var/mail/cltbld', 14:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:34 INFO - 'MOZ_NO_REMOTE': '1', 14:43:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:34 INFO - 'NO_EM_RESTART': '1', 14:43:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:34 INFO - 'PWD': '/builds/slave/test', 14:43:34 INFO - 'SHELL': '/bin/bash', 14:43:34 INFO - 'SHLVL': '1', 14:43:34 INFO - 'TERM': 'linux', 14:43:34 INFO - 'TMOUT': '86400', 14:43:34 INFO - 'USER': 'cltbld', 14:43:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', 14:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:34 INFO - '_': '/tools/buildbot/bin/python'} 14:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:34 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)) 14:43:34 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)) 14:43:34 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)) 14:43:34 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)) 14:43:34 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)) 14:43:34 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)) 14:43:34 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)) 14:43:34 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)) 14:43:34 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)) 14:43:34 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)) 14:43:34 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)) 14:43:34 INFO - Cleaning up... 14:43:34 INFO - Return code: 0 14:43:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:43:34 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')]} 14:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:34 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')]} 14:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:34 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 0x7f679da92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c42770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd19c0>, '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 0x2cd28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', '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 14:43:34 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 14:43:34 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 14:43:34 INFO - Using env: {'DISPLAY': ':0', 14:43:34 INFO - 'HOME': '/home/cltbld', 14:43:34 INFO - 'LANG': 'en_US.UTF-8', 14:43:34 INFO - 'LANGUAGE': 'en_US:en', 14:43:34 INFO - 'LOGNAME': 'cltbld', 14:43:34 INFO - 'MAIL': '/var/mail/cltbld', 14:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:34 INFO - 'MOZ_NO_REMOTE': '1', 14:43:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:34 INFO - 'NO_EM_RESTART': '1', 14:43:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:34 INFO - 'PWD': '/builds/slave/test', 14:43:34 INFO - 'SHELL': '/bin/bash', 14:43:34 INFO - 'SHLVL': '1', 14:43:34 INFO - 'TERM': 'linux', 14:43:34 INFO - 'TMOUT': '86400', 14:43:34 INFO - 'USER': 'cltbld', 14:43:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', 14:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:34 INFO - '_': '/tools/buildbot/bin/python'} 14:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:35 INFO - Downloading/unpacking jsonschema 14:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:43:37 INFO - Downloading/unpacking functools32 (from jsonschema) 14:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:37 INFO - Downloading functools32-3.2.3-2.tar.gz 14:43:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:43:37 INFO - warning: no files found matching '*.txt' 14:43:37 INFO - no previously-included directories found matching 'build' 14:43:37 INFO - no previously-included directories found matching 'dist' 14:43:37 INFO - no previously-included directories found matching '.git*' 14:43:37 INFO - Installing collected packages: jsonschema, functools32 14:43:37 INFO - Running setup.py install for functools32 14:43:37 INFO - warning: no files found matching '*.txt' 14:43:37 INFO - no previously-included directories found matching 'build' 14:43:37 INFO - no previously-included directories found matching 'dist' 14:43:37 INFO - no previously-included directories found matching '.git*' 14:43:37 INFO - Successfully installed jsonschema functools32 14:43:37 INFO - Cleaning up... 14:43:37 INFO - Return code: 0 14:43:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:43: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')]} 14:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:43:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43: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')]} 14:43:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:43:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:43:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f679da92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c42770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd19c0>, '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 0x2cd28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', '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 14:43:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:43:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:43:37 INFO - Using env: {'DISPLAY': ':0', 14:43:37 INFO - 'HOME': '/home/cltbld', 14:43:37 INFO - 'LANG': 'en_US.UTF-8', 14:43:37 INFO - 'LANGUAGE': 'en_US:en', 14:43:37 INFO - 'LOGNAME': 'cltbld', 14:43:37 INFO - 'MAIL': '/var/mail/cltbld', 14:43:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:37 INFO - 'MOZ_NO_REMOTE': '1', 14:43:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:37 INFO - 'NO_EM_RESTART': '1', 14:43:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:37 INFO - 'PWD': '/builds/slave/test', 14:43:37 INFO - 'SHELL': '/bin/bash', 14:43:37 INFO - 'SHLVL': '1', 14:43:37 INFO - 'TERM': 'linux', 14:43:37 INFO - 'TMOUT': '86400', 14:43:37 INFO - 'USER': 'cltbld', 14:43:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', 14:43:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:37 INFO - '_': '/tools/buildbot/bin/python'} 14:43:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:43:37 INFO - Downloading/unpacking flake8 14:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:43:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:43:39 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 14:43:39 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 14:43:39 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 14:43:39 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 14:43:39 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 14:43:39 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 14:43:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:43:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:43:39 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 14:43:39 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 14:43:39 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 14:43:39 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 14:43:39 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 14:43:39 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 14:43:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:43:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:43:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:43:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:43:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:43:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:43:40 INFO - no previously-included directories found matching 'docs/_build' 14:43:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:43:40 INFO - Running setup.py install for pep8 14:43:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:43:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:43:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:43:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:43:40 INFO - no previously-included directories found matching 'docs/_build' 14:43:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:43:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:43:40 INFO - Cleaning up... 14:43:40 INFO - Return code: 0 14:43:40 INFO - Running post-action listener: _resource_record_post_action 14:43:40 INFO - Running post-action listener: _start_resource_monitoring 14:43:40 INFO - Starting resource monitoring. 14:43:40 INFO - ##### 14:43:40 INFO - ##### Finished create-virtualenv step (success) 14:43:40 INFO - ##### 14:43:40 INFO - ##### 14:43:40 INFO - ##### Running install step. 14:43:40 INFO - ##### 14:43:40 INFO - Running pre-action listener: _resource_record_pre_action 14:43:40 INFO - Running main action method: install 14:43:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:43:40 INFO - Reading from file tmpfile_stdout 14:43:40 INFO - Detecting whether we're running mozinstall >=1.0... 14:43:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:43:40 INFO - Reading from file tmpfile_stdout 14:43:40 INFO - Output received: 14:43:40 INFO - Usage: mozinstall [options] installer 14:43:40 INFO - Options: 14:43:40 INFO - -h, --help show this help message and exit 14:43:40 INFO - -d DEST, --destination=DEST 14:43:40 INFO - Directory to install application into. [default: 14:43:40 INFO - "/builds/slave/test"] 14:43:40 INFO - --app=APP Application being installed. [default: firefox] 14:43:40 INFO - mkdir: /builds/slave/test/build/application 14:43:40 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'] 14:43:40 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 14:43:57 INFO - Reading from file tmpfile_stdout 14:43:57 INFO - Output received: 14:43:57 INFO - /builds/slave/test/build/application/firefox/firefox 14:43:57 INFO - Running post-action listener: _resource_record_post_action 14:43:57 INFO - ##### 14:43:57 INFO - ##### Finished install step (success) 14:43:57 INFO - ##### 14:43:57 INFO - ##### 14:43:57 INFO - ##### Running run-tests step. 14:43:57 INFO - ##### 14:43:57 INFO - Running pre-action listener: _resource_record_pre_action 14:43:57 INFO - Running main action method: run_tests 14:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:43:57 INFO - Python 2.7.3 14:43:57 INFO - Return code: 0 14:43:57 INFO - grabbing minidump binary from tooltool 14:43:57 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')]} 14:43:57 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 0x2cd19c0>, '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 0x2cd28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:43:57 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 14:43:57 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 14:43:57 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 14:43:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:43:57 INFO - Return code: 0 14:43:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:43:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:43:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:43:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:43:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:43:58 INFO - Return code: 0 14:43:58 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/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 14:43:58 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/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 14:43:58 INFO - Using env: {'DISPLAY': ':0', 14:43:58 INFO - 'HOME': '/home/cltbld', 14:43:58 INFO - 'LANG': 'en_US.UTF-8', 14:43:58 INFO - 'LANGUAGE': 'en_US:en', 14:43:58 INFO - 'LOGNAME': 'cltbld', 14:43:58 INFO - 'MAIL': '/var/mail/cltbld', 14:43:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:43:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:58 INFO - 'MOZ_NO_REMOTE': '1', 14:43:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:58 INFO - 'NO_EM_RESTART': '1', 14:43:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:43:58 INFO - 'PWD': '/builds/slave/test', 14:43:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:43:58 INFO - 'SHELL': '/bin/bash', 14:43:58 INFO - 'SHLVL': '1', 14:43:58 INFO - 'TERM': 'linux', 14:43:58 INFO - 'TMOUT': '86400', 14:43:58 INFO - 'USER': 'cltbld', 14:43:58 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155', 14:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:58 INFO - '_': '/tools/buildbot/bin/python'} 14:43:58 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/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 14:43:58 INFO - mozversion application_buildid: 20160519103123 14:43:58 INFO - mozversion application_changeset: a32fdbf877e09609cf4894cf6fa27711795839e2 14:43:58 INFO - mozversion application_display_name: Nightly 14:43:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:43:58 INFO - mozversion application_name: Firefox 14:43:58 INFO - mozversion application_remotingname: firefox 14:43:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:43:58 INFO - mozversion application_vendor: Mozilla 14:43:58 INFO - mozversion application_version: 49.0a1 14:43:58 INFO - mozversion platform_buildid: 20160519103123 14:43:58 INFO - mozversion platform_changeset: a32fdbf877e09609cf4894cf6fa27711795839e2 14:43:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:43:58 INFO - mozversion platform_version: 49.0a1 14:43:58 INFO - using testdate: 1463694238 14:43:58 INFO - actual date: 1463694238 14:43:58 INFO - starting webserver on 'localhost:59937' 14:43:58 INFO - SUITE-START | Running 2 tests 14:43:58 INFO - TEST-START | dromaeo_css 14:43:58 INFO - operating with platform_type : linux_ 14:43:58 INFO - Initialising browser for dromaeo_css test... 14:43:58 INFO - TEST-INFO | started process 18638 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6sPbEY/profile http://localhost:59937/getInfo.html) 14:44:02 INFO - PROCESS | 18638 | __metrics Screen width/height:1600/1200 14:44:02 INFO - PROCESS | 18638 | colorDepth:24 14:44:02 INFO - PROCESS | 18638 | Browser inner width/height: 1024/697 14:44:02 INFO - PROCESS | 18638 | __metrics 14:44:03 ERROR - PROCESS | 18638 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:44:04 INFO - TEST-INFO | 18638: exit 0 14:44:04 INFO - Browser initialized. 14:44:04 INFO - Running cycle 1/1 for dromaeo_css test... 14:44:04 INFO - TEST-INFO | started process 18716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6sPbEY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:44:16 INFO - PROCESS | 18716 | RSS: Main: 152858624 14:44:16 INFO - PROCESS | 18716 | 14:45:07 INFO - PROCESS | 18716 | 1463694307424 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] 14:47:15 INFO - PROCESS | 18716 | Cycle 1(1): loaded http://localhost:59937/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59937/tests/dromaeo/cssquery-ext.html) 14:47:16 INFO - PROCESS | 18716 | RSS: Main: 261783552 14:47:16 INFO - PROCESS | 18716 | 14:50:18 INFO - PROCESS | 18716 | Cycle 1(1): loaded http://localhost:59937/tests/dromaeo/cssquery-ext.html (next: http://localhost:59937/tests/dromaeo/cssquery-jquery.html) 14:50:19 INFO - PROCESS | 18716 | RSS: Main: 240242688 14:50:19 INFO - PROCESS | 18716 | 14:53:21 INFO - PROCESS | 18716 | Cycle 1(1): loaded http://localhost:59937/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59937/tests/dromaeo/cssquery-mootools.html) 14:53:21 INFO - PROCESS | 18716 | RSS: Main: 234065920 14:53:21 INFO - PROCESS | 18716 | 14:56:23 INFO - PROCESS | 18716 | Cycle 1(1): loaded http://localhost:59937/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59937/tests/dromaeo/cssquery-prototype.html) 14:56:24 INFO - PROCESS | 18716 | RSS: Main: 232521728 14:56:24 INFO - PROCESS | 18716 | 14:59:26 INFO - PROCESS | 18716 | Cycle 1(1): loaded http://localhost:59937/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59937/tests/dromaeo/cssquery-yui.html) 14:59:27 INFO - PROCESS | 18716 | RSS: Main: 226168832 14:59:27 INFO - PROCESS | 18716 | 15:02:30 INFO - PROCESS | 18716 | Cycle 1(1): loaded http://localhost:59937/tests/dromaeo/cssquery-yui.html (next: http://localhost:59937/tests/dromaeo/cssquery-dojo.html) 15:02:30 INFO - PROCESS | 18716 | RSS: Main: 270327808 15:02:30 INFO - PROCESS | 18716 | 15:02:30 INFO - PROCESS | 18716 | __start_tp_report 15:02:30 INFO - PROCESS | 18716 | _x_x_mozilla_page_load 15:02:30 INFO - PROCESS | 18716 | _x_x_mozilla_page_load_details 15:02:30 INFO - PROCESS | 18716 | |i|pagename|runs| 15:02:30 INFO - PROCESS | 18716 | |0;dojo.html;3116.3455674308393;3124.3751249750057;3127.358891427257;3162.667919868415;3171.730402915752;5161.870953226162;5184.7407629618465;5304.575633949285;5401.972990135048;5417.512423881854;5377.677339359641;5391.595630327722;5393.19102134679;5434.266374039504;5454.372747134081;4806.495317991613;4864.781084851173;4867.561919427251;4881.780319885614;5059.671121377099;4956;4993.176125939216;5013.298138260647;5031.119554078022;5032.82385116521;4771;4818.783154758027;4827.927581086286;4863.367762190893;4866.367372241586;4821.228603423436;4918.950810491885;4919.360483137205;4933.605311575066;4963.205887058053;4674.976625116887;4837.250226214942;4890.193118135503;4906.435759887588;4947.158982972904;5302.840914772563;5322.148456246982;5344.14493681013;5350.090484617585;5369.9463005369835;5741.885162296772;5772.163036359704;5786.450287222707;5787.942120578782;5797.913031304533;5675.914861277084;5705.315362156526;5707.971460142714;5771.797987070432;5845.883082338372;5442.156465747816;5460;5461.017016936949;5463.754131064072;5473.042217611942;5939.198208241832;5944.078667806497;5962.731677074542;5964.522838172936;5971;5505.587080968943;5604.85987850307;5647.491725744702;5664.745086471119;5706.087026075808;5722.084466485342;5765.394633563499;5837.532997360201;5837.737301821428;5843.18195452637;5678.630888992202;5679.744411501492;5693.231413759172;5764.769409223584;5771.105478650816;5637.605367624227;5672.234248376499;5690.174924635905;5726.79956201531;5763.740631671585;4379.343098535245;4387.978060109679;4390.62679672225;4391.8682439526865;4417.977910110429;3852.3451013327804;3868.9226215475533;3918.921621567553;3933.9134419501534;3965.6629186518894;5455.536279416215;5482.780688772485;5500.339959204921;5522.723863806794;5547.55619550435;5823.126531020381;5845.123231515222;5853.795117170878;5870.73581688825;5877.559183061202;5365.275687782178;5398;5548.639338442988;5559;5571.359293681197;4943.604511639061;4957.355543779286;4975.129352363322;5001;5045.823396181189;5972;5996.1005849122985;5997.340292567814;6002.54980876436;6006.489448396847;5651.689157096399;5776.075827867521;5807.0998995155815;5819.912701309569;5824.504917082096;6048.455638992512;6055.1522786810765;6057.757689692363;6079.969600151971;6094.939050609614;5720.656760594377;5733.942660573341;5747.396523365153;5752.654840709571;5759.827205183851;5633.183188437735;5667.20659107717;5686.601937864475;5722.942770572241;5839.474447299764;5612.607117501736;5617.747201375866;5625.549956003591;5627.071533196977;5628.352739434854;5573.21974923503;5595.328560572757;5611.158326251095;5617.775288988395;5633.2113504110275;5406.2971813665545;5529.087700529529;5539.944600553943;5565.248691426606;5596.188552659923;5731.054376028075;5743.59794814359;5770.163326317745;5790.044642633919;5804.042333015174;5478.643888147258;5590.357108932525;5626;5641.915371269516;5669.546436285004 15:02:30 INFO - PROCESS | 18716 | |1;ext.html;598.5271635408028;631.2803404119305;631.6715308039817;637.5059329020011;650.5381179362653;42482;44052;44228.336574951405;44285;47462.76268618661;46342.30486542696;47041.52958470414;47042.294365584545;47081;47091.529084709146;8721.215090641841;8895.644174233055;8904.821903561924;8930.062343453941;8939.106089391074;8765.474071555727;8804.427712198718;8856.025837157908;8871.245944094728;8877.067907869645;8833.514156721378;8859.645614175426;8885.822283554326;8886.60010299538;8887;8717.607707653107;8778.385513014091;8802.295816334678;8831.293496520295;8833.55832208387;8754.68679698044;8814.955925220396;8842.867356989651;8847.33644976623;8855.645774169025;43397.13205735868;43802.561974380485;43841.34237986433;43845;43946;3561.8397172127056;3728.813559322023;3740.1397678533817;3864.227154569069;4124.608162224614;32221;32897.177570560685;33086.66913330884;33886.1528461788;33900.660993389996;3693.9630603693886;3728.4034554471154;3732.533433320835;3756.1173124315765;3912.100216950089;350627;351447;353157;353315.2334238338;353506;60024.39975600276;60122.69938650279;60215.69892150599;60485;60646;57685;62734.68632656899;63923.68038159779;64418.35581644217;69008.6549567249;16810.56246844225;16819.91590042042;16866.746998795028;16950.660986780444;16958.830411695973;12932.676683082998;13013;13029.413676384585;13033.413496392684;13033.739325213442;16245.51263462098;17659.470215893543;18284;18418.447446576625;18893.622127557373;6811.489138314646;6812;6859.382655560924;6903.585784852925;7046.718131274794;918.554501066982;1029.2692188546066;1044.4882007816116;1058.222206678091;1087.521490544158;32409.837950810095;32955.50566741501;33015.339693206;33017.17457063593;33792.98621041373;1115.1023426142033;1131.7736452709491;1144.759600483891;1146.925449845774;1157.1841851494676;16947.830521694872;17150;17359.392421265195;17377.73933391;17450.389236376664;505217;506886;509181;509430;509969;60876.69561652163;61027;61033;61060.69469652623;61227.69386153041;1269.1560112525067;1367.8153449284218;1384.3631929312628;1406.9788953165505;1407.9225642589552;32024.519632206;34111.9685367811;34133.48799767956;34214;34243.4863477053;51276;51545;52076;52103.478965211376;52153;377978;380946;381325;381491;382276;37518.812405937795;42158.78920605377;42254;43542.12915741731;43602.34596481119;48547.27179092246;48597;49313.75343123262;50372.24441633452;50457.24314135218;40636.59363406328;40869.59130408658;42087;42099.36850947177;42418;40215.396769049075;40446.79776601098;40842.591574083875;41556.3766543496;41666;39957.80021099876;41455.37816932688;42460;42460.78769606256;42622.78688606537;36211.81894090618;37313.25373492569;37354.43968340423;37677.24645507129;38653.226935461695;28325.43349133047;28375.57436638411;28550.57174142431;28591;28700.712992869805 15:02:30 INFO - PROCESS | 18716 | |2;jquery.html;397.4455634390026;398.9062570295982;404.4418702190976;408.72411122492326;422.33060598950664;18075.276988920443;19617.31339403121;19656.312029078985;19971.700424493607;20697.68953465699;18898.14958326875;19262.807371926276;19415.51461213467;19778.406647800588;19831.5042123947;5632.211490391349;5664.54683625311;5793.971030144843;5808.273965754281;5809.82570522885;5531.778728850841;5683.801066962657;5685.317761868581;5689.146628005791;5713.485786279234;5520.723963801794;5535.750891209906;5689.2319536862615;5691.800786972457;5714.685692286923;5599.832005039835;5610.66336019836;5643.322801263834;5648.181013752983;5661.46216109469;4979.377577802775;5090.261912022736;5119.974400128012;5126.256692779526;5134.614903882224;22761.31716048521;22910.083596656114;23202;23206.883965580233;23255.418614534603;2363.72817126031;2417.045267119478;2438.0369753947093;2494.887730052152;2825.7456828885497;14092.506762263374;14406.423743050265;14643.41426342945;14932.925335373362;15147.697046059016;1956.7847536770944;1981.8909959952198;2006.668899631559;2095.800898914616;2203.1187524989973;68071;70822.29177708208;71418.64290678565;77111;83282;10831.514189323247;11070.557177712963;11141.331520108819;11384.203105782515;11435.14236432271;15502.767458488132;15766.68466630661;15777.921110394604;15806.446774362843;15810.446634367972;7570.697172113054;7701.691932322644;7710.460267781202;7807.687692492236;7890.210978902179;7020.859582808315;7088.929110708827;7167;7232.312930271616;7269.273072692794;4679.555442233051;4756.667033307635;4785.904281914342;4801.279808028824;4831.275308703723;1925.6245032218583;1930.3147382679228;1981.7027445883232;2001.1595130045125;2005.1177481907914;952.2286947572488;990.7225976726528;1003.4932359158578;1095.6986828622194;1109.389835590422;18744.25022999065;19448.70826937597;19481.805181948;19571.315003974792;19607.31374401889;994.2940512236394;1011.6155860772859;1016.5120742043861;1033.9069483746498;1038.3302769713493;10542.841857372145;10575.41835199056;10638.042576168182;11146;11162.88816157113;453675;454994;464728;465377;487286;68055;88363.55818220996;92910;96947;98240;1013.7060252526832;1018.4500369800224;1052.494802494807;1063.186662203415;1078.9730256743644;17299.481015569552;17874.106294685473;17927.551811204823;17967.82032179714;18334.174962126468;43235.783821080695;43610.34584481299;43733.37599744026;43964.560354396046;44367.77816110899;52473.7376313116;52788;55558.72220638871;63053.36946630475;63201.683991579746;8410.789730256793;8802.07578204305;8827.16141966512;8967.775805604912;9045.68340108093;12363.567275145328;13110;13619.863801362257;13857.584272471842;13921.930390347983;11756.70608234801;12015;12147.878521214674;12175.538935327817;12342.50629974827;11793;11793.469293881968;11803.173777835813;11914.761704765682;11961.521539138337;12215.144939854124;12243.938780306042;12357.629271121881;12518;12552.372381381078;7487.925120748941;8860.424072435271;8972.28221742246;9034.277257819227;9044.057351589254;10890.61882834097;11500;11558.133140014364;11571.363575003455;11583.6524904253 15:02:30 INFO - PROCESS | 18716 | |3;mootools.html;1334.6663334166458;1501.5870635575216;1519.756838905775;1693.7967443906732;1815.1559524820955;7691.961540192298;7958.0450345958425;7986.361091112712;8023.598820059003;8176.264136227738;7775.688972441096;7983.161768014362;8173.632186551605;8209.50742955423;8214.466059706116;2022.2214447437768;2256.7630398808137;2319.4549280918973;2331.743508214095;2361.3034154924253;2369.490559529701;2379.2267513058237;2381.226101517005;2381.7022872140983;2381.9642705359433;2327.0575416956076;2375.3349062262596;2380.8928598213033;2381.226101517005;2381.833271670984;1960.3334866145508;2258.762829902853;2330.4057465346395;2331.5103828196097;2350.2361732436857;2243.8541494802785;2260.5704916065893;2265.0600000999566;2272.988635056831;2279.623862062758;8169.387295952827;8242.216989386;8253.752387428387;8258.050324212672;8259.752207433787;5064.3163172971545;5157.69053856766;5172.094883395428;5204.5576126028955;5204.895902081975;3126.093432904455;3258.478643417042;3263.216827961296;3282.4255755242975;3333.483310086916;1026.5893642542967;1051.3113910388709;1055.2929537210089;1067.5729708116814;1068.316277582348;11229.775404491946;11483.311001339864;11491.310521368745;11501.5974440895;11529.654110376701;4590.563896429834;4634.235351167087;4664.626829853603;4678.50875658051;4704.3649107370065;9920.107190352903;9920.206383489303;9926;9928.702138935843;9952.552135153936;4505.43682039745;5225.451327610622;5245.082110630625;5247;5249.448807875195;4654.208784506642;4785.569298763128;4847.830325938575;4856.271559266068;4873.561379475864;3810.256999884996;3884.941725874114;3905.711115331934;3962.623550762673;3974.344233201547;1271.0848189303686;1299.9805002924963;1307.3071272225736;1307.7580647580228;1322.5635540271687;981.7692842182081;991.4101109839634;991.9553620087113;994.4928086675848;996.5166894056376;5772.595918285764;5877.853053673607;5953.196318497034;5959.40077293921;6074.210352654215;476.08591504311806;477.6513145403805;482.10088185534426;485.8639580917349;489.6645797628636;3876.7673939563715;3893.552241492265;3982.9203415932097;3995.2409042281874;4015.9196816063513;9862.65480708186;10204.489775511194;10343.586256549805;10344.37933723979;10357.74105647365;10225.948870255601;10231.488425578691;10257.076863082359;10348.948255258827;10351.792964140675;7477.626118694044;7769.300762931363;7799;7839.686412543549;7899.407544434191;5733.913991290051;5786.594938354275;5831.70841457917;5945.048792193401;5979.192808970907;9198.67804626835;9480.668176613786;9536.713898583053;9584.568694408628;9591.808163836544;9628.9037109628;9726.36778609388;9738.367006144861;9785.461799601091;9889.159421449258;6623.900641490285;6986.930130698628;7115.82210444743;7471.514351567131;7627.809304767426;7850.450468467153;7863.685452581833;7865.449418540876;7922.564258965812;7925.405594580314;6973.79078627642;7163.7492687755675;7187.389071928736;7283.053203083565;7320.63396830167;6997.545159564612;7000.684969176297;7048.400885924754;7061.1173603299585;7160.8925866113095;6296.842578935563;6405.487560995016;6420.357964203542;6430.324815894451;6431.067495213261;4594.058218065222;4676.251799712166;4720.409948756405;4729.148753224315;4796.160671882476;5006.6495345325475;5096.3374761282275;5157.613179011664;5163.974180129226;5271.736413179249 15:02:30 INFO - PROCESS | 18716 | |4;prototype.html;314.82841851191085;318.43795700588464;324.56508278906267;334.0013360053441;336.1998443703984;5022.221555658879;5148.794048238066;5157.922631160531;5270.815521456745;5282.260483532304;5150.381954165506;5172.948270517303;5190.610704197182;5221.973890130544;5232.110541207994;4042.7574345539215;4053.695972802037;4077.67378609712;4081.673466122703;4086.9182616347657;3891.8832435026993;3907.921841563167;4041.4139949707273;4067.2475592015426;4077.2049450357194;4019.3769965655224;4041.454403655513;4062.593740625943;4067.877963661095;4067.9389809152885;3995.262061003473;3999.5400528939253;4025.2754504189234;4043.353063509824;4064.248114098901;3503.527023851773;3603.40543810271;3607.7474576779373;3611.693006094485;3623.728220383455;5007.84819491519;5013.949860501421;5022.497750224985;5025.1708468102715;5060.873478163038;4602.332661764025;4608.400907881987;4624.861254162381;4625.49671356807;4642.675012749109;5057.9494205057845;5399.325084364455;5425.945740542623;5443.700596467193;5450.291462109901;3924.3917192835156;3932.646061854447;3936.5866584008554;3945.171513982067;3954.3475326571083;5599.496045355938;5612.765191657829;5612.915806262909;5638.40796716343;5642.210090587321;3973.145773658677;4002.399640054015;4003.219372222447;4023.4769479968004;4024.215278020816;3968.8214030368704;4066.9832541864535;4095.508538975342;4109.650679692199;4114.753114813121;4577.22187228172;4586.312053192048;4594.724316540952;4615.1616755695;4625.283081122364;5394.892102158014;5425.186222066722;5431.402545719968;5436.972815135899;5470.56235501159;1307.2809954525164;1360.177092858826;1388.854170312123;1402.719456108762;1417.6739349949569;891.821635672855;896.3770179725159;906.1663269791808;912.1425859691868;913.7395842185078;4598.425196850394;4634.281686338623;4674.859754207379;4678.2280923647895;4681.6020638245445;4881.9023619528125;4888.509004753584;4911.8280860169725;4923.483034281349;4924.261360795909;4626.768661566908;4637.5130611286;4681.578657920735;4686.835960741358;4708.717476951394;2712.389712314753;3009.5554134015797;3016.547517872337;3038.8176709397508;3040.847957602111;5795.913061304083;5799.507041901401;5799.652020878761;5813.413031201075;5862.6842397253695;5444.3194600674915;5666.206731057655;5673.461021202979;5712.371639119693;5718.571107166896;5754.971225143848;5793.420657934257;5811.476967072984;5817.767289308465;5818.650880947157;5532.474414930575;5607.327120745536;5616.382197958303;5623.578231632726;5625.718714064198;5353.2773075634295;5524.751386187711;5589.4070189995655;5594.468525490072;5601.663900166003;5748.540116790563;5771.624844385102;5777.075667893117;5807.883842323215;5820.30156381237;3765.717571182227;3968.980155099206;3973.721839471325;3993.880183594497;3998.640122388999;5191.896162076661;5630.296212973379;5639.6334238274385;5654.802081927277;5673.801416950387;5459.5632349412745;5471.452854714496;5492.752826122754;5493.450654934634;5507.669539827623;5259.47405259471;5432.022235997559;5437.728113594226;5446.373667028342;5458.836234912959;5246.790128394821;5307.52232299095;5369.919451208157;5383.9192412114635;5421.674699518042;5535.861603459945;5543.390227074938;5543.3902270751;5566.304211973504;5568.276124103841;5307.4692530746615;5398.676079435089;5448.45515448452;5448.700321482356;5482.17767334903 15:02:30 INFO - PROCESS | 18716 | |5;yui.html;798.4490701416019;812.6261919517021;830.7881490219993;841.4152164245847;854.9658013679453;13715.588532344033;14745.41018359267;15061.246937653115;15308.46420375287;15310.923445382785;14548.927255363735;14583.416663333453;14602.634934126652;14613.415463381478;14645.487407940724;667.1060778556733;785.3638552772244;804.6620419423856;820.306840719591;830.9418340716152;810.4731924249227;810.793247721833;811.9878201826978;815.559597817178;815.8653822119343;849.087231226431;850.1753299299701;851.4040171879678;852.8848605438279;853.2235665544356;702.2380716922146;812.9065157506903;841.1084250694253;857.2499063319596;858.9656413743505;631.1353445779266;631.8641492079179;632.9683515824237;633.0630666613392;633.2306247908767;13431.126976746578;13474.258915759629;13488.79766803489;13524.526641567596;13531.932340338333;13674;13874.514391996232;13919.721605567933;14120.223387713671;14392.784108238386;12011.579594714143;12205.20666156697;12236.510539578407;12351.567695130718;12388.690282742913;4367.082912588328;4410.360497727844;4419.889502762425;4442.977785111054;4654.069186162781;57782.42217577813;58201.70899145477;58320;58495;60756.392436075075;11263.493142808593;11455.783391641371;11523.539058437736;11542.711432214093;11587;20524.07641656099;20589.485262868548;20597.691034634492;20704.275350362666;20730;8249.628766705513;8256.463329883538;8439.746807595782;8499.36254780894;8581.841451404105;4639.930401043987;4732.6687131900435;4740.241561350167;4760.7619619018915;4930.0139972005745;3273.738100951918;3294.5058241264;3360.327934413127;3362.7309815214726;3365.9495107573407;577.336063526939;583.4165834165834;590.4184378387286;591.7485068845723;600.069891667913;662.5726406467801;673.2268218332049;682.4301708073715;716.2658275267892;720.0818955831252;9284.442933424016;9330.206932410822;9374.484403357881;9390.483523406278;9429.76425589352;617.4874853871365;723.8624661314334;751.6054071612338;753.3784627682074;767.6814122139361;4330.328799036154;4568.269076947672;4577.56513131252;4623.42207224097;4657.767111644404;60211;62594.37405625977;62842;65497.34502655008;69252.653736731;58729.70635146797;58945;59610.70194648999;60326;61008.69495652493;54927.725361373734;55011.72494137504;55427.44572554223;55671.72164139153;56434;9909.847296411546;9981.72920390117;10060.144887684335;10071.34536255141;10072.949635251776;36973.44539831851;36984.445233320985;37237.255254895295;37511.24977500489;37513.624863751014;46988;50123.74938125286;51008.23487647614;51290.23064654108;51742.482575173766;12503.85583649298;12587.685307867376;12812.55156069533;13063.564760939405;13283.601491955256;13855.792163117763;13936;14121.788173177616;14404.063735857137;14480.565583032105;12976.935115324362;13364.665883352605;13366.93316533411;13467;13856.237906915216;11717.941410292893;11980.64058078259;12964.481420743065;13157.53948611794;13981.300934953415;11470.598529051444;11576.826347604961;11629.24409913353;11634.301941883514;11856.881431185579;9947.452890091114;9948.602055917681;10007.491231290804;10018.649347273102;10592.364458132537;9857.260705446977;10160.745981350525;10222.233332500242;10244.64143754965;10263.640772572924 15:02:30 INFO - PROCESS | 18716 | __end_tp_report 15:02:30 INFO - PROCESS | 18716 | __start_cc_report 15:02:30 INFO - PROCESS | 18716 | _x_x_mozilla_cycle_collect,882 15:02:30 INFO - PROCESS | 18716 | __end_cc_report 15:02:30 INFO - PROCESS | 18716 | __startTimestamp1463695350359__endTimestamp 15:02:30 INFO - PROCESS | 18716 | 15:02:30 INFO - PROCESS | 18716 | ------- Summary: start ------- 15:02:30 INFO - PROCESS | 18716 | Number of tests: 6 15:02:30 INFO - PROCESS | 18716 | 15:02:30 INFO - PROCESS | 18716 | [#0] dojo.html Cycles:165 Average:5363.62 Median:5590.36 stddev:616.85 (11.0%) stddev-sans-first:593.01 15:02:30 INFO - PROCESS | 18716 | Values: 3116.3 3124.4 3127.4 3162.7 3171.7 5161.9 5184.7 5304.6 5402.0 5417.5 5377.7 5391.6 5393.2 5434.3 5454.4 4806.5 4864.8 4867.6 4881.8 5059.7 4956.0 4993.2 5013.3 5031.1 5032.8 4771.0 4818.8 4827.9 4863.4 4866.4 4821.2 4919.0 4919.4 4933.6 4963.2 4675.0 4837.3 4890.2 4906.4 4947.2 5302.8 5322.1 5344.1 5350.1 5369.9 5741.9 5772.2 5786.5 5787.9 5797.9 5675.9 5705.3 5708.0 5771.8 5845.9 5442.2 5460.0 5461.0 5463.8 5473.0 5939.2 5944.1 5962.7 5964.5 5971.0 5505.6 5604.9 5647.5 5664.7 5706.1 5722.1 5765.4 5837.5 5837.7 5843.2 5678.6 5679.7 5693.2 5764.8 5771.1 5637.6 5672.2 5690.2 5726.8 5763.7 4379.3 4388.0 4390.6 4391.9 4418.0 3852.3 3868.9 3918.9 3933.9 3965.7 5455.5 5482.8 5500.3 5522.7 5547.6 5823.1 5845.1 5853.8 5870.7 5877.6 5365.3 5398.0 5548.6 5559.0 5571.4 4943.6 4957.4 4975.1 5001.0 5045.8 5972.0 5996.1 5997.3 6002.5 6006.5 5651.7 5776.1 5807.1 5819.9 5824.5 6048.5 6055.2 6057.8 6080.0 6094.9 5720.7 5733.9 5747.4 5752.7 5759.8 5633.2 5667.2 5686.6 5722.9 5839.5 5612.6 5617.7 5625.5 5627.1 5628.4 5573.2 5595.3 5611.2 5617.8 5633.2 5406.3 5529.1 5539.9 5565.2 5596.2 5731.1 5743.6 5770.2 5790.0 5804.0 5478.6 5590.4 5626.0 5641.9 5669.5 15:02:30 INFO - PROCESS | 18716 | 15:02:30 INFO - PROCESS | 18716 | [#1] ext.html Cycles:180 Average:58963.80 Median:42129.08 stddev:110724.42 (262.8%) stddev-sans-first:110948.32 15:02:30 INFO - PROCESS | 18716 | Values: 598.5 631.3 631.7 637.5 650.5 42482.0 44052.0 44228.3 44285.0 47462.8 46342.3 47041.5 47042.3 47081.0 47091.5 8721.2 8895.6 8904.8 8930.1 8939.1 8765.5 8804.4 8856.0 8871.2 8877.1 8833.5 8859.6 8885.8 8886.6 8887.0 8717.6 8778.4 8802.3 8831.3 8833.6 8754.7 8815.0 8842.9 8847.3 8855.6 43397.1 43802.6 43841.3 43845.0 43946.0 3561.8 3728.8 3740.1 3864.2 4124.6 32221.0 32897.2 33086.7 33886.2 33900.7 3694.0 3728.4 3732.5 3756.1 3912.1 350627.0 351447.0 353157.0 353315.2 353506.0 60024.4 60122.7 60215.7 60485.0 60646.0 57685.0 62734.7 63923.7 64418.4 69008.7 16810.6 16819.9 16866.7 16950.7 16958.8 12932.7 13013.0 13029.4 13033.4 13033.7 16245.5 17659.5 18284.0 18418.4 18893.6 6811.5 6812.0 6859.4 6903.6 7046.7 918.6 1029.3 1044.5 1058.2 1087.5 32409.8 32955.5 33015.3 33017.2 33793.0 1115.1 1131.8 1144.8 1146.9 1157.2 16947.8 17150.0 17359.4 17377.7 17450.4 505217.0 506886.0 509181.0 509430.0 509969.0 60876.7 61027.0 61033.0 61060.7 61227.7 1269.2 1367.8 1384.4 1407.0 1407.9 32024.5 34112.0 34133.5 34214.0 34243.5 51276.0 51545.0 52076.0 52103.5 52153.0 377978.0 380946.0 381325.0 381491.0 382276.0 37518.8 42158.8 42254.0 43542.1 43602.3 48547.3 48597.0 49313.8 50372.2 50457.2 40636.6 40869.6 42087.0 42099.4 42418.0 40215.4 40446.8 40842.6 41556.4 41666.0 39957.8 41455.4 42460.0 42460.8 42622.8 36211.8 37313.3 37354.4 37677.2 38653.2 28325.4 28375.6 28550.6 28591.0 28700.7 15:02:30 INFO - PROCESS | 18716 | 15:02:30 INFO - PROCESS | 18716 | [#2] jquery.html Cycles:180 Average:28256.25 Median:23231.15 stddev:76683.10 (330.1%) stddev-sans-first:76869.68 15:02:30 INFO - PROCESS | 18716 | Values: 397.4 398.9 404.4 408.7 422.3 18075.3 19617.3 19656.3 19971.7 20697.7 18898.1 19262.8 19415.5 19778.4 19831.5 5632.2 5664.5 5794.0 5808.3 5809.8 5531.8 5683.8 5685.3 5689.1 5713.5 5520.7 5535.8 5689.2 5691.8 5714.7 5599.8 5610.7 5643.3 5648.2 5661.5 4979.4 5090.3 5120.0 5126.3 5134.6 22761.3 22910.1 23202.0 23206.9 23255.4 2363.7 2417.0 2438.0 2494.9 2825.7 14092.5 14406.4 14643.4 14932.9 15147.7 1956.8 1981.9 2006.7 2095.8 2203.1 68071.0 70822.3 71418.6 77111.0 83282.0 10831.5 11070.6 11141.3 11384.2 11435.1 15502.8 15766.7 15777.9 15806.4 15810.4 7570.7 7701.7 7710.5 7807.7 7890.2 7020.9 7088.9 7167.0 7232.3 7269.3 4679.6 4756.7 4785.9 4801.3 4831.3 1925.6 1930.3 1981.7 2001.2 2005.1 952.2 990.7 1003.5 1095.7 1109.4 18744.3 19448.7 19481.8 19571.3 19607.3 994.3 1011.6 1016.5 1033.9 1038.3 10542.8 10575.4 10638.0 11146.0 11162.9 453675.0 454994.0 464728.0 465377.0 487286.0 68055.0 88363.6 92910.0 96947.0 98240.0 1013.7 1018.5 1052.5 1063.2 1079.0 17299.5 17874.1 17927.6 17967.8 18334.2 43235.8 43610.3 43733.4 43964.6 44367.8 52473.7 52788.0 55558.7 63053.4 63201.7 8410.8 8802.1 8827.2 8967.8 9045.7 12363.6 13110.0 13619.9 13857.6 13921.9 11756.7 12015.0 12147.9 12175.5 12342.5 11793.0 11793.5 11803.2 11914.8 11961.5 12215.1 12243.9 12357.6 12518.0 12552.4 7487.9 8860.4 8972.3 9034.3 9044.1 10890.6 11500.0 11558.1 11571.4 11583.7 15:02:30 INFO - PROCESS | 18716 | 15:02:30 INFO - PROCESS | 18716 | [#3] mootools.html Cycles:180 Average:5505.67 Median:5035.48 stddev:3065.25 (60.9%) stddev-sans-first:3057.82 15:02:30 INFO - PROCESS | 18716 | Values: 1334.7 1501.6 1519.8 1693.8 1815.2 7692.0 7958.0 7986.4 8023.6 8176.3 7775.7 7983.2 8173.6 8209.5 8214.5 2022.2 2256.8 2319.5 2331.7 2361.3 2369.5 2379.2 2381.2 2381.7 2382.0 2327.1 2375.3 2380.9 2381.2 2381.8 1960.3 2258.8 2330.4 2331.5 2350.2 2243.9 2260.6 2265.1 2273.0 2279.6 8169.4 8242.2 8253.8 8258.1 8259.8 5064.3 5157.7 5172.1 5204.6 5204.9 3126.1 3258.5 3263.2 3282.4 3333.5 1026.6 1051.3 1055.3 1067.6 1068.3 11229.8 11483.3 11491.3 11501.6 11529.7 4590.6 4634.2 4664.6 4678.5 4704.4 9920.1 9920.2 9926.0 9928.7 9952.6 4505.4 5225.5 5245.1 5247.0 5249.4 4654.2 4785.6 4847.8 4856.3 4873.6 3810.3 3884.9 3905.7 3962.6 3974.3 1271.1 1300.0 1307.3 1307.8 1322.6 981.8 991.4 992.0 994.5 996.5 5772.6 5877.9 5953.2 5959.4 6074.2 476.1 477.7 482.1 485.9 489.7 3876.8 3893.6 3982.9 3995.2 4015.9 9862.7 10204.5 10343.6 10344.4 10357.7 10225.9 10231.5 10257.1 10348.9 10351.8 7477.6 7769.3 7799.0 7839.7 7899.4 5733.9 5786.6 5831.7 5945.0 5979.2 9198.7 9480.7 9536.7 9584.6 9591.8 9628.9 9726.4 9738.4 9785.5 9889.2 6623.9 6986.9 7115.8 7471.5 7627.8 7850.5 7863.7 7865.4 7922.6 7925.4 6973.8 7163.7 7187.4 7283.1 7320.6 6997.5 7000.7 7048.4 7061.1 7160.9 6296.8 6405.5 6420.4 6430.3 6431.1 4594.1 4676.3 4720.4 4729.1 4796.2 5006.6 5096.3 5157.6 5164.0 5271.7 15:02:30 INFO - PROCESS | 18716 | 15:02:30 INFO - PROCESS | 18716 | [#4] prototype.html Cycles:180 Average:4540.26 Median:5059.41 stddev:1335.55 (26.4%) stddev-sans-first:1301.10 15:02:30 INFO - PROCESS | 18716 | Values: 314.8 318.4 324.6 334.0 336.2 5022.2 5148.8 5157.9 5270.8 5282.3 5150.4 5172.9 5190.6 5222.0 5232.1 4042.8 4053.7 4077.7 4081.7 4086.9 3891.9 3907.9 4041.4 4067.2 4077.2 4019.4 4041.5 4062.6 4067.9 4067.9 3995.3 3999.5 4025.3 4043.4 4064.2 3503.5 3603.4 3607.7 3611.7 3623.7 5007.8 5013.9 5022.5 5025.2 5060.9 4602.3 4608.4 4624.9 4625.5 4642.7 5057.9 5399.3 5425.9 5443.7 5450.3 3924.4 3932.6 3936.6 3945.2 3954.3 5599.5 5612.8 5612.9 5638.4 5642.2 3973.1 4002.4 4003.2 4023.5 4024.2 3968.8 4067.0 4095.5 4109.7 4114.8 4577.2 4586.3 4594.7 4615.2 4625.3 5394.9 5425.2 5431.4 5437.0 5470.6 1307.3 1360.2 1388.9 1402.7 1417.7 891.8 896.4 906.2 912.1 913.7 4598.4 4634.3 4674.9 4678.2 4681.6 4881.9 4888.5 4911.8 4923.5 4924.3 4626.8 4637.5 4681.6 4686.8 4708.7 2712.4 3009.6 3016.5 3038.8 3040.8 5795.9 5799.5 5799.7 5813.4 5862.7 5444.3 5666.2 5673.5 5712.4 5718.6 5755.0 5793.4 5811.5 5817.8 5818.7 5532.5 5607.3 5616.4 5623.6 5625.7 5353.3 5524.8 5589.4 5594.5 5601.7 5748.5 5771.6 5777.1 5807.9 5820.3 3765.7 3969.0 3973.7 3993.9 3998.6 5191.9 5630.3 5639.6 5654.8 5673.8 5459.6 5471.5 5492.8 5493.5 5507.7 5259.5 5432.0 5437.7 5446.4 5458.8 5246.8 5307.5 5369.9 5383.9 5421.7 5535.9 5543.4 5543.4 5566.3 5568.3 5307.5 5398.7 5448.5 5448.7 5482.2 15:02:30 INFO - PROCESS | 18716 | 15:02:30 INFO - PROCESS | 18716 | [#5] yui.html Cycles:180 Average:15650.39 Median:25822.88 stddev:18470.17 (71.5%) stddev-sans-first:18488.31 15:02:30 INFO - PROCESS | 18716 | Values: 798.4 812.6 830.8 841.4 855.0 13715.6 14745.4 15061.2 15308.5 15310.9 14548.9 14583.4 14602.6 14613.4 14645.5 667.1 785.4 804.7 820.3 830.9 810.5 810.8 812.0 815.6 815.9 849.1 850.2 851.4 852.9 853.2 702.2 812.9 841.1 857.2 859.0 631.1 631.9 633.0 633.1 633.2 13431.1 13474.3 13488.8 13524.5 13531.9 13674.0 13874.5 13919.7 14120.2 14392.8 12011.6 12205.2 12236.5 12351.6 12388.7 4367.1 4410.4 4419.9 4443.0 4654.1 57782.4 58201.7 58320.0 58495.0 60756.4 11263.5 11455.8 11523.5 11542.7 11587.0 20524.1 20589.5 20597.7 20704.3 20730.0 8249.6 8256.5 8439.7 8499.4 8581.8 4639.9 4732.7 4740.2 4760.8 4930.0 3273.7 3294.5 3360.3 3362.7 3365.9 577.3 583.4 590.4 591.7 600.1 662.6 673.2 682.4 716.3 720.1 9284.4 9330.2 9374.5 9390.5 9429.8 617.5 723.9 751.6 753.4 767.7 4330.3 4568.3 4577.6 4623.4 4657.8 60211.0 62594.4 62842.0 65497.3 69252.7 58729.7 58945.0 59610.7 60326.0 61008.7 54927.7 55011.7 55427.4 55671.7 56434.0 9909.8 9981.7 10060.1 10071.3 10072.9 36973.4 36984.4 37237.3 37511.2 37513.6 46988.0 50123.7 51008.2 51290.2 51742.5 12503.9 12587.7 12812.6 13063.6 13283.6 13855.8 13936.0 14121.8 14404.1 14480.6 12976.9 13364.7 13366.9 13467.0 13856.2 11717.9 11980.6 12964.5 13157.5 13981.3 11470.6 11576.8 11629.2 11634.3 11856.9 9947.5 9948.6 10007.5 10018.6 10592.4 9857.3 10160.7 10222.2 10244.6 10263.6 15:02:30 INFO - PROCESS | 18716 | -------- Summary: end -------- 15:02:30 INFO - PROCESS | 18716 | 15:02:31 INFO - TEST-INFO | 18716: exit 0 15:02:31 INFO - TEST-OK | dromaeo_css | took 1112317ms 15:02:31 INFO - TEST-START | kraken 15:02:31 INFO - operating with platform_type : linux_ 15:02:31 INFO - Initialising browser for kraken test... 15:02:31 INFO - TEST-INFO | started process 18894 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ0PL1h/profile http://localhost:59937/getInfo.html) 15:02:35 INFO - PROCESS | 18894 | __metrics Screen width/height:1600/1200 15:02:35 INFO - PROCESS | 18894 | colorDepth:24 15:02:35 INFO - PROCESS | 18894 | Browser inner width/height: 1024/697 15:02:35 INFO - PROCESS | 18894 | __metrics 15:02:36 ERROR - PROCESS | 18894 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:02:36 INFO - TEST-INFO | 18894: exit 0 15:02:36 INFO - Browser initialized. 15:02:36 INFO - Running cycle 1/1 for kraken test... 15:02:36 INFO - TEST-INFO | started process 18978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ0PL1h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:48 INFO - PROCESS | 18978 | RSS: Main: 153116672 15:02:48 INFO - PROCESS | 18978 | 15:02:51 INFO - PROCESS | 18978 | Cycle 1(1): loaded http://localhost:59937/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59937/tests/kraken/driver.html?testName=audio-beat-detection) 15:02:52 INFO - PROCESS | 18978 | RSS: Main: 209772544 15:02:52 INFO - PROCESS | 18978 | 15:02:54 INFO - PROCESS | 18978 | Cycle 1(1): loaded http://localhost:59937/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59937/tests/kraken/driver.html?testName=audio-dft) 15:02:55 INFO - PROCESS | 18978 | RSS: Main: 198447104 15:02:55 INFO - PROCESS | 18978 | 15:02:58 INFO - PROCESS | 18978 | Cycle 1(1): loaded http://localhost:59937/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59937/tests/kraken/driver.html?testName=audio-fft) 15:02:59 INFO - PROCESS | 18978 | RSS: Main: 266059776 15:02:59 INFO - PROCESS | 18978 | 15:03:01 INFO - PROCESS | 18978 | Cycle 1(1): loaded http://localhost:59937/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59937/tests/kraken/driver.html?testName=audio-oscillator) 15:03:02 INFO - PROCESS | 18978 | RSS: Main: 175116288 15:03:02 INFO - PROCESS | 18978 | 15:03:04 INFO - PROCESS | 18978 | Cycle 1(1): loaded http://localhost:59937/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59937/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:03:04 INFO - PROCESS | 18978 | RSS: Main: 179769344 15:03:04 INFO - PROCESS | 18978 | 15:03:08 INFO - PROCESS | 18978 | Cycle 1(1): loaded http://localhost:59937/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59937/tests/kraken/driver.html?testName=imaging-darkroom) 15:03:08 INFO - PROCESS | 18978 | RSS: Main: 215166976 15:03:08 INFO - PROCESS | 18978 | 15:03:12 INFO - PROCESS | 18978 | Cycle 1(1): loaded http://localhost:59937/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59937/tests/kraken/driver.html?testName=imaging-desaturate) 15:03:12 INFO - PROCESS | 18978 | RSS: Main: 213143552 15:03:12 INFO - PROCESS | 18978 | 15:03:15 INFO - PROCESS | 18978 | Cycle 1(1): loaded http://localhost:59937/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59937/tests/kraken/driver.html?testName=json-parse-financial) 15:03:16 INFO - PROCESS | 18978 | RSS: Main: 214695936 15:03:16 INFO - PROCESS | 18978 | 15:03:18 INFO - PROCESS | 18978 | Cycle 1(1): loaded http://localhost:59937/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59937/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:03:18 INFO - PROCESS | 18978 | RSS: Main: 202887168 15:03:18 INFO - PROCESS | 18978 | 15:03:20 INFO - PROCESS | 18978 | Cycle 1(1): loaded http://localhost:59937/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59937/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:03:21 INFO - PROCESS | 18978 | RSS: Main: 205864960 15:03:21 INFO - PROCESS | 18978 | 15:03:23 INFO - PROCESS | 18978 | Cycle 1(1): loaded http://localhost:59937/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59937/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:03:24 INFO - PROCESS | 18978 | RSS: Main: 215793664 15:03:24 INFO - PROCESS | 18978 | 15:03:26 INFO - PROCESS | 18978 | Cycle 1(1): loaded http://localhost:59937/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:03:27 INFO - PROCESS | 18978 | RSS: Main: 225284096 15:03:27 INFO - PROCESS | 18978 | 15:03:30 INFO - PROCESS | 18978 | Cycle 1(1): loaded http://localhost:59937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:03:30 INFO - PROCESS | 18978 | RSS: Main: 221974528 15:03:30 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | Cycle 1(1): loaded http://localhost:59937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59937/tests/kraken/driver.html?testName=ai-astar) 15:03:32 INFO - PROCESS | 18978 | RSS: Main: 267755520 15:03:32 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | __start_tp_report 15:03:32 INFO - PROCESS | 18978 | _x_x_mozilla_page_load 15:03:32 INFO - PROCESS | 18978 | _x_x_mozilla_page_load_details 15:03:32 INFO - PROCESS | 18978 | |i|pagename|runs| 15:03:32 INFO - PROCESS | 18978 | |0;ai-astar;112;106;110;110;110;110;110;110;110;110 15:03:32 INFO - PROCESS | 18978 | |1;audio-beat-detection;162;126;169;207;126;153;156;126;184;126 15:03:32 INFO - PROCESS | 18978 | |2;audio-dft;161;161;162;161;161;162;162;163;163;161 15:03:32 INFO - PROCESS | 18978 | |3;audio-fft;75;75;77;155;76;74;77;75;133;76 15:03:32 INFO - PROCESS | 18978 | |4;audio-oscillator;92;93;150;92;93;94;122;92;93;131 15:03:32 INFO - PROCESS | 18978 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 15:03:32 INFO - PROCESS | 18978 | |6;imaging-darkroom;146;146;145;146;144;146;146;147;146;146 15:03:32 INFO - PROCESS | 18978 | |7;imaging-desaturate;94;96;96;95;95;95;95;95;95;95 15:03:32 INFO - PROCESS | 18978 | |8;json-parse-financial;54;53;55;55;57;55;55;107;52;64 15:03:32 INFO - PROCESS | 18978 | |9;json-stringify-tinderbox;63;62;62;61;63;62;62;62;62;62 15:03:32 INFO - PROCESS | 18978 | |10;stanford-crypto-aes;82;79;79;79;80;81;79;82;79;79 15:03:32 INFO - PROCESS | 18978 | |11;stanford-crypto-ccm;130;123;127;123;124;117;121;123;190;125 15:03:32 INFO - PROCESS | 18978 | |12;stanford-crypto-pbkdf2;159;160;161;160;159;160;161;160;160;161 15:03:32 INFO - PROCESS | 18978 | |13;stanford-crypto-sha256-iterative;63;69;64;65;63;64;63;70;63;63 15:03:32 INFO - PROCESS | 18978 | __end_tp_report 15:03:32 INFO - PROCESS | 18978 | __start_cc_report 15:03:32 INFO - PROCESS | 18978 | _x_x_mozilla_cycle_collect,1900 15:03:32 INFO - PROCESS | 18978 | __end_cc_report 15:03:32 INFO - PROCESS | 18978 | __startTimestamp1463695412655__endTimestamp 15:03:32 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | ------- Summary: start ------- 15:03:32 INFO - PROCESS | 18978 | Number of tests: 14 15:03:32 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:1.48 (1.3%) stddev-sans-first:1.33 15:03:32 INFO - PROCESS | 18978 | Values: 112.0 106.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 15:03:32 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:159.00 stddev:28.16 (17.7%) stddev-sans-first:29.70 15:03:32 INFO - PROCESS | 18978 | Values: 162.0 126.0 169.0 207.0 126.0 153.0 156.0 126.0 184.0 126.0 15:03:32 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 15:03:32 INFO - PROCESS | 18978 | Values: 161.0 161.0 162.0 161.0 161.0 162.0 162.0 163.0 163.0 161.0 15:03:32 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | [#3] audio-fft Cycles:10 Average:89.30 Median:75.50 stddev:29.31 (38.8%) stddev-sans-first:30.62 15:03:32 INFO - PROCESS | 18978 | Values: 75.0 75.0 77.0 155.0 76.0 74.0 77.0 75.0 133.0 76.0 15:03:32 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:92.50 stddev:21.21 (22.9%) stddev-sans-first:21.95 15:03:32 INFO - PROCESS | 18978 | Values: 92.0 93.0 150.0 92.0 93.0 94.0 122.0 92.0 93.0 131.0 15:03:32 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 15:03:32 INFO - PROCESS | 18978 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 15:03:32 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 15:03:32 INFO - PROCESS | 18978 | Values: 146.0 146.0 145.0 146.0 144.0 146.0 146.0 147.0 146.0 146.0 15:03:32 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 15:03:32 INFO - PROCESS | 18978 | Values: 94.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 15:03:32 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:55.00 stddev:16.59 (30.2%) stddev-sans-first:17.42 15:03:32 INFO - PROCESS | 18978 | Values: 54.0 53.0 55.0 55.0 57.0 55.0 55.0 107.0 52.0 64.0 15:03:32 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 15:03:32 INFO - PROCESS | 18978 | Values: 63.0 62.0 62.0 61.0 63.0 62.0 62.0 62.0 62.0 62.0 15:03:32 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.50 stddev:1.29 (1.6%) stddev-sans-first:1.12 15:03:32 INFO - PROCESS | 18978 | Values: 82.0 79.0 79.0 79.0 80.0 81.0 79.0 82.0 79.0 79.0 15:03:32 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:124.50 stddev:21.26 (17.1%) stddev-sans-first:22.54 15:03:32 INFO - PROCESS | 18978 | Values: 130.0 123.0 127.0 123.0 124.0 117.0 121.0 123.0 190.0 125.0 15:03:32 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 15:03:32 INFO - PROCESS | 18978 | Values: 159.0 160.0 161.0 160.0 159.0 160.0 161.0 160.0 160.0 161.0 15:03:32 INFO - PROCESS | 18978 | 15:03:32 INFO - PROCESS | 18978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:64.00 stddev:2.63 (4.1%) stddev-sans-first:2.71 15:03:32 INFO - PROCESS | 18978 | Values: 63.0 69.0 64.0 65.0 63.0 64.0 63.0 70.0 63.0 63.0 15:03:32 INFO - PROCESS | 18978 | -------- Summary: end -------- 15:03:32 INFO - PROCESS | 18978 | 15:03:33 INFO - TEST-INFO | 18978: exit 0 15:03:33 INFO - TEST-OK | kraken | took 62539ms 15:03:33 INFO - SUITE-END | took 1174s 15:03:33 INFO - Completed test suite (00:19:34) 15:03:33 INFO - javascript benchmark 15:03:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.3455674308393, 3124.3751249750057, 3127.358891427257, 3162.667919868415, 3171.730402915752, 5161.870953226162, 5184.7407629618465, 5304.575633949285, 5401.972990135048, 5417.512423881854, 5377.677339359641, 5391.595630327722, 5393.19102134679, 5434.266374039504, 5454.372747134081, 4806.495317991613, 4864.781084851173, 4867.561919427251, 4881.780319885614, 5059.671121377099, 4956.0, 4993.176125939216, 5013.298138260647, 5031.119554078022, 5032.82385116521, 4771.0, 4818.783154758027, 4827.927581086286, 4863.367762190893, 4866.367372241586, 4821.228603423436, 4918.950810491885, 4919.360483137205, 4933.605311575066, 4963.205887058053, 4674.976625116887, 4837.250226214942, 4890.193118135503, 4906.435759887588, 4947.158982972904, 5302.840914772563, 5322.148456246982, 5344.14493681013, 5350.090484617585, 5369.9463005369835, 5741.885162296772, 5772.163036359704, 5786.450287222707, 5787.942120578782, 5797.913031304533, 5675.914861277084, 5705.315362156526, 5707.971460142714, 5771.797987070432, 5845.883082338372, 5442.156465747816, 5460.0, 5461.017016936949, 5463.754131064072, 5473.042217611942, 5939.198208241832, 5944.078667806497, 5962.731677074542, 5964.522838172936, 5971.0, 5505.587080968943, 5604.85987850307, 5647.491725744702, 5664.745086471119, 5706.087026075808, 5722.084466485342, 5765.394633563499, 5837.532997360201, 5837.737301821428, 5843.18195452637, 5678.630888992202, 5679.744411501492, 5693.231413759172, 5764.769409223584, 5771.105478650816, 5637.605367624227, 5672.234248376499, 5690.174924635905, 5726.79956201531, 5763.740631671585, 4379.343098535245, 4387.978060109679, 4390.62679672225, 4391.8682439526865, 4417.977910110429, 3852.3451013327804, 3868.9226215475533, 3918.921621567553, 3933.9134419501534, 3965.6629186518894, 5455.536279416215, 5482.780688772485, 5500.339959204921, 5522.723863806794, 5547.55619550435, 5823.126531020381, 5845.123231515222, 5853.795117170878, 5870.73581688825, 5877.559183061202, 5365.275687782178, 5398.0, 5548.639338442988, 5559.0, 5571.359293681197, 4943.604511639061, 4957.355543779286, 4975.129352363322, 5001.0, 5045.823396181189, 5972.0, 5996.1005849122985, 5997.340292567814, 6002.54980876436, 6006.489448396847, 5651.689157096399, 5776.075827867521, 5807.0998995155815, 5819.912701309569, 5824.504917082096, 6048.455638992512, 6055.1522786810765, 6057.757689692363, 6079.969600151971, 6094.939050609614, 5720.656760594377, 5733.942660573341, 5747.396523365153, 5752.654840709571, 5759.827205183851, 5633.183188437735, 5667.20659107717, 5686.601937864475, 5722.942770572241, 5839.474447299764, 5612.607117501736, 5617.747201375866, 5625.549956003591, 5627.071533196977, 5628.352739434854, 5573.21974923503, 5595.328560572757, 5611.158326251095, 5617.775288988395, 5633.2113504110275, 5406.2971813665545, 5529.087700529529, 5539.944600553943, 5565.248691426606, 5596.188552659923, 5731.054376028075, 5743.59794814359, 5770.163326317745, 5790.044642633919, 5804.042333015174, 5478.643888147258, 5590.357108932525, 5626.0, 5641.915371269516, 5669.546436285004], "value": 5321.641499518364, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.5271635408028, 631.2803404119305, 631.6715308039817, 637.5059329020011, 650.5381179362653, 42482.0, 44052.0, 44228.336574951405, 44285.0, 47462.76268618661, 46342.30486542696, 47041.52958470414, 47042.294365584545, 47081.0, 47091.529084709146, 8721.215090641841, 8895.644174233055, 8904.821903561924, 8930.062343453941, 8939.106089391074, 8765.474071555727, 8804.427712198718, 8856.025837157908, 8871.245944094728, 8877.067907869645, 8833.514156721378, 8859.645614175426, 8885.822283554326, 8886.60010299538, 8887.0, 8717.607707653107, 8778.385513014091, 8802.295816334678, 8831.293496520295, 8833.55832208387, 8754.68679698044, 8814.955925220396, 8842.867356989651, 8847.33644976623, 8855.645774169025, 43397.13205735868, 43802.561974380485, 43841.34237986433, 43845.0, 43946.0, 3561.8397172127056, 3728.813559322023, 3740.1397678533817, 3864.227154569069, 4124.608162224614, 32221.0, 32897.177570560685, 33086.66913330884, 33886.1528461788, 33900.660993389996, 3693.9630603693886, 3728.4034554471154, 3732.533433320835, 3756.1173124315765, 3912.100216950089, 350627.0, 351447.0, 353157.0, 353315.2334238338, 353506.0, 60024.39975600276, 60122.69938650279, 60215.69892150599, 60485.0, 60646.0, 57685.0, 62734.68632656899, 63923.68038159779, 64418.35581644217, 69008.6549567249, 16810.56246844225, 16819.91590042042, 16866.746998795028, 16950.660986780444, 16958.830411695973, 12932.676683082998, 13013.0, 13029.413676384585, 13033.413496392684, 13033.739325213442, 16245.51263462098, 17659.470215893543, 18284.0, 18418.447446576625, 18893.622127557373, 6811.489138314646, 6812.0, 6859.382655560924, 6903.585784852925, 7046.718131274794, 918.554501066982, 1029.2692188546066, 1044.4882007816116, 1058.222206678091, 1087.521490544158, 32409.837950810095, 32955.50566741501, 33015.339693206, 33017.17457063593, 33792.98621041373, 1115.1023426142033, 1131.7736452709491, 1144.759600483891, 1146.925449845774, 1157.1841851494676, 16947.830521694872, 17150.0, 17359.392421265195, 17377.73933391, 17450.389236376664, 505217.0, 506886.0, 509181.0, 509430.0, 509969.0, 60876.69561652163, 61027.0, 61033.0, 61060.69469652623, 61227.69386153041, 1269.1560112525067, 1367.8153449284218, 1384.3631929312628, 1406.9788953165505, 1407.9225642589552, 32024.519632206, 34111.9685367811, 34133.48799767956, 34214.0, 34243.4863477053, 51276.0, 51545.0, 52076.0, 52103.478965211376, 52153.0, 377978.0, 380946.0, 381325.0, 381491.0, 382276.0, 37518.812405937795, 42158.78920605377, 42254.0, 43542.12915741731, 43602.34596481119, 48547.27179092246, 48597.0, 49313.75343123262, 50372.24441633452, 50457.24314135218, 40636.59363406328, 40869.59130408658, 42087.0, 42099.36850947177, 42418.0, 40215.396769049075, 40446.79776601098, 40842.591574083875, 41556.3766543496, 41666.0, 39957.80021099876, 41455.37816932688, 42460.0, 42460.78769606256, 42622.78688606537, 36211.81894090618, 37313.25373492569, 37354.43968340423, 37677.24645507129, 38653.226935461695, 28325.43349133047, 28375.57436638411, 28550.57174142431, 28591.0, 28700.712992869805], "value": 20477.793264969943, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.4455634390026, 398.9062570295982, 404.4418702190976, 408.72411122492326, 422.33060598950664, 18075.276988920443, 19617.31339403121, 19656.312029078985, 19971.700424493607, 20697.68953465699, 18898.14958326875, 19262.807371926276, 19415.51461213467, 19778.406647800588, 19831.5042123947, 5632.211490391349, 5664.54683625311, 5793.971030144843, 5808.273965754281, 5809.82570522885, 5531.778728850841, 5683.801066962657, 5685.317761868581, 5689.146628005791, 5713.485786279234, 5520.723963801794, 5535.750891209906, 5689.2319536862615, 5691.800786972457, 5714.685692286923, 5599.832005039835, 5610.66336019836, 5643.322801263834, 5648.181013752983, 5661.46216109469, 4979.377577802775, 5090.261912022736, 5119.974400128012, 5126.256692779526, 5134.614903882224, 22761.31716048521, 22910.083596656114, 23202.0, 23206.883965580233, 23255.418614534603, 2363.72817126031, 2417.045267119478, 2438.0369753947093, 2494.887730052152, 2825.7456828885497, 14092.506762263374, 14406.423743050265, 14643.41426342945, 14932.925335373362, 15147.697046059016, 1956.7847536770944, 1981.8909959952198, 2006.668899631559, 2095.800898914616, 2203.1187524989973, 68071.0, 70822.29177708208, 71418.64290678565, 77111.0, 83282.0, 10831.514189323247, 11070.557177712963, 11141.331520108819, 11384.203105782515, 11435.14236432271, 15502.767458488132, 15766.68466630661, 15777.921110394604, 15806.446774362843, 15810.446634367972, 7570.697172113054, 7701.691932322644, 7710.460267781202, 7807.687692492236, 7890.210978902179, 7020.859582808315, 7088.929110708827, 7167.0, 7232.312930271616, 7269.273072692794, 4679.555442233051, 4756.667033307635, 4785.904281914342, 4801.279808028824, 4831.275308703723, 1925.6245032218583, 1930.3147382679228, 1981.7027445883232, 2001.1595130045125, 2005.1177481907914, 952.2286947572488, 990.7225976726528, 1003.4932359158578, 1095.6986828622194, 1109.389835590422, 18744.25022999065, 19448.70826937597, 19481.805181948, 19571.315003974792, 19607.31374401889, 994.2940512236394, 1011.6155860772859, 1016.5120742043861, 1033.9069483746498, 1038.3302769713493, 10542.841857372145, 10575.41835199056, 10638.042576168182, 11146.0, 11162.88816157113, 453675.0, 454994.0, 464728.0, 465377.0, 487286.0, 68055.0, 88363.55818220996, 92910.0, 96947.0, 98240.0, 1013.7060252526832, 1018.4500369800224, 1052.494802494807, 1063.186662203415, 1078.9730256743644, 17299.481015569552, 17874.106294685473, 17927.551811204823, 17967.82032179714, 18334.174962126468, 43235.783821080695, 43610.34584481299, 43733.37599744026, 43964.560354396046, 44367.77816110899, 52473.7376313116, 52788.0, 55558.72220638871, 63053.36946630475, 63201.683991579746, 8410.789730256793, 8802.07578204305, 8827.16141966512, 8967.775805604912, 9045.68340108093, 12363.567275145328, 13110.0, 13619.863801362257, 13857.584272471842, 13921.930390347983, 11756.70608234801, 12015.0, 12147.878521214674, 12175.538935327817, 12342.50629974827, 11793.0, 11793.469293881968, 11803.173777835813, 11914.761704765682, 11961.521539138337, 12215.144939854124, 12243.938780306042, 12357.629271121881, 12518.0, 12552.372381381078, 7487.925120748941, 8860.424072435271, 8972.28221742246, 9034.277257819227, 9044.057351589254, 10890.61882834097, 11500.0, 11558.133140014364, 11571.363575003455, 11583.6524904253], "value": 9338.35762045968, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.6663334166458, 1501.5870635575216, 1519.756838905775, 1693.7967443906732, 1815.1559524820955, 7691.961540192298, 7958.0450345958425, 7986.361091112712, 8023.598820059003, 8176.264136227738, 7775.688972441096, 7983.161768014362, 8173.632186551605, 8209.50742955423, 8214.466059706116, 2022.2214447437768, 2256.7630398808137, 2319.4549280918973, 2331.743508214095, 2361.3034154924253, 2369.490559529701, 2379.2267513058237, 2381.226101517005, 2381.7022872140983, 2381.9642705359433, 2327.0575416956076, 2375.3349062262596, 2380.8928598213033, 2381.226101517005, 2381.833271670984, 1960.3334866145508, 2258.762829902853, 2330.4057465346395, 2331.5103828196097, 2350.2361732436857, 2243.8541494802785, 2260.5704916065893, 2265.0600000999566, 2272.988635056831, 2279.623862062758, 8169.387295952827, 8242.216989386, 8253.752387428387, 8258.050324212672, 8259.752207433787, 5064.3163172971545, 5157.69053856766, 5172.094883395428, 5204.5576126028955, 5204.895902081975, 3126.093432904455, 3258.478643417042, 3263.216827961296, 3282.4255755242975, 3333.483310086916, 1026.5893642542967, 1051.3113910388709, 1055.2929537210089, 1067.5729708116814, 1068.316277582348, 11229.775404491946, 11483.311001339864, 11491.310521368745, 11501.5974440895, 11529.654110376701, 4590.563896429834, 4634.235351167087, 4664.626829853603, 4678.50875658051, 4704.3649107370065, 9920.107190352903, 9920.206383489303, 9926.0, 9928.702138935843, 9952.552135153936, 4505.43682039745, 5225.451327610622, 5245.082110630625, 5247.0, 5249.448807875195, 4654.208784506642, 4785.569298763128, 4847.830325938575, 4856.271559266068, 4873.561379475864, 3810.256999884996, 3884.941725874114, 3905.711115331934, 3962.623550762673, 3974.344233201547, 1271.0848189303686, 1299.9805002924963, 1307.3071272225736, 1307.7580647580228, 1322.5635540271687, 981.7692842182081, 991.4101109839634, 991.9553620087113, 994.4928086675848, 996.5166894056376, 5772.595918285764, 5877.853053673607, 5953.196318497034, 5959.40077293921, 6074.210352654215, 476.08591504311806, 477.6513145403805, 482.10088185534426, 485.8639580917349, 489.6645797628636, 3876.7673939563715, 3893.552241492265, 3982.9203415932097, 3995.2409042281874, 4015.9196816063513, 9862.65480708186, 10204.489775511194, 10343.586256549805, 10344.37933723979, 10357.74105647365, 10225.948870255601, 10231.488425578691, 10257.076863082359, 10348.948255258827, 10351.792964140675, 7477.626118694044, 7769.300762931363, 7799.0, 7839.686412543549, 7899.407544434191, 5733.913991290051, 5786.594938354275, 5831.70841457917, 5945.048792193401, 5979.192808970907, 9198.67804626835, 9480.668176613786, 9536.713898583053, 9584.568694408628, 9591.808163836544, 9628.9037109628, 9726.36778609388, 9738.367006144861, 9785.461799601091, 9889.159421449258, 6623.900641490285, 6986.930130698628, 7115.82210444743, 7471.514351567131, 7627.809304767426, 7850.450468467153, 7863.685452581833, 7865.449418540876, 7922.564258965812, 7925.405594580314, 6973.79078627642, 7163.7492687755675, 7187.389071928736, 7283.053203083565, 7320.63396830167, 6997.545159564612, 7000.684969176297, 7048.400885924754, 7061.1173603299585, 7160.8925866113095, 6296.842578935563, 6405.487560995016, 6420.357964203542, 6430.324815894451, 6431.067495213261, 4594.058218065222, 4676.251799712166, 4720.409948756405, 4729.148753224315, 4796.160671882476, 5006.6495345325475, 5096.3374761282275, 5157.613179011664, 5163.974180129226, 5271.736413179249], "value": 4393.17546068761, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.82841851191085, 318.43795700588464, 324.56508278906267, 334.0013360053441, 336.1998443703984, 5022.221555658879, 5148.794048238066, 5157.922631160531, 5270.815521456745, 5282.260483532304, 5150.381954165506, 5172.948270517303, 5190.610704197182, 5221.973890130544, 5232.110541207994, 4042.7574345539215, 4053.695972802037, 4077.67378609712, 4081.673466122703, 4086.9182616347657, 3891.8832435026993, 3907.921841563167, 4041.4139949707273, 4067.2475592015426, 4077.2049450357194, 4019.3769965655224, 4041.454403655513, 4062.593740625943, 4067.877963661095, 4067.9389809152885, 3995.262061003473, 3999.5400528939253, 4025.2754504189234, 4043.353063509824, 4064.248114098901, 3503.527023851773, 3603.40543810271, 3607.7474576779373, 3611.693006094485, 3623.728220383455, 5007.84819491519, 5013.949860501421, 5022.497750224985, 5025.1708468102715, 5060.873478163038, 4602.332661764025, 4608.400907881987, 4624.861254162381, 4625.49671356807, 4642.675012749109, 5057.9494205057845, 5399.325084364455, 5425.945740542623, 5443.700596467193, 5450.291462109901, 3924.3917192835156, 3932.646061854447, 3936.5866584008554, 3945.171513982067, 3954.3475326571083, 5599.496045355938, 5612.765191657829, 5612.915806262909, 5638.40796716343, 5642.210090587321, 3973.145773658677, 4002.399640054015, 4003.219372222447, 4023.4769479968004, 4024.215278020816, 3968.8214030368704, 4066.9832541864535, 4095.508538975342, 4109.650679692199, 4114.753114813121, 4577.22187228172, 4586.312053192048, 4594.724316540952, 4615.1616755695, 4625.283081122364, 5394.892102158014, 5425.186222066722, 5431.402545719968, 5436.972815135899, 5470.56235501159, 1307.2809954525164, 1360.177092858826, 1388.854170312123, 1402.719456108762, 1417.6739349949569, 891.821635672855, 896.3770179725159, 906.1663269791808, 912.1425859691868, 913.7395842185078, 4598.425196850394, 4634.281686338623, 4674.859754207379, 4678.2280923647895, 4681.6020638245445, 4881.9023619528125, 4888.509004753584, 4911.8280860169725, 4923.483034281349, 4924.261360795909, 4626.768661566908, 4637.5130611286, 4681.578657920735, 4686.835960741358, 4708.717476951394, 2712.389712314753, 3009.5554134015797, 3016.547517872337, 3038.8176709397508, 3040.847957602111, 5795.913061304083, 5799.507041901401, 5799.652020878761, 5813.413031201075, 5862.6842397253695, 5444.3194600674915, 5666.206731057655, 5673.461021202979, 5712.371639119693, 5718.571107166896, 5754.971225143848, 5793.420657934257, 5811.476967072984, 5817.767289308465, 5818.650880947157, 5532.474414930575, 5607.327120745536, 5616.382197958303, 5623.578231632726, 5625.718714064198, 5353.2773075634295, 5524.751386187711, 5589.4070189995655, 5594.468525490072, 5601.663900166003, 5748.540116790563, 5771.624844385102, 5777.075667893117, 5807.883842323215, 5820.30156381237, 3765.717571182227, 3968.980155099206, 3973.721839471325, 3993.880183594497, 3998.640122388999, 5191.896162076661, 5630.296212973379, 5639.6334238274385, 5654.802081927277, 5673.801416950387, 5459.5632349412745, 5471.452854714496, 5492.752826122754, 5493.450654934634, 5507.669539827623, 5259.47405259471, 5432.022235997559, 5437.728113594226, 5446.373667028342, 5458.836234912959, 5246.790128394821, 5307.52232299095, 5369.919451208157, 5383.9192412114635, 5421.674699518042, 5535.861603459945, 5543.390227074938, 5543.3902270751, 5566.304211973504, 5568.276124103841, 5307.4692530746615, 5398.676079435089, 5448.45515448452, 5448.700321482356, 5482.17767334903], "value": 4115.1768659692125, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.4490701416019, 812.6261919517021, 830.7881490219993, 841.4152164245847, 854.9658013679453, 13715.588532344033, 14745.41018359267, 15061.246937653115, 15308.46420375287, 15310.923445382785, 14548.927255363735, 14583.416663333453, 14602.634934126652, 14613.415463381478, 14645.487407940724, 667.1060778556733, 785.3638552772244, 804.6620419423856, 820.306840719591, 830.9418340716152, 810.4731924249227, 810.793247721833, 811.9878201826978, 815.559597817178, 815.8653822119343, 849.087231226431, 850.1753299299701, 851.4040171879678, 852.8848605438279, 853.2235665544356, 702.2380716922146, 812.9065157506903, 841.1084250694253, 857.2499063319596, 858.9656413743505, 631.1353445779266, 631.8641492079179, 632.9683515824237, 633.0630666613392, 633.2306247908767, 13431.126976746578, 13474.258915759629, 13488.79766803489, 13524.526641567596, 13531.932340338333, 13674.0, 13874.514391996232, 13919.721605567933, 14120.223387713671, 14392.784108238386, 12011.579594714143, 12205.20666156697, 12236.510539578407, 12351.567695130718, 12388.690282742913, 4367.082912588328, 4410.360497727844, 4419.889502762425, 4442.977785111054, 4654.069186162781, 57782.42217577813, 58201.70899145477, 58320.0, 58495.0, 60756.392436075075, 11263.493142808593, 11455.783391641371, 11523.539058437736, 11542.711432214093, 11587.0, 20524.07641656099, 20589.485262868548, 20597.691034634492, 20704.275350362666, 20730.0, 8249.628766705513, 8256.463329883538, 8439.746807595782, 8499.36254780894, 8581.841451404105, 4639.930401043987, 4732.6687131900435, 4740.241561350167, 4760.7619619018915, 4930.0139972005745, 3273.738100951918, 3294.5058241264, 3360.327934413127, 3362.7309815214726, 3365.9495107573407, 577.336063526939, 583.4165834165834, 590.4184378387286, 591.7485068845723, 600.069891667913, 662.5726406467801, 673.2268218332049, 682.4301708073715, 716.2658275267892, 720.0818955831252, 9284.442933424016, 9330.206932410822, 9374.484403357881, 9390.483523406278, 9429.76425589352, 617.4874853871365, 723.8624661314334, 751.6054071612338, 753.3784627682074, 767.6814122139361, 4330.328799036154, 4568.269076947672, 4577.56513131252, 4623.42207224097, 4657.767111644404, 60211.0, 62594.37405625977, 62842.0, 65497.34502655008, 69252.653736731, 58729.70635146797, 58945.0, 59610.70194648999, 60326.0, 61008.69495652493, 54927.725361373734, 55011.72494137504, 55427.44572554223, 55671.72164139153, 56434.0, 9909.847296411546, 9981.72920390117, 10060.144887684335, 10071.34536255141, 10072.949635251776, 36973.44539831851, 36984.445233320985, 37237.255254895295, 37511.24977500489, 37513.624863751014, 46988.0, 50123.74938125286, 51008.23487647614, 51290.23064654108, 51742.482575173766, 12503.85583649298, 12587.685307867376, 12812.55156069533, 13063.564760939405, 13283.601491955256, 13855.792163117763, 13936.0, 14121.788173177616, 14404.063735857137, 14480.565583032105, 12976.935115324362, 13364.665883352605, 13366.93316533411, 13467.0, 13856.237906915216, 11717.941410292893, 11980.64058078259, 12964.481420743065, 13157.53948611794, 13981.300934953415, 11470.598529051444, 11576.826347604961, 11629.24409913353, 11634.301941883514, 11856.881431185579, 9947.452890091114, 9948.602055917681, 10007.491231290804, 10018.649347273102, 10592.364458132537, 9857.260705446977, 10160.745981350525, 10222.233332500242, 10244.64143754965, 10263.640772572924], "value": 6923.083082684481, "unit": "score"}], "name": "dromaeo_css", "value": 7093.368001164878, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 126.0, 169.0, 207.0, 126.0, 153.0, 156.0, 126.0, 184.0, 126.0], "value": 153.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 162.0, 162.0, 163.0, 163.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 155.0, 76.0, 74.0, 77.0, 75.0, 133.0, 76.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 150.0, 92.0, 93.0, 94.0, 122.0, 92.0, 93.0, 131.0], "value": 105.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 144.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 55.0, 55.0, 57.0, 55.0, 55.0, 107.0, 52.0, 64.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 79.0, 79.0, 80.0, 81.0, 79.0, 82.0, 79.0, 79.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 123.0, 127.0, 123.0, 124.0, 117.0, 121.0, 123.0, 190.0, 125.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 161.0, 160.0, 159.0, 160.0, 161.0, 160.0, 160.0, 161.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 64.0, 65.0, 63.0, 64.0, 63.0, 70.0, 63.0, 63.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1535.1999999999998, "alertThreshold": 2.0}]} 15:03:33 INFO - Return code: 0 15:03:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:03:33 ERROR - # TBPL SUCCESS # 15:03:33 INFO - Running post-action listener: _resource_record_post_action 15:03:33 INFO - ##### 15:03:33 INFO - ##### Finished run-tests step (success) 15:03:33 INFO - ##### 15:03:33 INFO - Running post-run listener: _resource_record_post_run 15:03:34 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550559744; Read time: 12; Write time: 593776 15:03:34 INFO - TinderboxPrint: CPU usage
13.2% 15:03:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:03:34 INFO - TinderboxPrint: I/O write bytes / time
550,559,744 / 593,776 15:03:34 INFO - TinderboxPrint: CPU idle
8,263.5 (86.8%) 15:03:34 INFO - TinderboxPrint: CPU user
1,209.7 (12.7%) 15:03:34 INFO - TinderboxPrint: Swap in / out
0 / 0 15:03:34 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 259440640; Read time: 0; Write time: 376256 15:03:34 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291119104; Read time: 12; Write time: 217520 15:03:34 INFO - Running post-run listener: _upload_blobber_files 15:03:34 INFO - Blob upload gear active. 15:03:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:03:34 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 15:03:34 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'] 15:03:34 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 15:03:34 INFO - (blobuploader) - INFO - Open directory for files ... 15:03:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:03:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:03:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:03:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:03:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:03:40 INFO - (blobuploader) - INFO - Done attempting. 15:03:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:03:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:03:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:03:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:03:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:03:41 INFO - (blobuploader) - INFO - Done attempting. 15:03:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:03:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:03:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:03:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:03:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:03:42 INFO - (blobuploader) - INFO - Done attempting. 15:03:42 INFO - (blobuploader) - INFO - Iteration through files over. 15:03:42 INFO - Return code: 0 15:03:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:03:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:03:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/263f48b119c99a2fbd08673f2740f4997c062c9a5d1c6595c2f3598a6aa77830a5c13d5169c4f2a592384318b3298843053b9bcd8613df8bf358d99afa795318", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/32e969d0518acaff7bb5df954b490a683d8a78358792b0163e6a0cb615524c74add88c0c680c412b51cf77c13e6983dcf7d5683d18cc08937af8f11f7e60e9ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e10eae10da3ff04ee909e52b33ca20ae7593d27a0ecf8d3eada3b6626485f994e76bc3a51a2402750404a0d62b5f255405344def204b752e7eb65d6f7ef4f35e"} 15:03:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:03:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:03:42 INFO - Contents: 15:03:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/263f48b119c99a2fbd08673f2740f4997c062c9a5d1c6595c2f3598a6aa77830a5c13d5169c4f2a592384318b3298843053b9bcd8613df8bf358d99afa795318", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/32e969d0518acaff7bb5df954b490a683d8a78358792b0163e6a0cb615524c74add88c0c680c412b51cf77c13e6983dcf7d5683d18cc08937af8f11f7e60e9ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e10eae10da3ff04ee909e52b33ca20ae7593d27a0ecf8d3eada3b6626485f994e76bc3a51a2402750404a0d62b5f255405344def204b752e7eb65d6f7ef4f35e"} 15:03:42 INFO - Running post-run listener: copy_logs_to_upload_dir 15:03:42 INFO - Copying logs to upload dir... 15:03:42 INFO - mkdir: /builds/slave/test/build/upload/logs 15:03:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.686755 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-19 15:03:42.577204) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 15:03:42.581005) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155 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/263f48b119c99a2fbd08673f2740f4997c062c9a5d1c6595c2f3598a6aa77830a5c13d5169c4f2a592384318b3298843053b9bcd8613df8bf358d99afa795318", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/32e969d0518acaff7bb5df954b490a683d8a78358792b0163e6a0cb615524c74add88c0c680c412b51cf77c13e6983dcf7d5683d18cc08937af8f11f7e60e9ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e10eae10da3ff04ee909e52b33ca20ae7593d27a0ecf8d3eada3b6626485f994e76bc3a51a2402750404a0d62b5f255405344def204b752e7eb65d6f7ef4f35e"} build_url:https://queue.taskcluster.net/v1/task/AavsB14NQw-64R7QRxI35Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/AavsB14NQw-64R7QRxI35Q/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/263f48b119c99a2fbd08673f2740f4997c062c9a5d1c6595c2f3598a6aa77830a5c13d5169c4f2a592384318b3298843053b9bcd8613df8bf358d99afa795318", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/32e969d0518acaff7bb5df954b490a683d8a78358792b0163e6a0cb615524c74add88c0c680c412b51cf77c13e6983dcf7d5683d18cc08937af8f11f7e60e9ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e10eae10da3ff04ee909e52b33ca20ae7593d27a0ecf8d3eada3b6626485f994e76bc3a51a2402750404a0d62b5f255405344def204b752e7eb65d6f7ef4f35e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 15:03:42.610536) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 15:03:42.611178) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463693288.423298-1017621155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 15:03:42.695613) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 15:03:42.696216) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 15:03:42.696830) ========= ========= Total master_lag: 0.18 =========