builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1463810960.28 results: success (0) buildid: 20160520203038 builduid: abeca14195a54ba0a7b3eb8e3a460e64 revision: 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.283409) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.283844) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.284136) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.304854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.305120) ========= 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=8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 23:09:20-- 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% 80.9M=0s 2016-05-20 23:09:20 (80.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143148 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.462972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.463267) ========= 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=8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018323 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.515101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:20.515908) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 --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=8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 23:09:20,698 truncating revision to first 12 chars 2016-05-20 23:09:20,698 Setting DEBUG logging. 2016-05-20 23:09:20,699 attempt 1/10 2016-05-20 23:09:20,699 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/06d9362a57a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 23:09:20,932 unpacking tar archive at: fx-team-06d9362a57a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562496 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:21.092680) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:21.092983) ========= script_repo_revision: 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:21.093383) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:21.093684) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 23:09:21.102135) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-05-20 23:09:21.102432) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:09:21 INFO - MultiFileLogger online at 20160520 23:09:21 in /builds/slave/test 23:09:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:09:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:09:21 INFO - {'append_to_log': False, 23:09:21 INFO - 'base_work_dir': '/builds/slave/test', 23:09:21 INFO - 'blob_upload_branch': 'Fx-Team', 23:09:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:09:21 INFO - 'branch': 'Fx-Team', 23:09:21 INFO - 'buildbot_json_path': 'buildprops.json', 23:09:21 INFO - 'config_files': ('talos/linux_config.py',), 23:09:21 INFO - 'default_actions': ('clobber', 23:09:21 INFO - 'read-buildbot-config', 23:09:21 INFO - 'download-and-extract', 23:09:21 INFO - 'populate-webroot', 23:09:21 INFO - 'create-virtualenv', 23:09:21 INFO - 'install', 23:09:21 INFO - 'run-tests'), 23:09:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:09:21 INFO - 'download_minidump_stackwalk': True, 23:09:21 INFO - 'download_symbols': 'ondemand', 23:09:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:09:21 INFO - 'tooltool.py': '/tools/tooltool.py', 23:09:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:09:21 INFO - '/tools/misc-python/virtualenv.py')}, 23:09:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:09:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:09:21 INFO - 'installer_path': 'installer.exe', 23:09:21 INFO - 'log_level': 'info', 23:09:21 INFO - 'log_name': 'talos', 23:09:21 INFO - 'log_to_console': True, 23:09:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:09:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:09:21 INFO - 'opt_config_files': (), 23:09:21 INFO - 'pip_index': False, 23:09:21 INFO - 'sps_profile': False, 23:09:21 INFO - 'sps_profile_interval': 0, 23:09:21 INFO - 'suite': 'dromaeojs', 23:09:21 INFO - 'system_bits': '32', 23:09:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:09:21 INFO - 'title': 'talos-linux64-ix-038', 23:09:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:09:21 INFO - 'use_talos_json': True, 23:09:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:09:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:09:21 INFO - 'work_dir': 'build'} 23:09:21 INFO - ##### 23:09:21 INFO - ##### Running clobber step. 23:09:21 INFO - ##### 23:09:21 INFO - Running pre-action listener: _resource_record_pre_action 23:09:21 INFO - Running main action method: clobber 23:09:21 INFO - rmtree: /builds/slave/test/build 23:09:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:09:21 INFO - Running post-action listener: _resource_record_post_action 23:09:21 INFO - ##### 23:09:21 INFO - ##### Finished clobber step (success) 23:09:21 INFO - ##### 23:09:21 INFO - ##### 23:09:21 INFO - ##### Running read-buildbot-config step. 23:09:21 INFO - ##### 23:09:21 INFO - Running pre-action listener: _resource_record_pre_action 23:09:21 INFO - Running main action method: read_buildbot_config 23:09:21 INFO - Using buildbot properties: 23:09:21 INFO - { 23:09:21 INFO - "project": "", 23:09:21 INFO - "product": "firefox", 23:09:21 INFO - "script_repo_revision": "production", 23:09:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:09:21 INFO - "repository": "", 23:09:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:09:21 INFO - "buildid": "20160520203038", 23:09:21 INFO - "pgo_build": "True", 23:09:21 INFO - "basedir": "/builds/slave/test", 23:09:21 INFO - "buildnumber": 111, 23:09:21 INFO - "slavename": "talos-linux64-ix-038", 23:09:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:09:21 INFO - "platform": "ubuntu64_hw", 23:09:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:09:21 INFO - "branch": "fx-team", 23:09:21 INFO - "repo_path": "integration/fx-team", 23:09:21 INFO - "revision": "06d9362a57a10396f3f7c7989c21f1a416f4c7e9", 23:09:21 INFO - "stage_platform": "linux64-pgo", 23:09:21 INFO - "builduid": "abeca14195a54ba0a7b3eb8e3a460e64", 23:09:21 INFO - "slavebuilddir": "test" 23:09:21 INFO - } 23:09:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:09:21 INFO - Running post-action listener: _resource_record_post_action 23:09:21 INFO - ##### 23:09:21 INFO - ##### Finished read-buildbot-config step (success) 23:09:21 INFO - ##### 23:09:21 INFO - ##### 23:09:21 INFO - ##### Running download-and-extract step. 23:09:21 INFO - ##### 23:09:21 INFO - Running pre-action listener: _resource_record_pre_action 23:09:21 INFO - Running main action method: download_and_extract 23:09:21 INFO - mkdir: /builds/slave/test/build/tests 23:09: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')]} 23:09:21 INFO - https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:09:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:09:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:09:30 INFO - Downloaded 1361 bytes. 23:09:30 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:30 INFO - Using the following test package requirements: 23:09:30 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:30 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:09:30 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:09:30 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:30 INFO - u'jsshell-linux-x86_64.zip'], 23:09:30 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:09:30 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:30 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:09:30 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:09:30 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:09:30 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:09:30 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:09: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')]} 23:09:30 INFO - https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:09:35 INFO - Downloaded 24389251 bytes. 23:09:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:09:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:09:36 INFO - Return code: 0 23:09:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:36 INFO - https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:09:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:09:47 INFO - Downloaded 24389251 bytes. 23:09:47 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'] 23:09:47 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 23:09:48 INFO - Return code: 0 23:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:48 INFO - https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:09:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:09:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:09:51 INFO - Downloaded 10840359 bytes. 23:09:51 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'] 23:09:51 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 23:09:51 INFO - Return code: 0 23:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:51 INFO - https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:09:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:09:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eKJy6gDWTG-cHMld2N__2w/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 23:09:58 INFO - Downloaded 58593479 bytes. 23:09:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:58 INFO - mkdir: /builds/slave/test/properties 23:09:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:09:58 INFO - Writing to file /builds/slave/test/properties/build_url 23:09:58 INFO - Contents: 23:09:58 INFO - build_url:https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:59 INFO - Running post-action listener: _resource_record_post_action 23:09:59 INFO - Running post-action listener: set_extra_try_arguments 23:09:59 INFO - ##### 23:09:59 INFO - ##### Finished download-and-extract step (success) 23:09:59 INFO - ##### 23:09:59 INFO - ##### 23:09:59 INFO - ##### Running populate-webroot step. 23:09:59 INFO - ##### 23:09:59 INFO - Running pre-action listener: _resource_record_pre_action 23:09:59 INFO - Running main action method: populate_webroot 23:09:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:09:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:09:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:09:59 INFO - '--tppagecycles', 23:09:59 INFO - '7'], 23:09:59 INFO - 'tests': ['tsvgm']}}, 23:09:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:09:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:09:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:09:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:09:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:09:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:09:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:59 INFO - 'talos_options': ['--disable-e10s'], 23:09:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:59 INFO - 'talos_options': ['--disable-e10s'], 23:09:59 INFO - 'tests': ['damp', 'tps']}, 23:09:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:59 INFO - 'tests': ['damp', 'tps']}, 23:09:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:09:59 INFO - 'tests': ['dromaeo_dom']}, 23:09:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:09:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:09:59 INFO - 'tests': ['a11yr', 23:09:59 INFO - 'ts_paint', 23:09:59 INFO - 'tpaint', 23:09:59 INFO - 'sessionrestore', 23:09:59 INFO - 'sessionrestore_no_auto_restore', 23:09:59 INFO - 'tabpaint']}, 23:09:59 INFO - 'other-e10s': {'tests': ['a11yr', 23:09:59 INFO - 'ts_paint', 23:09:59 INFO - 'tpaint', 23:09:59 INFO - 'sessionrestore', 23:09:59 INFO - 'sessionrestore_no_auto_restore', 23:09:59 INFO - 'tabpaint']}, 23:09:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:09:59 INFO - 'ts_paint', 23:09:59 INFO - 'tpaint', 23:09:59 INFO - 'sessionrestore', 23:09:59 INFO - 'sessionrestore_no_auto_restore', 23:09:59 INFO - 'tabpaint']}, 23:09:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:09:59 INFO - 'ts_paint', 23:09:59 INFO - 'tpaint', 23:09:59 INFO - 'sessionrestore', 23:09:59 INFO - 'sessionrestore_no_auto_restore', 23:09:59 INFO - 'tabpaint']}, 23:09:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:09:59 INFO - 'tests': ['a11yr', 23:09:59 INFO - 'ts_paint', 23:09:59 INFO - 'tpaint', 23:09:59 INFO - 'sessionrestore', 23:09:59 INFO - 'sessionrestore_no_auto_restore', 23:09:59 INFO - 'tabpaint']}, 23:09:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:09:59 INFO - 'tests': ['a11yr', 23:09:59 INFO - 'ts_paint', 23:09:59 INFO - 'tpaint', 23:09:59 INFO - 'sessionrestore', 23:09:59 INFO - 'sessionrestore_no_auto_restore', 23:09:59 INFO - 'tabpaint']}, 23:09:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:09:59 INFO - 'tests': ['tsvgx', 23:09:59 INFO - 'tsvgr_opacity', 23:09:59 INFO - 'tart', 23:09:59 INFO - 'tscrollx', 23:09:59 INFO - 'cart']}, 23:09:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:09:59 INFO - 'tsvgr_opacity', 23:09:59 INFO - 'tart', 23:09:59 INFO - 'tscrollx', 23:09:59 INFO - 'cart']}, 23:09:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:59 INFO - 'talos_options': ['--disable-e10s'], 23:09:59 INFO - 'tests': ['tp5o']}, 23:09:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:59 INFO - 'tests': ['tp5o']}, 23:09:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:59 INFO - 'talos_options': ['--disable-e10s', 23:09:59 INFO - '--xperf_path', 23:09:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:59 INFO - 'tests': ['tp5n']}, 23:09:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:59 INFO - 'talos_options': ['--xperf_path', 23:09:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:59 INFO - 'tests': ['tp5n']}}, 23:09:59 INFO - 'talos.zip': {'path': '', 23:09:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:09:59 INFO - Running post-action listener: _resource_record_post_action 23:09:59 INFO - ##### 23:09:59 INFO - ##### Finished populate-webroot step (success) 23:09:59 INFO - ##### 23:09:59 INFO - ##### 23:09:59 INFO - ##### Running create-virtualenv step. 23:09:59 INFO - ##### 23:09:59 INFO - Running pre-action listener: _resource_record_pre_action 23:09:59 INFO - Running main action method: create_virtualenv 23:09:59 INFO - Creating virtualenv /builds/slave/test/build/venv 23:09:59 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 23:09:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:09:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:09:59 INFO - Using real prefix '/usr' 23:09:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:09:59 INFO - Installing distribute.............................................................................................................................................................................................done. 23:10:01 INFO - Installing pip.................done. 23:10:01 INFO - Return code: 0 23:10:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa418919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d9c0>, '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 0x2a9e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ed50>, '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': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', '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 23:10:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:10:01 INFO - Using env: {'DISPLAY': ':0', 23:10:01 INFO - 'HOME': '/home/cltbld', 23:10:01 INFO - 'LANG': 'en_US.UTF-8', 23:10:01 INFO - 'LANGUAGE': 'en_US:en', 23:10:01 INFO - 'LOGNAME': 'cltbld', 23:10:01 INFO - 'MAIL': '/var/mail/cltbld', 23:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:01 INFO - 'MOZ_NO_REMOTE': '1', 23:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:01 INFO - 'NO_EM_RESTART': '1', 23:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:01 INFO - 'PWD': '/builds/slave/test', 23:10:01 INFO - 'SHELL': '/bin/bash', 23:10:01 INFO - 'SHLVL': '1', 23:10:01 INFO - 'TERM': 'linux', 23:10:01 INFO - 'TMOUT': '86400', 23:10:01 INFO - 'USER': 'cltbld', 23:10:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', 23:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:01 INFO - '_': '/tools/buildbot/bin/python'} 23:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:02 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 23:10:02 INFO - Cleaning up... 23:10:02 INFO - Return code: 0 23:10:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:10:02 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')]} 23:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:02 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')]} 23:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:02 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 0x7fa418919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d9c0>, '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 0x2a9e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ed50>, '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': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', '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 23:10:02 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 23:10:02 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 23:10:02 INFO - Using env: {'DISPLAY': ':0', 23:10:02 INFO - 'HOME': '/home/cltbld', 23:10:02 INFO - 'LANG': 'en_US.UTF-8', 23:10:02 INFO - 'LANGUAGE': 'en_US:en', 23:10:02 INFO - 'LOGNAME': 'cltbld', 23:10:02 INFO - 'MAIL': '/var/mail/cltbld', 23:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:02 INFO - 'MOZ_NO_REMOTE': '1', 23:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:02 INFO - 'NO_EM_RESTART': '1', 23:10:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:02 INFO - 'PWD': '/builds/slave/test', 23:10:02 INFO - 'SHELL': '/bin/bash', 23:10:02 INFO - 'SHLVL': '1', 23:10:02 INFO - 'TERM': 'linux', 23:10:02 INFO - 'TMOUT': '86400', 23:10:02 INFO - 'USER': 'cltbld', 23:10:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', 23:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:02 INFO - '_': '/tools/buildbot/bin/python'} 23:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:02 INFO - Downloading/unpacking psutil>=3.1.1 23:10:02 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 23:10:02 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 23:10:02 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 23:10:02 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 23:10:02 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 23:10:02 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 23:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:10:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:10:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:10:04 INFO - Installing collected packages: psutil 23:10:04 INFO - Running setup.py install for psutil 23:10:04 INFO - building 'psutil._psutil_linux' extension 23:10:04 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 23:10:04 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 23:10:04 INFO - building 'psutil._psutil_posix' extension 23:10:04 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 23:10:04 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 23:10:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:10:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:10:04 INFO - Successfully installed psutil 23:10:04 INFO - Cleaning up... 23:10:04 INFO - Return code: 0 23:10:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:04 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 0x7fa418919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d9c0>, '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 0x2a9e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ed50>, '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': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', '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 23:10:04 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 23:10:04 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 23:10:04 INFO - Using env: {'DISPLAY': ':0', 23:10:04 INFO - 'HOME': '/home/cltbld', 23:10:04 INFO - 'LANG': 'en_US.UTF-8', 23:10:04 INFO - 'LANGUAGE': 'en_US:en', 23:10:04 INFO - 'LOGNAME': 'cltbld', 23:10:04 INFO - 'MAIL': '/var/mail/cltbld', 23:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:04 INFO - 'MOZ_NO_REMOTE': '1', 23:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:04 INFO - 'NO_EM_RESTART': '1', 23:10:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:04 INFO - 'PWD': '/builds/slave/test', 23:10:04 INFO - 'SHELL': '/bin/bash', 23:10:04 INFO - 'SHLVL': '1', 23:10:04 INFO - 'TERM': 'linux', 23:10:04 INFO - 'TMOUT': '86400', 23:10:04 INFO - 'USER': 'cltbld', 23:10:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', 23:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:04 INFO - '_': '/tools/buildbot/bin/python'} 23:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:10:05 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 23:10:05 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 23:10:05 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 23:10:05 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 23:10:05 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 23:10:05 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 23:10:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:10:07 INFO - Installing collected packages: mozsystemmonitor 23:10:07 INFO - Running setup.py install for mozsystemmonitor 23:10:07 INFO - Successfully installed mozsystemmonitor 23:10:07 INFO - Cleaning up... 23:10:07 INFO - Return code: 0 23:10:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:10:07 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')]} 23:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:07 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')]} 23:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:07 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 0x7fa418919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d9c0>, '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 0x2a9e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ed50>, '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': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', '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 23:10:07 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 23:10:07 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 23:10:07 INFO - Using env: {'DISPLAY': ':0', 23:10:07 INFO - 'HOME': '/home/cltbld', 23:10:07 INFO - 'LANG': 'en_US.UTF-8', 23:10:07 INFO - 'LANGUAGE': 'en_US:en', 23:10:07 INFO - 'LOGNAME': 'cltbld', 23:10:07 INFO - 'MAIL': '/var/mail/cltbld', 23:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:07 INFO - 'MOZ_NO_REMOTE': '1', 23:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:07 INFO - 'NO_EM_RESTART': '1', 23:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:07 INFO - 'PWD': '/builds/slave/test', 23:10:07 INFO - 'SHELL': '/bin/bash', 23:10:07 INFO - 'SHLVL': '1', 23:10:07 INFO - 'TERM': 'linux', 23:10:07 INFO - 'TMOUT': '86400', 23:10:07 INFO - 'USER': 'cltbld', 23:10:07 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', 23:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:07 INFO - '_': '/tools/buildbot/bin/python'} 23:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:07 INFO - Downloading/unpacking blobuploader==1.2.4 23:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:09 INFO - Downloading blobuploader-1.2.4.tar.gz 23:10:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:10:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:10:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:10 INFO - Downloading docopt-0.6.1.tar.gz 23:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:10:10 INFO - Installing collected packages: blobuploader, requests, docopt 23:10:10 INFO - Running setup.py install for blobuploader 23:10:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:10:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:10:10 INFO - Running setup.py install for requests 23:10:10 INFO - Running setup.py install for docopt 23:10:10 INFO - Successfully installed blobuploader requests docopt 23:10:10 INFO - Cleaning up... 23:10:10 INFO - Return code: 0 23:10:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10:10 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')]} 23:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:10 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')]} 23:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:10 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 0x7fa418919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d9c0>, '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 0x2a9e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ed50>, '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': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', '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 23:10:10 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 23:10:10 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 23:10:10 INFO - Using env: {'DISPLAY': ':0', 23:10:10 INFO - 'HOME': '/home/cltbld', 23:10:10 INFO - 'LANG': 'en_US.UTF-8', 23:10:10 INFO - 'LANGUAGE': 'en_US:en', 23:10:10 INFO - 'LOGNAME': 'cltbld', 23:10:10 INFO - 'MAIL': '/var/mail/cltbld', 23:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:10 INFO - 'MOZ_NO_REMOTE': '1', 23:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:10 INFO - 'NO_EM_RESTART': '1', 23:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:10 INFO - 'PWD': '/builds/slave/test', 23:10:10 INFO - 'SHELL': '/bin/bash', 23:10:10 INFO - 'SHLVL': '1', 23:10:10 INFO - 'TERM': 'linux', 23:10:10 INFO - 'TMOUT': '86400', 23:10:10 INFO - 'USER': 'cltbld', 23:10:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', 23:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:10 INFO - '_': '/tools/buildbot/bin/python'} 23:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:10:10 INFO - Running setup.py (path:/tmp/pip-hs6bGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:10:10 INFO - Running setup.py (path:/tmp/pip-H227Fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:10:11 INFO - Running setup.py (path:/tmp/pip-VZThEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:10:11 INFO - Running setup.py (path:/tmp/pip-ix6yqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:10:11 INFO - Running setup.py (path:/tmp/pip-auWzCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:10:11 INFO - Running setup.py (path:/tmp/pip-HeOU4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:10:11 INFO - Running setup.py (path:/tmp/pip-XndEHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:10:11 INFO - Running setup.py (path:/tmp/pip-9mtEfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:10:11 INFO - Running setup.py (path:/tmp/pip-52ZHgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:10:11 INFO - Running setup.py (path:/tmp/pip-N9L5cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:10:11 INFO - Running setup.py (path:/tmp/pip-3y3TUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:10:11 INFO - Running setup.py (path:/tmp/pip-xns4JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:10:11 INFO - Running setup.py (path:/tmp/pip-BTwIN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:10:11 INFO - Running setup.py (path:/tmp/pip-NAb4ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:11 INFO - Running setup.py (path:/tmp/pip-kz4kFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:10:12 INFO - Running setup.py (path:/tmp/pip-RkXfeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:10:12 INFO - Running setup.py (path:/tmp/pip-f8FoxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:10:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:10:12 INFO - Running setup.py install for manifestparser 23:10:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:10:12 INFO - Running setup.py install for mozcrash 23:10:12 INFO - Running setup.py install for mozdebug 23:10:12 INFO - Running setup.py install for mozdevice 23:10:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:10:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:10:12 INFO - Running setup.py install for mozfile 23:10:12 INFO - Running setup.py install for mozhttpd 23:10:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:10:12 INFO - Running setup.py install for mozinfo 23:10:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:10:12 INFO - Running setup.py install for mozInstall 23:10:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:10:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:10:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:10:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:10:12 INFO - Running setup.py install for mozleak 23:10:13 INFO - Running setup.py install for mozlog 23:10:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:10:13 INFO - Running setup.py install for moznetwork 23:10:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:10:13 INFO - Running setup.py install for mozprocess 23:10:13 INFO - Running setup.py install for mozprofile 23:10:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:10:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:10:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:10:13 INFO - Running setup.py install for mozrunner 23:10:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:10:13 INFO - Running setup.py install for mozscreenshot 23:10:13 INFO - Running setup.py install for moztest 23:10:13 INFO - Running setup.py install for mozversion 23:10:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:10:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:10:13 INFO - Cleaning up... 23:10:13 INFO - Return code: 0 23:10:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10:13 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')]} 23:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:13 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')]} 23:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:13 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 0x7fa418919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d9c0>, '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 0x2a9e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ed50>, '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': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', '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 23:10:13 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 23:10:13 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 23:10:13 INFO - Using env: {'DISPLAY': ':0', 23:10:13 INFO - 'HOME': '/home/cltbld', 23:10:13 INFO - 'LANG': 'en_US.UTF-8', 23:10:13 INFO - 'LANGUAGE': 'en_US:en', 23:10:13 INFO - 'LOGNAME': 'cltbld', 23:10:13 INFO - 'MAIL': '/var/mail/cltbld', 23:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:13 INFO - 'MOZ_NO_REMOTE': '1', 23:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:13 INFO - 'NO_EM_RESTART': '1', 23:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:13 INFO - 'PWD': '/builds/slave/test', 23:10:13 INFO - 'SHELL': '/bin/bash', 23:10:13 INFO - 'SHLVL': '1', 23:10:13 INFO - 'TERM': 'linux', 23:10:13 INFO - 'TMOUT': '86400', 23:10:13 INFO - 'USER': 'cltbld', 23:10:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', 23:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:13 INFO - '_': '/tools/buildbot/bin/python'} 23:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:10:14 INFO - Running setup.py (path:/tmp/pip-HWPZ_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:10:14 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)) 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:10:14 INFO - Running setup.py (path:/tmp/pip-j5GbpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:10:14 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)) 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:10:14 INFO - Running setup.py (path:/tmp/pip-hdbqIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:10:14 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)) 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:10:14 INFO - Running setup.py (path:/tmp/pip-jzMgeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:10:14 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)) 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:10:14 INFO - Running setup.py (path:/tmp/pip-2CnPoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:10:14 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)) 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:10:14 INFO - Running setup.py (path:/tmp/pip-2X5sy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:10:14 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)) 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:10:14 INFO - Running setup.py (path:/tmp/pip-sh875t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:10:14 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)) 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:10:14 INFO - Running setup.py (path:/tmp/pip-UGmolj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:10:14 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)) 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:10:14 INFO - Running setup.py (path:/tmp/pip-7Fn8oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:10:14 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)) 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:10:14 INFO - Running setup.py (path:/tmp/pip-dsQ8aF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:10:14 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)) 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:10:14 INFO - Running setup.py (path:/tmp/pip-9uCgpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:10:14 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)) 23:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:10:14 INFO - Running setup.py (path:/tmp/pip-i91BIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:10:15 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)) 23:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:10:15 INFO - Running setup.py (path:/tmp/pip-kqjczW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:10:15 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)) 23:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:10:15 INFO - Running setup.py (path:/tmp/pip-WgZW2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:10:15 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)) 23:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:15 INFO - Running setup.py (path:/tmp/pip-6ZSvjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:15 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)) 23:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:10:15 INFO - Running setup.py (path:/tmp/pip-jkj8w2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:10:15 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)) 23:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:10:15 INFO - Running setup.py (path:/tmp/pip-XwvQkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:10:15 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)) 23:10:15 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)) 23:10:15 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)) 23:10:15 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)) 23:10:15 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)) 23:10:15 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)) 23:10:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:10:15 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 23:10:15 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 23:10:15 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 23:10:15 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 23:10:15 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 23:10:15 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 23:10:17 INFO - Downloading blessings-1.6.tar.gz 23:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:10:17 INFO - Installing collected packages: blessings 23:10:17 INFO - Running setup.py install for blessings 23:10:17 INFO - Successfully installed blessings 23:10:17 INFO - Cleaning up... 23:10:17 INFO - Return code: 0 23:10:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:10:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:10:17 INFO - Reading from file tmpfile_stdout 23:10:17 INFO - Current package versions: 23:10:17 INFO - argparse == 1.2.1 23:10:17 INFO - blessings == 1.6 23:10:17 INFO - blobuploader == 1.2.4 23:10:17 INFO - docopt == 0.6.1 23:10:17 INFO - manifestparser == 1.1 23:10:17 INFO - mozInstall == 1.12 23:10:17 INFO - mozcrash == 0.17 23:10:17 INFO - mozdebug == 0.1 23:10:17 INFO - mozdevice == 0.48 23:10:17 INFO - mozfile == 1.2 23:10:17 INFO - mozhttpd == 0.7 23:10:17 INFO - mozinfo == 0.9 23:10:17 INFO - mozleak == 0.1 23:10:17 INFO - mozlog == 3.2 23:10:17 INFO - moznetwork == 0.27 23:10:17 INFO - mozprocess == 0.22 23:10:17 INFO - mozprofile == 0.28 23:10:17 INFO - mozrunner == 6.11 23:10:17 INFO - mozscreenshot == 0.1 23:10:17 INFO - mozsystemmonitor == 0.3 23:10:17 INFO - moztest == 0.7 23:10:17 INFO - mozversion == 1.4 23:10:17 INFO - psutil == 3.1.1 23:10:17 INFO - requests == 1.2.3 23:10:17 INFO - wsgiref == 0.1.2 23:10:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:17 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 0x7fa418919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d9c0>, '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 0x2a9e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ed50>, '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': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', '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 23:10:17 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 23:10:17 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 23:10:17 INFO - Using env: {'DISPLAY': ':0', 23:10:17 INFO - 'HOME': '/home/cltbld', 23:10:17 INFO - 'LANG': 'en_US.UTF-8', 23:10:17 INFO - 'LANGUAGE': 'en_US:en', 23:10:17 INFO - 'LOGNAME': 'cltbld', 23:10:17 INFO - 'MAIL': '/var/mail/cltbld', 23:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:17 INFO - 'MOZ_NO_REMOTE': '1', 23:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:17 INFO - 'NO_EM_RESTART': '1', 23:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:17 INFO - 'PWD': '/builds/slave/test', 23:10:17 INFO - 'SHELL': '/bin/bash', 23:10:17 INFO - 'SHLVL': '1', 23:10:17 INFO - 'TERM': 'linux', 23:10:17 INFO - 'TMOUT': '86400', 23:10:17 INFO - 'USER': 'cltbld', 23:10:17 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', 23:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:17 INFO - '_': '/tools/buildbot/bin/python'} 23:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:17 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)) 23:10:17 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)) 23:10:17 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)) 23:10:17 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)) 23:10:17 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)) 23:10:17 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)) 23:10:17 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)) 23:10:17 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)) 23:10:17 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)) 23:10:17 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)) 23:10:17 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)) 23:10:17 INFO - Cleaning up... 23:10:17 INFO - Return code: 0 23:10:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:17 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 0x7fa418919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d9c0>, '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 0x2a9e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ed50>, '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': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', '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 23:10:17 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 23:10:17 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 23:10:17 INFO - Using env: {'DISPLAY': ':0', 23:10:17 INFO - 'HOME': '/home/cltbld', 23:10:17 INFO - 'LANG': 'en_US.UTF-8', 23:10:17 INFO - 'LANGUAGE': 'en_US:en', 23:10:17 INFO - 'LOGNAME': 'cltbld', 23:10:17 INFO - 'MAIL': '/var/mail/cltbld', 23:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:17 INFO - 'MOZ_NO_REMOTE': '1', 23:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:17 INFO - 'NO_EM_RESTART': '1', 23:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:17 INFO - 'PWD': '/builds/slave/test', 23:10:17 INFO - 'SHELL': '/bin/bash', 23:10:17 INFO - 'SHLVL': '1', 23:10:17 INFO - 'TERM': 'linux', 23:10:17 INFO - 'TMOUT': '86400', 23:10:17 INFO - 'USER': 'cltbld', 23:10:17 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', 23:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:17 INFO - '_': '/tools/buildbot/bin/python'} 23:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:18 INFO - Downloading/unpacking jsonschema 23:10:18 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 23:10:18 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 23:10:18 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 23:10:18 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 23:10:18 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 23:10:18 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 23:10:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:10:20 INFO - Downloading/unpacking functools32 (from jsonschema) 23:10:20 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 23:10:20 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 23:10:20 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 23:10:20 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 23:10:20 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 23:10:20 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 23:10:20 INFO - Downloading functools32-3.2.3-2.tar.gz 23:10:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:10:20 INFO - warning: no files found matching '*.txt' 23:10:20 INFO - no previously-included directories found matching 'build' 23:10:20 INFO - no previously-included directories found matching 'dist' 23:10:20 INFO - no previously-included directories found matching '.git*' 23:10:20 INFO - Installing collected packages: jsonschema, functools32 23:10:20 INFO - Running setup.py install for functools32 23:10:20 INFO - warning: no files found matching '*.txt' 23:10:20 INFO - no previously-included directories found matching 'build' 23:10:20 INFO - no previously-included directories found matching 'dist' 23:10:20 INFO - no previously-included directories found matching '.git*' 23:10:20 INFO - Successfully installed jsonschema functools32 23:10:20 INFO - Cleaning up... 23:10:20 INFO - Return code: 0 23:10:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:20 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 0x7fa418919f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a0e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9d9c0>, '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 0x2a9e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ed50>, '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': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', '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 23:10:20 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 23:10:20 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 23:10:20 INFO - Using env: {'DISPLAY': ':0', 23:10:20 INFO - 'HOME': '/home/cltbld', 23:10:20 INFO - 'LANG': 'en_US.UTF-8', 23:10:20 INFO - 'LANGUAGE': 'en_US:en', 23:10:20 INFO - 'LOGNAME': 'cltbld', 23:10:20 INFO - 'MAIL': '/var/mail/cltbld', 23:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:20 INFO - 'MOZ_NO_REMOTE': '1', 23:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:20 INFO - 'NO_EM_RESTART': '1', 23:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:20 INFO - 'PWD': '/builds/slave/test', 23:10:20 INFO - 'SHELL': '/bin/bash', 23:10:20 INFO - 'SHLVL': '1', 23:10:20 INFO - 'TERM': 'linux', 23:10:20 INFO - 'TMOUT': '86400', 23:10:20 INFO - 'USER': 'cltbld', 23:10:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', 23:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:20 INFO - '_': '/tools/buildbot/bin/python'} 23:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:20 INFO - Downloading/unpacking flake8 23:10:20 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 23:10:20 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 23:10:20 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 23:10:20 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 23:10:20 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 23:10:20 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 23:10:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:10:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:10:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:10:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:10:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:10:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:10:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:10:24 INFO - no previously-included directories found matching 'docs/_build' 23:10:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:10:24 INFO - Running setup.py install for pep8 23:10:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:10:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:10:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:10:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:10:24 INFO - no previously-included directories found matching 'docs/_build' 23:10:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:10:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:10:24 INFO - Cleaning up... 23:10:26 INFO - Return code: 0 23:10:26 INFO - Running post-action listener: _resource_record_post_action 23:10:26 INFO - Running post-action listener: _start_resource_monitoring 23:10:26 INFO - Starting resource monitoring. 23:10:26 INFO - ##### 23:10:26 INFO - ##### Finished create-virtualenv step (success) 23:10:26 INFO - ##### 23:10:26 INFO - ##### 23:10:26 INFO - ##### Running install step. 23:10:26 INFO - ##### 23:10:26 INFO - Running pre-action listener: _resource_record_pre_action 23:10:26 INFO - Running main action method: install 23:10:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:10:26 INFO - Reading from file tmpfile_stdout 23:10:26 INFO - Detecting whether we're running mozinstall >=1.0... 23:10:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:10:26 INFO - Reading from file tmpfile_stdout 23:10:26 INFO - Output received: 23:10:26 INFO - Usage: mozinstall [options] installer 23:10:26 INFO - Options: 23:10:26 INFO - -h, --help show this help message and exit 23:10:26 INFO - -d DEST, --destination=DEST 23:10:26 INFO - Directory to install application into. [default: 23:10:26 INFO - "/builds/slave/test"] 23:10:26 INFO - --app=APP Application being installed. [default: firefox] 23:10:26 INFO - mkdir: /builds/slave/test/build/application 23:10:26 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'] 23:10:26 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 23:10:43 INFO - Reading from file tmpfile_stdout 23:10:43 INFO - Output received: 23:10:43 INFO - /builds/slave/test/build/application/firefox/firefox 23:10:43 INFO - Running post-action listener: _resource_record_post_action 23:10:43 INFO - ##### 23:10:43 INFO - ##### Finished install step (success) 23:10:43 INFO - ##### 23:10:43 INFO - ##### 23:10:43 INFO - ##### Running run-tests step. 23:10:43 INFO - ##### 23:10:43 INFO - Running pre-action listener: _resource_record_pre_action 23:10:43 INFO - Running main action method: run_tests 23:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:10:43 INFO - Python 2.7.3 23:10:43 INFO - Return code: 0 23:10:43 INFO - grabbing minidump binary from tooltool 23:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:43 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 0x2a9d9c0>, '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 0x2a9e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:10:43 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 23:10:43 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 23:10:43 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 23:10:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:10:43 INFO - Return code: 0 23:10:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:10:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:10:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:10:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:10:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:10:44 INFO - Return code: 0 23:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 23:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 23:10:44 INFO - Using env: {'DISPLAY': ':0', 23:10:44 INFO - 'HOME': '/home/cltbld', 23:10:44 INFO - 'LANG': 'en_US.UTF-8', 23:10:44 INFO - 'LANGUAGE': 'en_US:en', 23:10:44 INFO - 'LOGNAME': 'cltbld', 23:10:44 INFO - 'MAIL': '/var/mail/cltbld', 23:10:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:10:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:44 INFO - 'MOZ_NO_REMOTE': '1', 23:10:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:44 INFO - 'NO_EM_RESTART': '1', 23:10:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:44 INFO - 'PWD': '/builds/slave/test', 23:10:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:10:44 INFO - 'SHELL': '/bin/bash', 23:10:44 INFO - 'SHLVL': '1', 23:10:44 INFO - 'TERM': 'linux', 23:10:44 INFO - 'TMOUT': '86400', 23:10:44 INFO - 'USER': 'cltbld', 23:10:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975', 23:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:44 INFO - '_': '/tools/buildbot/bin/python'} 23:10:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 23:10:44 INFO - mozversion application_buildid: 20160520203038 23:10:44 INFO - mozversion application_changeset: 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 23:10:44 INFO - mozversion application_display_name: Nightly 23:10:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:10:44 INFO - mozversion application_name: Firefox 23:10:44 INFO - mozversion application_remotingname: firefox 23:10:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:10:44 INFO - mozversion application_vendor: Mozilla 23:10:44 INFO - mozversion application_version: 49.0a1 23:10:44 INFO - mozversion platform_buildid: 20160520203038 23:10:44 INFO - mozversion platform_changeset: 06d9362a57a10396f3f7c7989c21f1a416f4c7e9 23:10:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 23:10:44 INFO - mozversion platform_version: 49.0a1 23:10:44 INFO - using testdate: 1463811044 23:10:44 INFO - actual date: 1463811044 23:10:44 INFO - starting webserver on 'localhost:35641' 23:10:44 INFO - SUITE-START | Running 2 tests 23:10:44 INFO - TEST-START | dromaeo_css 23:10:44 INFO - operating with platform_type : linux_ 23:10:44 INFO - Initialising browser for dromaeo_css test... 23:10:44 INFO - TEST-INFO | started process 10224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRFrYph/profile http://localhost:35641/getInfo.html) 23:10:48 INFO - PROCESS | 10224 | __metrics Screen width/height:1600/1200 23:10:48 INFO - PROCESS | 10224 | colorDepth:24 23:10:48 INFO - PROCESS | 10224 | Browser inner width/height: 1024/697 23:10:48 INFO - PROCESS | 10224 | __metrics 23:10:49 ERROR - PROCESS | 10224 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:10:50 INFO - TEST-INFO | 10224: exit 0 23:10:50 INFO - Browser initialized. 23:10:50 INFO - Running cycle 1/1 for dromaeo_css test... 23:10:50 INFO - TEST-INFO | started process 10304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRFrYph/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:11:02 INFO - PROCESS | 10304 | RSS: Main: 153075712 23:11:02 INFO - PROCESS | 10304 | 23:11:53 INFO - PROCESS | 10304 | 1463811113455 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] 23:14:02 INFO - PROCESS | 10304 | Cycle 1(1): loaded http://localhost:35641/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35641/tests/dromaeo/cssquery-ext.html) 23:14:03 INFO - PROCESS | 10304 | RSS: Main: 256450560 23:14:03 INFO - PROCESS | 10304 | 23:17:05 INFO - PROCESS | 10304 | Cycle 1(1): loaded http://localhost:35641/tests/dromaeo/cssquery-ext.html (next: http://localhost:35641/tests/dromaeo/cssquery-jquery.html) 23:17:06 INFO - PROCESS | 10304 | RSS: Main: 242012160 23:17:06 INFO - PROCESS | 10304 | 23:20:08 INFO - PROCESS | 10304 | Cycle 1(1): loaded http://localhost:35641/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35641/tests/dromaeo/cssquery-mootools.html) 23:20:08 INFO - PROCESS | 10304 | RSS: Main: 237252608 23:20:08 INFO - PROCESS | 10304 | 23:23:10 INFO - PROCESS | 10304 | Cycle 1(1): loaded http://localhost:35641/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35641/tests/dromaeo/cssquery-prototype.html) 23:23:11 INFO - PROCESS | 10304 | RSS: Main: 234713088 23:23:11 INFO - PROCESS | 10304 | 23:26:13 INFO - PROCESS | 10304 | Cycle 1(1): loaded http://localhost:35641/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35641/tests/dromaeo/cssquery-yui.html) 23:26:14 INFO - PROCESS | 10304 | RSS: Main: 218615808 23:26:14 INFO - PROCESS | 10304 | 23:29:17 INFO - PROCESS | 10304 | Cycle 1(1): loaded http://localhost:35641/tests/dromaeo/cssquery-yui.html (next: http://localhost:35641/tests/dromaeo/cssquery-dojo.html) 23:29:17 INFO - PROCESS | 10304 | RSS: Main: 310358016 23:29:17 INFO - PROCESS | 10304 | 23:29:17 INFO - PROCESS | 10304 | __start_tp_report 23:29:17 INFO - PROCESS | 10304 | _x_x_mozilla_page_load 23:29:17 INFO - PROCESS | 10304 | _x_x_mozilla_page_load_details 23:29:17 INFO - PROCESS | 10304 | |i|pagename|runs| 23:29:17 INFO - PROCESS | 10304 | |0;dojo.html;3134.8275844828536;3152.9527057094133;3186.7928584641995;3200.80795152291;3209.9518507222383;5352;5389.407165211828;5415.539679127269;5498.120300751881;5565.053940830058;5444.128939369702;5446.2375267462585;5482.80810171644;5500.339959204891;5528.115501519757;4902.313676085342;4919.680220785655;5037.924431133536;5131.897362052757;5151.716655583941;5062.367204099488;5063.822766203184;5095.79616815327;5129.9230511542355;5136.178211486163;4808.831690890819;4854.247591623304;4922.114019476493;4926.704397736147;4941.950580494203;4936;4944.060628480577;4949.08441938239;4959.479254678243;5002.574781143607;4776.4268287805335;4896.779644915988;4927.137750893579;4938.876528086791;4974.7512624369;5386.67679939201;5452.863678408032;5473.28847249859;5531.529819965308;5558.221848941152;5925.940740592582;6001.969990150065;6003.219581454383;6012.368701286346;6013.278406591194;5707.400722924116;5797.275340582427;5815.389384114692;5850.76596936122;5858.3848695886745;5444.346678398618;5513.5037846594;5567.8886422271735;5573.21974923507;5575.832725018256;6028.457438830526;6043.576949613573;6049.092636104531;6049.879002420015;6079.483243924227;5597.048501754712;5712.65724056558;5728.455796699307;5822.039363505059;5830.795922142789;5915.112733089984;5951.940480595139;5973.074173503114;5977.970110149508;5979.730912108878;5841.065429531254;5847.736851841677;5885.323187833454;5900.911486327708;5907.527397808251;5661.518770904437;5707.4577915098;5760.51035661965;5768.480836724715;5922.555808314393;4405.7797110145;4407.801648925806;4411.470623525198;4425.513193548707;4443.844465443694;3919.6472317490993;3932.980335098306;3933.645971862546;3972.4239985201984;4007.318755811519;5392.272043274186;5444.128939369682;5462.863428414322;5501.477359650827;5526.198701188305;5870.853228669317;5901.852453688606;5908.4091590841435;5912.40875912414;5986.610870293417;5500.119980803052;5549.667019978814;5552.583556233299;5558.110702287615;5565.610407271533;4954.628402869799;5030.195168772979;5082.720450375191;5090.312807770978;5091.210862316273;6072.969635151884;6104.847378815565;6126.754929802847;6137.232845894263;6142.170806941006;5680.289963754531;5882.058870580687;5898.852528686645;5911.822645320647;5947.078202878561;6012.6392416455155;6085.543584231289;6105.725242364193;6111.083337499411;6165.106059621419;5780.566457515787;5798.652080874992;5825.76696932118;5826.533877289722;5833.066709326487;5704.3154821421695;5883.823485295448;5949.672767997802;5959.4934430573885;5962.344142144448;5808.5062769665055;5874.559408044328;5877.147813566923;5883.382244864228;5933.851653708692;5833;5835.4748072673665;5837.591368604157;5837.591368604327;5846.824595262149;5422.539084177889;5618.353889302783;5682.318121825408;5729.541636668973;5746.396628353963;5895.557833162444;5924.31870334917;5934.317553481233;5934.525237981037;5937.643741375531;5702.971485142548;5749.540036796962;5763.135529670415;5763.6541807491685;5809.5352371811 23:29:17 INFO - PROCESS | 10304 | |1;ext.html;604.727872457394;643.5237923936286;652.8237375908504;653.5523166630857;657.539722194464;30196.849015754946;42551.36172957404;43536.34695479563;43596;43609;44987.550124498746;45422.318665220046;45522.08955820881;45549;45549;8468.026176989648;8538.914610853873;8587.098354672764;8588.957055214714;8640.351973601973;8011.399145064114;8059.435839491238;8061.717839875606;8062.556559389232;8065.879011814827;8146.796330091765;8154.673813047471;8167.346612271004;8170.060443049037;8214.753557393287;8022.9598852005365;8070.999999999971;8071.23323284287;8085.919140808604;8138.674453021901;8737.30101591871;8759.211670949582;8812.559372031374;8823.514706691129;8827.073157318453;41136.38295425571;41370.172596548204;41618.37572436416;41695;41726.79136604328;3567.661072198137;3617.7286703497343;3675.0454647367974;3708.5364329458816;3733.6453036961716;32634.184145396317;32887.506687399706;33003.17492062694;33007.83496082504;34706.47940280873;4377.23398405281;4411.757353345564;4483.551644835523;4493.887652808673;4563.087382523476;329060;329153;329227;329595;330581;61274.69362653248;61316.08025879615;61606.69196653988;61656.69171654203;61811;36010.819945900104;36570.26859462849;64294.678526608004;64798.352016480174;64832.67583662052;15925.203739812963;16016.519504414886;16048;16050.75923861143;16061.839381606269;13535.729285414236;13655.317234138254;13663;13665;13665.18008919468;19611.31360402379;19846.511511636683;20120.89939550322;20129.194832206842;20156;7239.9276007240305;7281.927180728125;7314.318835945;7367.2264412235945;7510.774676759706;962.932594718377;1072.7586293083993;1125.58915995661;1136.539701420926;1150.6893138852631;32506.674933250837;32642;32792.180195495304;32848.34303313968;33121.3375732484;1149.706824759681;1201.5794471934928;1213.6905089202373;1238.8389509363726;1242.689327668083;17295.481135565955;17427.73858392125;17428.564285892953;17497.82502174962;17544.912275438543;506708;507978;510027;511455;513135;58167.418325817045;58801.35393907285;58804.41195588075;58817.70591147017;58969;1278.39276343736;1413.4840783114296;1438.4102517967583;1488.6501672107047;1602.7115119278408;30940.845295773375;33990.32019359648;34366;34418;34783.82608087044;52383.214251787016;52739;53064;53440.46559534355;53463.73268133635;454579;456094;459544;461596;462781;36958.44562331621;43734.12531749411;44261.11477770491;44945;45338;48613;49612.25581616206;50816.49183508118;53704;53868.19197711959;40538.59461405348;42486.36270455884;43145.3528197071;43367.34948975831;43512.34731479094;41247.381289281286;41781;41808.79095604503;41877.79061104675;42769;41504.58495415128;42096;42138.78930605327;42454;42654.36018459663;35524.64475355317;37186.25627487489;38003.80998094992;38309.61690383172;38443.231135376576;28553.42893142167;28720.281992950342;28851.5672264912;28875;29078.854605726836 23:29:17 INFO - PROCESS | 10304 | |2;jquery.html;376.4672987722373;379.96010418906013;383.867565689837;392.4211787613269;397.5229724330804;17964;19685.114169862354;20342.288019919306;20456.18175272989;20512.8974355128;18305.90847045763;18945.905270473628;18994.33519826803;19285.42143735687;19410.51473713158;5590.18942253374;5664.461876121762;5729.39841316662;5794.536437085044;5809.506191973687;5580.804671836487;5662.292213473316;5683.886322273552;5694.800681976131;5712.600117991742;5452.182172674091;5647.519960803316;5652.463016013472;5693.060644993571;5697.971510142444;5629.211910332536;5638.351589567191;5676.035074037382;5678.659280443187;5694.601377903548;4930.260460930889;5001.824936127255;5027.421846487664;5037.823676171316;5047.772850221712;23224.76775232243;23246.07015719369;23535.646965295535;23771.405714857094;23798;2384.391980045095;2466.3094333586623;2471.802255819548;2557.6930768307734;2568.4991426671804;14300.928495357457;14320.713585728332;14336.641583960485;14448.205348705817;14789.260536973108;1935.5644979879414;1978.7427634407436;2016.3346095788354;2072.4611600983703;2076.09689784944;57447.74301742904;58020;73773.8933915997;79516.20483795204;79984.60007699982;10352.171826253882;10404.167666586654;10447.05976462122;10574.048335649828;10644.627438039632;11980.820287695691;12668.93665531685;14452.783208251885;14454.710905781825;14457.78313325301;8009.159038301011;8095.838083238302;8142.83714325722;8266.669333226724;8277.668893244203;8182.386321025828;8236.752897413087;8248.13394593571;8355.248027677539;8412.411131220879;6478.125453063871;6503.447206987459;6556.475481961432;6568.244651865001;6572.539922205399;1673.1885035757648;1735.800382955951;1766.3729376071567;1796.6316905034437;1800.9549761256073;989.0318266649459;992.399598243067;1002.5288114586133;1070.175964507325;1101.2566517600587;18621.44135675932;18873.245070197037;19729.506762331057;19969.20123195056;20043.29848455297;995.0795514149528;1023.467796745688;1028.5217373921162;1041.2763129624989;1043.139409986764;11122.22144449897;11507.88492115085;11522.193446458836;11577.421128943688;11610.361430121424;442376;444999;452057;452952;460091;48811.75594122078;80844.19155808366;82279;82468.58765706133;82876;1072.6245813965206;1079.2607064160918;1090.8363745438248;1111.0944580167138;1120.0367683791933;18194;18233.544161396072;18616.255349785857;18628.627427451105;18908.527286817938;28914.710852892043;30148;32103.839480802446;36264.63735362612;41315;53614;54760;55586.72206638941;55802.72098639643;56377.87244255174;7519.473636845587;8465.238128568459;8590.65637374498;8607.311415086653;8618.965724113146;12494.375281236084;13494.730105398034;13648.112872663245;13659.79510307366;14137.36381862798;11722.355270460206;12035.398230088636;12100.394980250776;12334;12379.876201237872;7308.96345518269;9946.701598952042;11798.823017654913;11993.76012479728;12208.877911220774;11676.70808229801;12509.186902851285;12580.874191258337;12596.072160311975;12825.358732063547;8241.423100382915;8547.61535730906;8590.09803970599;8632.654693812177;8655.740327790176;8739.868901966604;10990.450477475933;11702.2978621283;12002.699932501757;12176.330301833485 23:29:17 INFO - PROCESS | 10304 | |3;mootools.html;1336.458734212643;1485.7845612386202;1507.547735679296;1657.3784830688492;1795.3716199330236;8514.787130321745;8880.600372983215;8889.644414223432;9202.033786452426;9204.263658907288;8970.192682658559;9158.908410915888;9160.816783664322;9168.816623667539;9173.220276276525;2061.6701327787555;2271.2277825539313;2354.72920614129;2379.3456799380137;2408.0247499762622;2399.796017338528;2439.2804122783823;2441.7924476419525;2442.0842184180933;2442.413820683032;2368.384220102777;2412.819038572114;2414.396400899775;2422.1764600035985;2423.6485709572103;2066.1528773202913;2317.721873375189;2383.988080059606;2394.6647469354302;2405.506871091422;2237.9216727414623;2241.484458574521;2254.7407048189502;2259.3899647095354;2260.062074239189;8870;8938.374313798036;8945.73162805117;8948.8657670135;8950.373473856833;5089;5261.158214685632;5267.420583735786;5271.973640131775;5282.97358513205;3359.6808303211155;3362.0922350965348;3433.0902310887636;3521.841517131735;3536.2220311531423;1040.588967357897;1076.4133547216786;1076.8546246256733;1096.6984079378235;1098.3135540287321;11843.881561184364;12036.81944770829;12055.156139070268;12061.758764824743;12065.879341206562;4422.314541246048;4478.776061196927;4570.634349252052;4571.588557029883;4573.474050484237;10346.172306215636;10375.27373083892;10382.273240873066;10393.792124157475;10395.740106497398;4778.95221047792;5045.394552653705;5098.745062746848;5120.667156634807;5124.846254612367;4706.647001474903;4845.466998630148;4849.2968519564465;4910.680805747615;4913.06651736169;4062.086030643141;4116.176764647083;4140.834366625361;4172.874813755592;4211.136716973013;1241.0878004666563;1245.5329251530677;1251.8560365557896;1261.8864302212844;1268.1756858042347;957.4733896356976;974.5176137811687;985.6402413119304;993.0615568288043;1010.3281317923498;5852.4440178183;5945.316288626776;5963.6051296393025;6027.60820546663;6111.908321375183;405.0885507607882;415.92929202035725;416.1012213618569;417.5365344467638;420.07583316703375;3976.5029371328583;4143.08852052548;4146.958530414718;4164.354525048622;4198.538160802309;10356.378617282837;11060.557577696964;11492.94253528727;11500.367479788692;11500.94249528747;11123.777524449466;11384.373859437645;11464.426778661034;11474.426278686033;11496.827547586792;8295.170482951657;8354.331653467709;8521.701740439179;8551.486910785248;8594.054653988056;5704.3725190228215;5744.827655170351;6279.937200627935;6325.367463253638;6417.518686098655;10246.38521688701;10304.124149447382;10754.569817207224;10777.08394786452;10812.891871081189;10797.352158870493;10805.891941080488;10807.783844323227;10900.563977440814;10904.890951090387;7622.390208783173;8343.624536895975;8595.44129631572;8672.523011234443;8838.955805220932;9030.45817250967;9039.186473217442;9081.137291957253;9097.59060842277;9113.772155695895;7869;8010.599470026359;8024.679012839421;8162.795930101795;8170.591470426574;7818.179091195342;7956.283934445928;8003.679852806055;8044.6379912902885;8090.83818323642;6718.764843230463;6726.596404215763;6864.3822056013205;6865.828354290983;6884.4148247399535;5012.899742005066;5044.167712327425;5083.440821509705;5166.3800343958965;5253.133233016662;5027.396712394536;5113.105206588906;5134.7946082156295;5205.817796377109;5326 23:29:17 INFO - PROCESS | 10304 | |4;prototype.html;305.81039755351685;312.31291159449216;315.4794588928268;316.9778115531913;323.5599584564992;5364.973175134124;5369.892602147955;5376.91934620981;5391.622586418952;5408.648437851547;5307.550092439916;5328.254044433782;5330.1610944224185;5363.302770639821;5381.19282107684;3914.9804250978777;4012.3179059559943;4126.174765046988;4134.607212314825;4145.54399016108;4090.1615168890453;4091.284025295561;4097.180563887219;4109.260333140033;4121.629053385194;3914.7651140931494;4105.527864295615;4114.773687447189;4128;4138.730982486129;3984.9003774905714;4065.7763822989723;4068.3490641497365;4086.325756250245;4089.1821635672686;3560.1099725068734;3569.7679650822874;3591.120175557005;3597.3524765542193;3598.5321908152036;5065.949340506585;5066.949330506684;5114.181730923035;5127.3847138343635;5135;4550.3402006709175;4696.976515117402;4705.882352941169;4736.83421080264;4754.334393184922;5523.502884740353;5529.25828364064;5542.63972841764;5556.222128901957;5564.33228012637;3959.8614048508166;3971.0866500705;3980.5223373195113;3986.3223252047223;3987.501562304712;5694.462495126334;5780.450857168562;5783.942160578383;5784.942150578482;5794.595242974161;4012.9398059029136;4018.4976877890263;4040.6565441937178;4043.211573743092;4062.959370406258;4079.9796001019804;4090.141070375195;4090.4477895484324;4092.4475195848777;4114.485689288839;4422.314541246048;4690.202665546797;4694.483606803249;4698.1778188816825;4699.835505757351;5593.636413633101;5619.831405057855;5637.830865074055;5667.546596272288;5670.064439367458;1392.3595146232847;1399.3353157250224;1405.7118290750373;1406.2336026865382;1416.3414012484245;873.3929918706565;881.2641444393875;887.7070566712969;903.1350261709549;936.7798567336671;5368.409474957752;5371.167469042305;5382.596305277119;5388.137897936312;5397.731533089721;5647.6893770843;5661.603687741818;5674.347450043298;5682.801101961494;5688.345840228344;5187.688738675692;5311.814086506954;5315.707636080053;5316.122839731401;5320.201969704575;3041.4829478988627;3041.9201183579953;3043.7412819910555;3054.633443986736;3079.16862447138;5857.326407463196;5908.527317814564;5910.704464776744;5915.319738230072;5938.940610593925;5607.915646394548;5762.703391736825;5814.505767009767;5877.52979761618;5883.264591926009;5814.186013958049;5847.883042339129;5852.209951656557;5886.499647530008;5898.616589921641;5533.391326954113;5570.58220633446;5670.234518340137;5739.741711623071;5741.483266506035;5601.411851755507;5601.747921343631;5626.493615574618;5633.6619802811965;5645;5795.76816927335;5848.64908105515;5848.883022339614;5869.53043756507;5880.558958078076;3867.7099217559357;3988.364770444104;4011.7793521356607;4019.1559772448113;4026.375911733686;5647.915281270866;5692.068584678811;5754.165645981226;5775.94224057754;5780.514378817149;5399.70301633414;5571.582131340247;5584.888302234014;5677.943220567741;5708.65748055118;5572.86067848307;5601.943980560305;5618.943810562006;5623.971880140573;5637.8590535236945;5277.577793776411;5526.784107496344;5544.69504177258;5553.361363443256;5569.610127291051;5702.942970570241;5713.485786279255;5717.141928873049;5719.370869204301;5752.769889204553;5594.888102237851;5608.298962629671;5610.943890561042;5613.438656134354;5617.7191140442 23:29:17 INFO - PROCESS | 10304 | |5;yui.html;710.9253528379523;824.1223097401268;854.9016863060746;856.0540602634089;872.6073267029839;15067.17130557819;15633.765493517607;15657.921710391432;15744.527664170078;15745.999999999985;14449.205293708868;14464.783028254584;14479.34842932068;14485.275736213174;14491;663.3300366629702;790.7509134622604;798.2336956521746;812.0296245986049;812.212154210415;769.2422963381065;776.6427443376053;777.0636383158309;779.8479296537178;781.0159199408757;829.9709510167145;831.6590198018813;831.7587899509165;832.097174565597;832.1886160993043;706.3395724997118;832.063928080909;850.158343240194;855.4738835616114;856.1395797223812;620.2618883528587;622.5237693164732;626.8182227154119;626.8307556959595;626.9811905642838;13824.101433406897;13878.375473103735;13899.722005559934;13909.234992075431;13923;13562.93218533901;13746;13757;13867.791983120262;14133.293335333192;12469.75060498794;12539;12566;12593.244405335618;13208.801867971988;4397.340398940152;4432.955670443286;4473.798679059418;4506.143832671782;4545.818167273305;57976.71011644957;58030;58215.41784582142;58532;59314.40685593132;11449.198556100993;11474.368909710047;11547.711307217218;11571.710707232387;11613.593524226611;20551.177952882015;20578.176872924916;20681.89659051725;20684.379468615967;20785.58428831415;8336.87494687568;8583;8587.441816281922;8634.956825215833;8695;4681.882952926204;4760.476347601761;4779.784909679072;4781.163296423112;4974.328465657162;3450.6376830432946;3514.525539052246;3554.573451185874;3555.2178520725397;3555.7510974232073;660.9669516524154;666.2770893580423;669.3641041011059;672.8149758816364;677.8373190434261;624.753222477119;638.9042791612407;642.0593680941278;642.4378668664918;716.8996340512332;9458.810823783486;9658.179054780423;9662.806743865083;9662.951685241529;9737.318387712934;658.5949640970769;702.9121359830021;725.2457444257913;731.2431633259657;748.913874904393;4168.708190426702;4288.48538175421;4411.514733379326;4427.512973572904;4461.353103799996;63181.36818631847;63672.67764207176;64155;66029.33970660328;67575.3242467569;59308;59740.40259597435;60781;61385;61914.69042654758;54039.45960540344;54573.72713136488;54635.180472292945;54980.450195498335;55318.44681553133;8751.956240218758;8807.253617851466;8812.51531165792;8886.955565222133;8890.19988201039;37011;37338.8133059333;37517.24965500729;37607.62392376041;38146;44872.102557949314;47949.520504794506;48485;48584.271235930784;48878.26682599693;11083.113350932068;11263.718407039889;11549.595764148215;11613.825792613286;11635.301881887113;11493.080553555863;11800.173987821114;11866.347350895783;12089.214201076902;12729.87270127324;11470.311781293149;11649.650510484698;11774.3524106175;11811.704707382385;11996.820047699117;11411.885881141083;11635.5927542539;11973.880261197624;11993.700157495783;12011.819822702491;11590.246633968765;11771.882281177079;11907;11929.164958452826;12436.440360183995;9530.189933855423;9690.903090969001;9746.80506389854;9816.901830981598;9964.252681048805;9160;9253.213476854542;9562.495638911849;9617;9934.155596774355 23:29:17 INFO - PROCESS | 10304 | __end_tp_report 23:29:17 INFO - PROCESS | 10304 | __start_cc_report 23:29:17 INFO - PROCESS | 10304 | _x_x_mozilla_cycle_collect,904 23:29:17 INFO - PROCESS | 10304 | __end_cc_report 23:29:17 INFO - PROCESS | 10304 | __startTimestamp1463812157400__endTimestamp 23:29:17 INFO - PROCESS | 10304 | 23:29:17 INFO - PROCESS | 10304 | ------- Summary: start ------- 23:29:17 INFO - PROCESS | 10304 | Number of tests: 6 23:29:17 INFO - PROCESS | 10304 | 23:29:17 INFO - PROCESS | 10304 | [#0] dojo.html Cycles:165 Average:5465.07 Median:5704.32 stddev:643.13 (11.3%) stddev-sans-first:618.58 23:29:17 INFO - PROCESS | 10304 | Values: 3134.8 3153.0 3186.8 3200.8 3210.0 5352.0 5389.4 5415.5 5498.1 5565.1 5444.1 5446.2 5482.8 5500.3 5528.1 4902.3 4919.7 5037.9 5131.9 5151.7 5062.4 5063.8 5095.8 5129.9 5136.2 4808.8 4854.2 4922.1 4926.7 4942.0 4936.0 4944.1 4949.1 4959.5 5002.6 4776.4 4896.8 4927.1 4938.9 4974.8 5386.7 5452.9 5473.3 5531.5 5558.2 5925.9 6002.0 6003.2 6012.4 6013.3 5707.4 5797.3 5815.4 5850.8 5858.4 5444.3 5513.5 5567.9 5573.2 5575.8 6028.5 6043.6 6049.1 6049.9 6079.5 5597.0 5712.7 5728.5 5822.0 5830.8 5915.1 5951.9 5973.1 5978.0 5979.7 5841.1 5847.7 5885.3 5900.9 5907.5 5661.5 5707.5 5760.5 5768.5 5922.6 4405.8 4407.8 4411.5 4425.5 4443.8 3919.6 3933.0 3933.6 3972.4 4007.3 5392.3 5444.1 5462.9 5501.5 5526.2 5870.9 5901.9 5908.4 5912.4 5986.6 5500.1 5549.7 5552.6 5558.1 5565.6 4954.6 5030.2 5082.7 5090.3 5091.2 6073.0 6104.8 6126.8 6137.2 6142.2 5680.3 5882.1 5898.9 5911.8 5947.1 6012.6 6085.5 6105.7 6111.1 6165.1 5780.6 5798.7 5825.8 5826.5 5833.1 5704.3 5883.8 5949.7 5959.5 5962.3 5808.5 5874.6 5877.1 5883.4 5933.9 5833.0 5835.5 5837.6 5837.6 5846.8 5422.5 5618.4 5682.3 5729.5 5746.4 5895.6 5924.3 5934.3 5934.5 5937.6 5703.0 5749.5 5763.1 5763.7 5809.5 23:29:17 INFO - PROCESS | 10304 | 23:29:17 INFO - PROCESS | 10304 | [#1] ext.html Cycles:180 Average:60226.32 Median:42957.18 stddev:116288.83 (270.7%) stddev-sans-first:116528.89 23:29:17 INFO - PROCESS | 10304 | Values: 604.7 643.5 652.8 653.6 657.5 30196.8 42551.4 43536.3 43596.0 43609.0 44987.6 45422.3 45522.1 45549.0 45549.0 8468.0 8538.9 8587.1 8589.0 8640.4 8011.4 8059.4 8061.7 8062.6 8065.9 8146.8 8154.7 8167.3 8170.1 8214.8 8023.0 8071.0 8071.2 8085.9 8138.7 8737.3 8759.2 8812.6 8823.5 8827.1 41136.4 41370.2 41618.4 41695.0 41726.8 3567.7 3617.7 3675.0 3708.5 3733.6 32634.2 32887.5 33003.2 33007.8 34706.5 4377.2 4411.8 4483.6 4493.9 4563.1 329060.0 329153.0 329227.0 329595.0 330581.0 61274.7 61316.1 61606.7 61656.7 61811.0 36010.8 36570.3 64294.7 64798.4 64832.7 15925.2 16016.5 16048.0 16050.8 16061.8 13535.7 13655.3 13663.0 13665.0 13665.2 19611.3 19846.5 20120.9 20129.2 20156.0 7239.9 7281.9 7314.3 7367.2 7510.8 962.9 1072.8 1125.6 1136.5 1150.7 32506.7 32642.0 32792.2 32848.3 33121.3 1149.7 1201.6 1213.7 1238.8 1242.7 17295.5 17427.7 17428.6 17497.8 17544.9 506708.0 507978.0 510027.0 511455.0 513135.0 58167.4 58801.4 58804.4 58817.7 58969.0 1278.4 1413.5 1438.4 1488.7 1602.7 30940.8 33990.3 34366.0 34418.0 34783.8 52383.2 52739.0 53064.0 53440.5 53463.7 454579.0 456094.0 459544.0 461596.0 462781.0 36958.4 43734.1 44261.1 44945.0 45338.0 48613.0 49612.3 50816.5 53704.0 53868.2 40538.6 42486.4 43145.4 43367.3 43512.3 41247.4 41781.0 41808.8 41877.8 42769.0 41504.6 42096.0 42138.8 42454.0 42654.4 35524.6 37186.3 38003.8 38309.6 38443.2 28553.4 28720.3 28851.6 28875.0 29078.9 23:29:17 INFO - PROCESS | 10304 | 23:29:17 INFO - PROCESS | 10304 | [#2] jquery.html Cycles:180 Average:27002.84 Median:2469.06 stddev:73929.05 (2994.2%) stddev-sans-first:74109.41 23:29:17 INFO - PROCESS | 10304 | Values: 376.5 380.0 383.9 392.4 397.5 17964.0 19685.1 20342.3 20456.2 20512.9 18305.9 18945.9 18994.3 19285.4 19410.5 5590.2 5664.5 5729.4 5794.5 5809.5 5580.8 5662.3 5683.9 5694.8 5712.6 5452.2 5647.5 5652.5 5693.1 5698.0 5629.2 5638.4 5676.0 5678.7 5694.6 4930.3 5001.8 5027.4 5037.8 5047.8 23224.8 23246.1 23535.6 23771.4 23798.0 2384.4 2466.3 2471.8 2557.7 2568.5 14300.9 14320.7 14336.6 14448.2 14789.3 1935.6 1978.7 2016.3 2072.5 2076.1 57447.7 58020.0 73773.9 79516.2 79984.6 10352.2 10404.2 10447.1 10574.0 10644.6 11980.8 12668.9 14452.8 14454.7 14457.8 8009.2 8095.8 8142.8 8266.7 8277.7 8182.4 8236.8 8248.1 8355.2 8412.4 6478.1 6503.4 6556.5 6568.2 6572.5 1673.2 1735.8 1766.4 1796.6 1801.0 989.0 992.4 1002.5 1070.2 1101.3 18621.4 18873.2 19729.5 19969.2 20043.3 995.1 1023.5 1028.5 1041.3 1043.1 11122.2 11507.9 11522.2 11577.4 11610.4 442376.0 444999.0 452057.0 452952.0 460091.0 48811.8 80844.2 82279.0 82468.6 82876.0 1072.6 1079.3 1090.8 1111.1 1120.0 18194.0 18233.5 18616.3 18628.6 18908.5 28914.7 30148.0 32103.8 36264.6 41315.0 53614.0 54760.0 55586.7 55802.7 56377.9 7519.5 8465.2 8590.7 8607.3 8619.0 12494.4 13494.7 13648.1 13659.8 14137.4 11722.4 12035.4 12100.4 12334.0 12379.9 7309.0 9946.7 11798.8 11993.8 12208.9 11676.7 12509.2 12580.9 12596.1 12825.4 8241.4 8547.6 8590.1 8632.7 8655.7 8739.9 10990.5 11702.3 12002.7 12176.3 23:29:17 INFO - PROCESS | 10304 | 23:29:17 INFO - PROCESS | 10304 | [#3] mootools.html Cycles:180 Average:5912.62 Median:4316.73 stddev:3438.16 (79.6%) stddev-sans-first:3430.60 23:29:17 INFO - PROCESS | 10304 | Values: 1336.5 1485.8 1507.5 1657.4 1795.4 8514.8 8880.6 8889.6 9202.0 9204.3 8970.2 9158.9 9160.8 9168.8 9173.2 2061.7 2271.2 2354.7 2379.3 2408.0 2399.8 2439.3 2441.8 2442.1 2442.4 2368.4 2412.8 2414.4 2422.2 2423.6 2066.2 2317.7 2384.0 2394.7 2405.5 2237.9 2241.5 2254.7 2259.4 2260.1 8870.0 8938.4 8945.7 8948.9 8950.4 5089.0 5261.2 5267.4 5272.0 5283.0 3359.7 3362.1 3433.1 3521.8 3536.2 1040.6 1076.4 1076.9 1096.7 1098.3 11843.9 12036.8 12055.2 12061.8 12065.9 4422.3 4478.8 4570.6 4571.6 4573.5 10346.2 10375.3 10382.3 10393.8 10395.7 4779.0 5045.4 5098.7 5120.7 5124.8 4706.6 4845.5 4849.3 4910.7 4913.1 4062.1 4116.2 4140.8 4172.9 4211.1 1241.1 1245.5 1251.9 1261.9 1268.2 957.5 974.5 985.6 993.1 1010.3 5852.4 5945.3 5963.6 6027.6 6111.9 405.1 415.9 416.1 417.5 420.1 3976.5 4143.1 4147.0 4164.4 4198.5 10356.4 11060.6 11492.9 11500.4 11500.9 11123.8 11384.4 11464.4 11474.4 11496.8 8295.2 8354.3 8521.7 8551.5 8594.1 5704.4 5744.8 6279.9 6325.4 6417.5 10246.4 10304.1 10754.6 10777.1 10812.9 10797.4 10805.9 10807.8 10900.6 10904.9 7622.4 8343.6 8595.4 8672.5 8839.0 9030.5 9039.2 9081.1 9097.6 9113.8 7869.0 8010.6 8024.7 8162.8 8170.6 7818.2 7956.3 8003.7 8044.6 8090.8 6718.8 6726.6 6864.4 6865.8 6884.4 5012.9 5044.2 5083.4 5166.4 5253.1 5027.4 5113.1 5134.8 5205.8 5326.0 23:29:17 INFO - PROCESS | 10304 | 23:29:17 INFO - PROCESS | 10304 | [#4] prototype.html Cycles:180 Average:4681.29 Median:5381.89 stddev:1396.06 (25.9%) stddev-sans-first:1360.80 23:29:17 INFO - PROCESS | 10304 | Values: 305.8 312.3 315.5 317.0 323.6 5365.0 5369.9 5376.9 5391.6 5408.6 5307.6 5328.3 5330.2 5363.3 5381.2 3915.0 4012.3 4126.2 4134.6 4145.5 4090.2 4091.3 4097.2 4109.3 4121.6 3914.8 4105.5 4114.8 4128.0 4138.7 3984.9 4065.8 4068.3 4086.3 4089.2 3560.1 3569.8 3591.1 3597.4 3598.5 5065.9 5066.9 5114.2 5127.4 5135.0 4550.3 4697.0 4705.9 4736.8 4754.3 5523.5 5529.3 5542.6 5556.2 5564.3 3959.9 3971.1 3980.5 3986.3 3987.5 5694.5 5780.5 5783.9 5784.9 5794.6 4012.9 4018.5 4040.7 4043.2 4063.0 4080.0 4090.1 4090.4 4092.4 4114.5 4422.3 4690.2 4694.5 4698.2 4699.8 5593.6 5619.8 5637.8 5667.5 5670.1 1392.4 1399.3 1405.7 1406.2 1416.3 873.4 881.3 887.7 903.1 936.8 5368.4 5371.2 5382.6 5388.1 5397.7 5647.7 5661.6 5674.3 5682.8 5688.3 5187.7 5311.8 5315.7 5316.1 5320.2 3041.5 3041.9 3043.7 3054.6 3079.2 5857.3 5908.5 5910.7 5915.3 5938.9 5607.9 5762.7 5814.5 5877.5 5883.3 5814.2 5847.9 5852.2 5886.5 5898.6 5533.4 5570.6 5670.2 5739.7 5741.5 5601.4 5601.7 5626.5 5633.7 5645.0 5795.8 5848.6 5848.9 5869.5 5880.6 3867.7 3988.4 4011.8 4019.2 4026.4 5647.9 5692.1 5754.2 5775.9 5780.5 5399.7 5571.6 5584.9 5677.9 5708.7 5572.9 5601.9 5618.9 5624.0 5637.9 5277.6 5526.8 5544.7 5553.4 5569.6 5702.9 5713.5 5717.1 5719.4 5752.8 5594.9 5608.3 5610.9 5613.4 5617.7 23:29:17 INFO - PROCESS | 10304 | 23:29:17 INFO - PROCESS | 10304 | [#5] yui.html Cycles:180 Average:15432.64 Median:54306.59 stddev:18442.28 (34.0%) stddev-sans-first:18460.88 23:29:17 INFO - PROCESS | 10304 | Values: 710.9 824.1 854.9 856.1 872.6 15067.2 15633.8 15657.9 15744.5 15746.0 14449.2 14464.8 14479.3 14485.3 14491.0 663.3 790.8 798.2 812.0 812.2 769.2 776.6 777.1 779.8 781.0 830.0 831.7 831.8 832.1 832.2 706.3 832.1 850.2 855.5 856.1 620.3 622.5 626.8 626.8 627.0 13824.1 13878.4 13899.7 13909.2 13923.0 13562.9 13746.0 13757.0 13867.8 14133.3 12469.8 12539.0 12566.0 12593.2 13208.8 4397.3 4433.0 4473.8 4506.1 4545.8 57976.7 58030.0 58215.4 58532.0 59314.4 11449.2 11474.4 11547.7 11571.7 11613.6 20551.2 20578.2 20681.9 20684.4 20785.6 8336.9 8583.0 8587.4 8635.0 8695.0 4681.9 4760.5 4779.8 4781.2 4974.3 3450.6 3514.5 3554.6 3555.2 3555.8 661.0 666.3 669.4 672.8 677.8 624.8 638.9 642.1 642.4 716.9 9458.8 9658.2 9662.8 9663.0 9737.3 658.6 702.9 725.2 731.2 748.9 4168.7 4288.5 4411.5 4427.5 4461.4 63181.4 63672.7 64155.0 66029.3 67575.3 59308.0 59740.4 60781.0 61385.0 61914.7 54039.5 54573.7 54635.2 54980.5 55318.4 8752.0 8807.3 8812.5 8887.0 8890.2 37011.0 37338.8 37517.2 37607.6 38146.0 44872.1 47949.5 48485.0 48584.3 48878.3 11083.1 11263.7 11549.6 11613.8 11635.3 11493.1 11800.2 11866.3 12089.2 12729.9 11470.3 11649.7 11774.4 11811.7 11996.8 11411.9 11635.6 11973.9 11993.7 12011.8 11590.2 11771.9 11907.0 11929.2 12436.4 9530.2 9690.9 9746.8 9816.9 9964.3 9160.0 9253.2 9562.5 9617.0 9934.2 23:29:17 INFO - PROCESS | 10304 | -------- Summary: end -------- 23:29:17 INFO - PROCESS | 10304 | 23:29:18 INFO - TEST-INFO | 10304: exit 0 23:29:18 INFO - TEST-OK | dromaeo_css | took 1113883ms 23:29:18 INFO - TEST-START | kraken 23:29:18 INFO - operating with platform_type : linux_ 23:29:18 INFO - Initialising browser for kraken test... 23:29:18 INFO - TEST-INFO | started process 10486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJlqzJM/profile http://localhost:35641/getInfo.html) 23:29:23 INFO - PROCESS | 10486 | __metrics Screen width/height:1600/1200 23:29:23 INFO - PROCESS | 10486 | colorDepth:24 23:29:23 INFO - PROCESS | 10486 | Browser inner width/height: 1024/697 23:29:23 INFO - PROCESS | 10486 | __metrics 23:29:24 ERROR - PROCESS | 10486 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:29:25 INFO - TEST-INFO | 10486: exit 0 23:29:25 INFO - Browser initialized. 23:29:25 INFO - Running cycle 1/1 for kraken test... 23:29:25 INFO - TEST-INFO | started process 10572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJlqzJM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:29:37 INFO - PROCESS | 10572 | RSS: Main: 153354240 23:29:37 INFO - PROCESS | 10572 | 23:29:40 INFO - PROCESS | 10572 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35641/tests/kraken/driver.html?testName=audio-beat-detection) 23:29:40 INFO - PROCESS | 10572 | RSS: Main: 209727488 23:29:40 INFO - PROCESS | 10572 | 23:29:43 INFO - PROCESS | 10572 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35641/tests/kraken/driver.html?testName=audio-dft) 23:29:44 INFO - PROCESS | 10572 | RSS: Main: 196898816 23:29:44 INFO - PROCESS | 10572 | 23:29:47 INFO - PROCESS | 10572 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35641/tests/kraken/driver.html?testName=audio-fft) 23:29:48 INFO - PROCESS | 10572 | RSS: Main: 265842688 23:29:48 INFO - PROCESS | 10572 | 23:29:50 INFO - PROCESS | 10572 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35641/tests/kraken/driver.html?testName=audio-oscillator) 23:29:50 INFO - PROCESS | 10572 | RSS: Main: 175308800 23:29:50 INFO - PROCESS | 10572 | 23:29:53 INFO - PROCESS | 10572 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35641/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:29:53 INFO - PROCESS | 10572 | RSS: Main: 179597312 23:29:53 INFO - PROCESS | 10572 | 23:29:56 INFO - PROCESS | 10572 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35641/tests/kraken/driver.html?testName=imaging-darkroom) 23:29:57 INFO - PROCESS | 10572 | RSS: Main: 214982656 23:29:57 INFO - PROCESS | 10572 | 23:30:01 INFO - PROCESS | 10572 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35641/tests/kraken/driver.html?testName=imaging-desaturate) 23:30:01 INFO - PROCESS | 10572 | RSS: Main: 213737472 23:30:01 INFO - PROCESS | 10572 | 23:30:04 INFO - PROCESS | 10572 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35641/tests/kraken/driver.html?testName=json-parse-financial) 23:30:05 INFO - PROCESS | 10572 | RSS: Main: 214290432 23:30:05 INFO - PROCESS | 10572 | 23:30:07 INFO - PROCESS | 10572 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35641/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:30:07 INFO - PROCESS | 10572 | RSS: Main: 204554240 23:30:07 INFO - PROCESS | 10572 | 23:30:09 INFO - PROCESS | 10572 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35641/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:30:10 INFO - PROCESS | 10572 | RSS: Main: 206626816 23:30:10 INFO - PROCESS | 10572 | 23:30:12 INFO - PROCESS | 10572 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35641/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:30:12 INFO - PROCESS | 10572 | RSS: Main: 216436736 23:30:12 INFO - PROCESS | 10572 | 23:30:15 INFO - PROCESS | 10572 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:30:16 INFO - PROCESS | 10572 | RSS: Main: 222425088 23:30:16 INFO - PROCESS | 10572 | 23:30:18 INFO - PROCESS | 10572 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:30:19 INFO - PROCESS | 10572 | RSS: Main: 220704768 23:30:19 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | Cycle 1(1): loaded http://localhost:35641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35641/tests/kraken/driver.html?testName=ai-astar) 23:30:21 INFO - PROCESS | 10572 | RSS: Main: 266997760 23:30:21 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | __start_tp_report 23:30:21 INFO - PROCESS | 10572 | _x_x_mozilla_page_load 23:30:21 INFO - PROCESS | 10572 | _x_x_mozilla_page_load_details 23:30:21 INFO - PROCESS | 10572 | |i|pagename|runs| 23:30:21 INFO - PROCESS | 10572 | |0;ai-astar;109;105;112;111;108;108;109;109;111;110 23:30:21 INFO - PROCESS | 10572 | |1;audio-beat-detection;154;130;125;209;122;124;150;131;152;125 23:30:21 INFO - PROCESS | 10572 | |2;audio-dft;161;161;159;159;159;161;162;162;163;162 23:30:21 INFO - PROCESS | 10572 | |3;audio-fft;74;75;75;135;76;75;75;76;116;75 23:30:21 INFO - PROCESS | 10572 | |4;audio-oscillator;93;92;161;91;93;92;129;91;92;127 23:30:21 INFO - PROCESS | 10572 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;116;116;117 23:30:21 INFO - PROCESS | 10572 | |6;imaging-darkroom;146;148;147;149;148;149;146;154;147;146 23:30:21 INFO - PROCESS | 10572 | |7;imaging-desaturate;96;96;95;94;95;96;96;95;95;95 23:30:21 INFO - PROCESS | 10572 | |8;json-parse-financial;55;55;55;54;56;54;55;108;54;53 23:30:21 INFO - PROCESS | 10572 | |9;json-stringify-tinderbox;61;62;61;62;61;61;62;62;62;62 23:30:21 INFO - PROCESS | 10572 | |10;stanford-crypto-aes;78;78;84;78;81;78;87;78;86;85 23:30:21 INFO - PROCESS | 10572 | |11;stanford-crypto-ccm;120;121;135;127;120;119;118;120;208;119 23:30:21 INFO - PROCESS | 10572 | |12;stanford-crypto-pbkdf2;161;161;156;154;159;156;158;157;160;161 23:30:21 INFO - PROCESS | 10572 | |13;stanford-crypto-sha256-iterative;61;62;62;63;71;65;61;63;62;65 23:30:21 INFO - PROCESS | 10572 | __end_tp_report 23:30:21 INFO - PROCESS | 10572 | __start_cc_report 23:30:21 INFO - PROCESS | 10572 | _x_x_mozilla_cycle_collect,1866 23:30:21 INFO - PROCESS | 10572 | __end_cc_report 23:30:21 INFO - PROCESS | 10572 | __startTimestamp1463812221418__endTimestamp 23:30:21 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | ------- Summary: start ------- 23:30:21 INFO - PROCESS | 10572 | Number of tests: 14 23:30:21 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | [#0] ai-astar Cycles:10 Average:109.20 Median:109.50 stddev:1.99 (1.8%) stddev-sans-first:2.11 23:30:21 INFO - PROCESS | 10572 | Values: 109.0 105.0 112.0 111.0 108.0 108.0 109.0 109.0 111.0 110.0 23:30:21 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:140.50 stddev:26.59 (18.9%) stddev-sans-first:27.86 23:30:21 INFO - PROCESS | 10572 | Values: 154.0 130.0 125.0 209.0 122.0 124.0 150.0 131.0 152.0 125.0 23:30:21 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.45 (0.9%) stddev-sans-first:1.54 23:30:21 INFO - PROCESS | 10572 | Values: 161.0 161.0 159.0 159.0 159.0 161.0 162.0 162.0 163.0 162.0 23:30:21 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | [#3] audio-fft Cycles:10 Average:85.20 Median:75.00 stddev:21.71 (29.0%) stddev-sans-first:22.65 23:30:21 INFO - PROCESS | 10572 | Values: 74.0 75.0 75.0 135.0 76.0 75.0 75.0 76.0 116.0 75.0 23:30:21 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | [#4] audio-oscillator Cycles:10 Average:106.10 Median:92.00 stddev:24.43 (26.6%) stddev-sans-first:25.45 23:30:21 INFO - PROCESS | 10572 | Values: 93.0 92.0 161.0 91.0 93.0 92.0 129.0 91.0 92.0 127.0 23:30:21 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:30:21 INFO - PROCESS | 10572 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 23:30:21 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:2.40 (1.6%) stddev-sans-first:2.44 23:30:21 INFO - PROCESS | 10572 | Values: 146.0 148.0 147.0 149.0 148.0 149.0 146.0 154.0 147.0 146.0 23:30:21 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 23:30:21 INFO - PROCESS | 10572 | Values: 96.0 96.0 95.0 94.0 95.0 96.0 96.0 95.0 95.0 95.0 23:30:21 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:55.00 stddev:16.92 (30.8%) stddev-sans-first:17.85 23:30:21 INFO - PROCESS | 10572 | Values: 55.0 55.0 55.0 54.0 56.0 54.0 55.0 108.0 54.0 53.0 23:30:21 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 23:30:21 INFO - PROCESS | 10572 | Values: 61.0 62.0 61.0 62.0 61.0 61.0 62.0 62.0 62.0 62.0 23:30:21 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:82.50 stddev:3.80 (4.6%) stddev-sans-first:3.84 23:30:21 INFO - PROCESS | 10572 | Values: 78.0 78.0 84.0 78.0 81.0 78.0 87.0 78.0 86.0 85.0 23:30:21 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:120.50 stddev:27.65 (22.9%) stddev-sans-first:29.05 23:30:21 INFO - PROCESS | 10572 | Values: 120.0 121.0 135.0 127.0 120.0 119.0 118.0 120.0 208.0 119.0 23:30:21 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:159.50 stddev:2.50 (1.6%) stddev-sans-first:2.45 23:30:21 INFO - PROCESS | 10572 | Values: 161.0 161.0 156.0 154.0 159.0 156.0 158.0 157.0 160.0 161.0 23:30:21 INFO - PROCESS | 10572 | 23:30:21 INFO - PROCESS | 10572 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:2.99 (4.7%) stddev-sans-first:3.03 23:30:21 INFO - PROCESS | 10572 | Values: 61.0 62.0 62.0 63.0 71.0 65.0 61.0 63.0 62.0 65.0 23:30:21 INFO - PROCESS | 10572 | -------- Summary: end -------- 23:30:21 INFO - PROCESS | 10572 | 23:30:22 INFO - TEST-INFO | 10572: exit 0 23:30:22 INFO - TEST-OK | kraken | took 64369ms 23:30:22 INFO - SUITE-END | took 1178s 23:30:22 INFO - Completed test suite (00:19:38) 23:30:22 INFO - javascript benchmark 23:30:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3134.8275844828536, 3152.9527057094133, 3186.7928584641995, 3200.80795152291, 3209.9518507222383, 5352.0, 5389.407165211828, 5415.539679127269, 5498.120300751881, 5565.053940830058, 5444.128939369702, 5446.2375267462585, 5482.80810171644, 5500.339959204891, 5528.115501519757, 4902.313676085342, 4919.680220785655, 5037.924431133536, 5131.897362052757, 5151.716655583941, 5062.367204099488, 5063.822766203184, 5095.79616815327, 5129.9230511542355, 5136.178211486163, 4808.831690890819, 4854.247591623304, 4922.114019476493, 4926.704397736147, 4941.950580494203, 4936.0, 4944.060628480577, 4949.08441938239, 4959.479254678243, 5002.574781143607, 4776.4268287805335, 4896.779644915988, 4927.137750893579, 4938.876528086791, 4974.7512624369, 5386.67679939201, 5452.863678408032, 5473.28847249859, 5531.529819965308, 5558.221848941152, 5925.940740592582, 6001.969990150065, 6003.219581454383, 6012.368701286346, 6013.278406591194, 5707.400722924116, 5797.275340582427, 5815.389384114692, 5850.76596936122, 5858.3848695886745, 5444.346678398618, 5513.5037846594, 5567.8886422271735, 5573.21974923507, 5575.832725018256, 6028.457438830526, 6043.576949613573, 6049.092636104531, 6049.879002420015, 6079.483243924227, 5597.048501754712, 5712.65724056558, 5728.455796699307, 5822.039363505059, 5830.795922142789, 5915.112733089984, 5951.940480595139, 5973.074173503114, 5977.970110149508, 5979.730912108878, 5841.065429531254, 5847.736851841677, 5885.323187833454, 5900.911486327708, 5907.527397808251, 5661.518770904437, 5707.4577915098, 5760.51035661965, 5768.480836724715, 5922.555808314393, 4405.7797110145, 4407.801648925806, 4411.470623525198, 4425.513193548707, 4443.844465443694, 3919.6472317490993, 3932.980335098306, 3933.645971862546, 3972.4239985201984, 4007.318755811519, 5392.272043274186, 5444.128939369682, 5462.863428414322, 5501.477359650827, 5526.198701188305, 5870.853228669317, 5901.852453688606, 5908.4091590841435, 5912.40875912414, 5986.610870293417, 5500.119980803052, 5549.667019978814, 5552.583556233299, 5558.110702287615, 5565.610407271533, 4954.628402869799, 5030.195168772979, 5082.720450375191, 5090.312807770978, 5091.210862316273, 6072.969635151884, 6104.847378815565, 6126.754929802847, 6137.232845894263, 6142.170806941006, 5680.289963754531, 5882.058870580687, 5898.852528686645, 5911.822645320647, 5947.078202878561, 6012.6392416455155, 6085.543584231289, 6105.725242364193, 6111.083337499411, 6165.106059621419, 5780.566457515787, 5798.652080874992, 5825.76696932118, 5826.533877289722, 5833.066709326487, 5704.3154821421695, 5883.823485295448, 5949.672767997802, 5959.4934430573885, 5962.344142144448, 5808.5062769665055, 5874.559408044328, 5877.147813566923, 5883.382244864228, 5933.851653708692, 5833.0, 5835.4748072673665, 5837.591368604157, 5837.591368604327, 5846.824595262149, 5422.539084177889, 5618.353889302783, 5682.318121825408, 5729.541636668973, 5746.396628353963, 5895.557833162444, 5924.31870334917, 5934.317553481233, 5934.525237981037, 5937.643741375531, 5702.971485142548, 5749.540036796962, 5763.135529670415, 5763.6541807491685, 5809.5352371811], "value": 5420.292492914342, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.727872457394, 643.5237923936286, 652.8237375908504, 653.5523166630857, 657.539722194464, 30196.849015754946, 42551.36172957404, 43536.34695479563, 43596.0, 43609.0, 44987.550124498746, 45422.318665220046, 45522.08955820881, 45549.0, 45549.0, 8468.026176989648, 8538.914610853873, 8587.098354672764, 8588.957055214714, 8640.351973601973, 8011.399145064114, 8059.435839491238, 8061.717839875606, 8062.556559389232, 8065.879011814827, 8146.796330091765, 8154.673813047471, 8167.346612271004, 8170.060443049037, 8214.753557393287, 8022.9598852005365, 8070.999999999971, 8071.23323284287, 8085.919140808604, 8138.674453021901, 8737.30101591871, 8759.211670949582, 8812.559372031374, 8823.514706691129, 8827.073157318453, 41136.38295425571, 41370.172596548204, 41618.37572436416, 41695.0, 41726.79136604328, 3567.661072198137, 3617.7286703497343, 3675.0454647367974, 3708.5364329458816, 3733.6453036961716, 32634.184145396317, 32887.506687399706, 33003.17492062694, 33007.83496082504, 34706.47940280873, 4377.23398405281, 4411.757353345564, 4483.551644835523, 4493.887652808673, 4563.087382523476, 329060.0, 329153.0, 329227.0, 329595.0, 330581.0, 61274.69362653248, 61316.08025879615, 61606.69196653988, 61656.69171654203, 61811.0, 36010.819945900104, 36570.26859462849, 64294.678526608004, 64798.352016480174, 64832.67583662052, 15925.203739812963, 16016.519504414886, 16048.0, 16050.75923861143, 16061.839381606269, 13535.729285414236, 13655.317234138254, 13663.0, 13665.0, 13665.18008919468, 19611.31360402379, 19846.511511636683, 20120.89939550322, 20129.194832206842, 20156.0, 7239.9276007240305, 7281.927180728125, 7314.318835945, 7367.2264412235945, 7510.774676759706, 962.932594718377, 1072.7586293083993, 1125.58915995661, 1136.539701420926, 1150.6893138852631, 32506.674933250837, 32642.0, 32792.180195495304, 32848.34303313968, 33121.3375732484, 1149.706824759681, 1201.5794471934928, 1213.6905089202373, 1238.8389509363726, 1242.689327668083, 17295.481135565955, 17427.73858392125, 17428.564285892953, 17497.82502174962, 17544.912275438543, 506708.0, 507978.0, 510027.0, 511455.0, 513135.0, 58167.418325817045, 58801.35393907285, 58804.41195588075, 58817.70591147017, 58969.0, 1278.39276343736, 1413.4840783114296, 1438.4102517967583, 1488.6501672107047, 1602.7115119278408, 30940.845295773375, 33990.32019359648, 34366.0, 34418.0, 34783.82608087044, 52383.214251787016, 52739.0, 53064.0, 53440.46559534355, 53463.73268133635, 454579.0, 456094.0, 459544.0, 461596.0, 462781.0, 36958.44562331621, 43734.12531749411, 44261.11477770491, 44945.0, 45338.0, 48613.0, 49612.25581616206, 50816.49183508118, 53704.0, 53868.19197711959, 40538.59461405348, 42486.36270455884, 43145.3528197071, 43367.34948975831, 43512.34731479094, 41247.381289281286, 41781.0, 41808.79095604503, 41877.79061104675, 42769.0, 41504.58495415128, 42096.0, 42138.78930605327, 42454.0, 42654.36018459663, 35524.64475355317, 37186.25627487489, 38003.80998094992, 38309.61690383172, 38443.231135376576, 28553.42893142167, 28720.281992950342, 28851.5672264912, 28875.0, 29078.854605726836], "value": 20538.572599833522, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.4672987722373, 379.96010418906013, 383.867565689837, 392.4211787613269, 397.5229724330804, 17964.0, 19685.114169862354, 20342.288019919306, 20456.18175272989, 20512.8974355128, 18305.90847045763, 18945.905270473628, 18994.33519826803, 19285.42143735687, 19410.51473713158, 5590.18942253374, 5664.461876121762, 5729.39841316662, 5794.536437085044, 5809.506191973687, 5580.804671836487, 5662.292213473316, 5683.886322273552, 5694.800681976131, 5712.600117991742, 5452.182172674091, 5647.519960803316, 5652.463016013472, 5693.060644993571, 5697.971510142444, 5629.211910332536, 5638.351589567191, 5676.035074037382, 5678.659280443187, 5694.601377903548, 4930.260460930889, 5001.824936127255, 5027.421846487664, 5037.823676171316, 5047.772850221712, 23224.76775232243, 23246.07015719369, 23535.646965295535, 23771.405714857094, 23798.0, 2384.391980045095, 2466.3094333586623, 2471.802255819548, 2557.6930768307734, 2568.4991426671804, 14300.928495357457, 14320.713585728332, 14336.641583960485, 14448.205348705817, 14789.260536973108, 1935.5644979879414, 1978.7427634407436, 2016.3346095788354, 2072.4611600983703, 2076.09689784944, 57447.74301742904, 58020.0, 73773.8933915997, 79516.20483795204, 79984.60007699982, 10352.171826253882, 10404.167666586654, 10447.05976462122, 10574.048335649828, 10644.627438039632, 11980.820287695691, 12668.93665531685, 14452.783208251885, 14454.710905781825, 14457.78313325301, 8009.159038301011, 8095.838083238302, 8142.83714325722, 8266.669333226724, 8277.668893244203, 8182.386321025828, 8236.752897413087, 8248.13394593571, 8355.248027677539, 8412.411131220879, 6478.125453063871, 6503.447206987459, 6556.475481961432, 6568.244651865001, 6572.539922205399, 1673.1885035757648, 1735.800382955951, 1766.3729376071567, 1796.6316905034437, 1800.9549761256073, 989.0318266649459, 992.399598243067, 1002.5288114586133, 1070.175964507325, 1101.2566517600587, 18621.44135675932, 18873.245070197037, 19729.506762331057, 19969.20123195056, 20043.29848455297, 995.0795514149528, 1023.467796745688, 1028.5217373921162, 1041.2763129624989, 1043.139409986764, 11122.22144449897, 11507.88492115085, 11522.193446458836, 11577.421128943688, 11610.361430121424, 442376.0, 444999.0, 452057.0, 452952.0, 460091.0, 48811.75594122078, 80844.19155808366, 82279.0, 82468.58765706133, 82876.0, 1072.6245813965206, 1079.2607064160918, 1090.8363745438248, 1111.0944580167138, 1120.0367683791933, 18194.0, 18233.544161396072, 18616.255349785857, 18628.627427451105, 18908.527286817938, 28914.710852892043, 30148.0, 32103.839480802446, 36264.63735362612, 41315.0, 53614.0, 54760.0, 55586.72206638941, 55802.72098639643, 56377.87244255174, 7519.473636845587, 8465.238128568459, 8590.65637374498, 8607.311415086653, 8618.965724113146, 12494.375281236084, 13494.730105398034, 13648.112872663245, 13659.79510307366, 14137.36381862798, 11722.355270460206, 12035.398230088636, 12100.394980250776, 12334.0, 12379.876201237872, 7308.96345518269, 9946.701598952042, 11798.823017654913, 11993.76012479728, 12208.877911220774, 11676.70808229801, 12509.186902851285, 12580.874191258337, 12596.072160311975, 12825.358732063547, 8241.423100382915, 8547.61535730906, 8590.09803970599, 8632.654693812177, 8655.740327790176, 8739.868901966604, 10990.450477475933, 11702.2978621283, 12002.699932501757, 12176.330301833485], "value": 9209.820635044538, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.458734212643, 1485.7845612386202, 1507.547735679296, 1657.3784830688492, 1795.3716199330236, 8514.787130321745, 8880.600372983215, 8889.644414223432, 9202.033786452426, 9204.263658907288, 8970.192682658559, 9158.908410915888, 9160.816783664322, 9168.816623667539, 9173.220276276525, 2061.6701327787555, 2271.2277825539313, 2354.72920614129, 2379.3456799380137, 2408.0247499762622, 2399.796017338528, 2439.2804122783823, 2441.7924476419525, 2442.0842184180933, 2442.413820683032, 2368.384220102777, 2412.819038572114, 2414.396400899775, 2422.1764600035985, 2423.6485709572103, 2066.1528773202913, 2317.721873375189, 2383.988080059606, 2394.6647469354302, 2405.506871091422, 2237.9216727414623, 2241.484458574521, 2254.7407048189502, 2259.3899647095354, 2260.062074239189, 8870.0, 8938.374313798036, 8945.73162805117, 8948.8657670135, 8950.373473856833, 5089.0, 5261.158214685632, 5267.420583735786, 5271.973640131775, 5282.97358513205, 3359.6808303211155, 3362.0922350965348, 3433.0902310887636, 3521.841517131735, 3536.2220311531423, 1040.588967357897, 1076.4133547216786, 1076.8546246256733, 1096.6984079378235, 1098.3135540287321, 11843.881561184364, 12036.81944770829, 12055.156139070268, 12061.758764824743, 12065.879341206562, 4422.314541246048, 4478.776061196927, 4570.634349252052, 4571.588557029883, 4573.474050484237, 10346.172306215636, 10375.27373083892, 10382.273240873066, 10393.792124157475, 10395.740106497398, 4778.95221047792, 5045.394552653705, 5098.745062746848, 5120.667156634807, 5124.846254612367, 4706.647001474903, 4845.466998630148, 4849.2968519564465, 4910.680805747615, 4913.06651736169, 4062.086030643141, 4116.176764647083, 4140.834366625361, 4172.874813755592, 4211.136716973013, 1241.0878004666563, 1245.5329251530677, 1251.8560365557896, 1261.8864302212844, 1268.1756858042347, 957.4733896356976, 974.5176137811687, 985.6402413119304, 993.0615568288043, 1010.3281317923498, 5852.4440178183, 5945.316288626776, 5963.6051296393025, 6027.60820546663, 6111.908321375183, 405.0885507607882, 415.92929202035725, 416.1012213618569, 417.5365344467638, 420.07583316703375, 3976.5029371328583, 4143.08852052548, 4146.958530414718, 4164.354525048622, 4198.538160802309, 10356.378617282837, 11060.557577696964, 11492.94253528727, 11500.367479788692, 11500.94249528747, 11123.777524449466, 11384.373859437645, 11464.426778661034, 11474.426278686033, 11496.827547586792, 8295.170482951657, 8354.331653467709, 8521.701740439179, 8551.486910785248, 8594.054653988056, 5704.3725190228215, 5744.827655170351, 6279.937200627935, 6325.367463253638, 6417.518686098655, 10246.38521688701, 10304.124149447382, 10754.569817207224, 10777.08394786452, 10812.891871081189, 10797.352158870493, 10805.891941080488, 10807.783844323227, 10900.563977440814, 10904.890951090387, 7622.390208783173, 8343.624536895975, 8595.44129631572, 8672.523011234443, 8838.955805220932, 9030.45817250967, 9039.186473217442, 9081.137291957253, 9097.59060842277, 9113.772155695895, 7869.0, 8010.599470026359, 8024.679012839421, 8162.795930101795, 8170.591470426574, 7818.179091195342, 7956.283934445928, 8003.679852806055, 8044.6379912902885, 8090.83818323642, 6718.764843230463, 6726.596404215763, 6864.3822056013205, 6865.828354290983, 6884.4148247399535, 5012.899742005066, 5044.167712327425, 5083.440821509705, 5166.3800343958965, 5253.133233016662, 5027.396712394536, 5113.105206588906, 5134.7946082156295, 5205.817796377109, 5326.0], "value": 4602.9119932577405, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.81039755351685, 312.31291159449216, 315.4794588928268, 316.9778115531913, 323.5599584564992, 5364.973175134124, 5369.892602147955, 5376.91934620981, 5391.622586418952, 5408.648437851547, 5307.550092439916, 5328.254044433782, 5330.1610944224185, 5363.302770639821, 5381.19282107684, 3914.9804250978777, 4012.3179059559943, 4126.174765046988, 4134.607212314825, 4145.54399016108, 4090.1615168890453, 4091.284025295561, 4097.180563887219, 4109.260333140033, 4121.629053385194, 3914.7651140931494, 4105.527864295615, 4114.773687447189, 4128.0, 4138.730982486129, 3984.9003774905714, 4065.7763822989723, 4068.3490641497365, 4086.325756250245, 4089.1821635672686, 3560.1099725068734, 3569.7679650822874, 3591.120175557005, 3597.3524765542193, 3598.5321908152036, 5065.949340506585, 5066.949330506684, 5114.181730923035, 5127.3847138343635, 5135.0, 4550.3402006709175, 4696.976515117402, 4705.882352941169, 4736.83421080264, 4754.334393184922, 5523.502884740353, 5529.25828364064, 5542.63972841764, 5556.222128901957, 5564.33228012637, 3959.8614048508166, 3971.0866500705, 3980.5223373195113, 3986.3223252047223, 3987.501562304712, 5694.462495126334, 5780.450857168562, 5783.942160578383, 5784.942150578482, 5794.595242974161, 4012.9398059029136, 4018.4976877890263, 4040.6565441937178, 4043.211573743092, 4062.959370406258, 4079.9796001019804, 4090.141070375195, 4090.4477895484324, 4092.4475195848777, 4114.485689288839, 4422.314541246048, 4690.202665546797, 4694.483606803249, 4698.1778188816825, 4699.835505757351, 5593.636413633101, 5619.831405057855, 5637.830865074055, 5667.546596272288, 5670.064439367458, 1392.3595146232847, 1399.3353157250224, 1405.7118290750373, 1406.2336026865382, 1416.3414012484245, 873.3929918706565, 881.2641444393875, 887.7070566712969, 903.1350261709549, 936.7798567336671, 5368.409474957752, 5371.167469042305, 5382.596305277119, 5388.137897936312, 5397.731533089721, 5647.6893770843, 5661.603687741818, 5674.347450043298, 5682.801101961494, 5688.345840228344, 5187.688738675692, 5311.814086506954, 5315.707636080053, 5316.122839731401, 5320.201969704575, 3041.4829478988627, 3041.9201183579953, 3043.7412819910555, 3054.633443986736, 3079.16862447138, 5857.326407463196, 5908.527317814564, 5910.704464776744, 5915.319738230072, 5938.940610593925, 5607.915646394548, 5762.703391736825, 5814.505767009767, 5877.52979761618, 5883.264591926009, 5814.186013958049, 5847.883042339129, 5852.209951656557, 5886.499647530008, 5898.616589921641, 5533.391326954113, 5570.58220633446, 5670.234518340137, 5739.741711623071, 5741.483266506035, 5601.411851755507, 5601.747921343631, 5626.493615574618, 5633.6619802811965, 5645.0, 5795.76816927335, 5848.64908105515, 5848.883022339614, 5869.53043756507, 5880.558958078076, 3867.7099217559357, 3988.364770444104, 4011.7793521356607, 4019.1559772448113, 4026.375911733686, 5647.915281270866, 5692.068584678811, 5754.165645981226, 5775.94224057754, 5780.514378817149, 5399.70301633414, 5571.582131340247, 5584.888302234014, 5677.943220567741, 5708.65748055118, 5572.86067848307, 5601.943980560305, 5618.943810562006, 5623.971880140573, 5637.8590535236945, 5277.577793776411, 5526.784107496344, 5544.69504177258, 5553.361363443256, 5569.610127291051, 5702.942970570241, 5713.485786279255, 5717.141928873049, 5719.370869204301, 5752.769889204553, 5594.888102237851, 5608.298962629671, 5610.943890561042, 5613.438656134354, 5617.7191140442], "value": 4226.972008699638, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.9253528379523, 824.1223097401268, 854.9016863060746, 856.0540602634089, 872.6073267029839, 15067.17130557819, 15633.765493517607, 15657.921710391432, 15744.527664170078, 15745.999999999985, 14449.205293708868, 14464.783028254584, 14479.34842932068, 14485.275736213174, 14491.0, 663.3300366629702, 790.7509134622604, 798.2336956521746, 812.0296245986049, 812.212154210415, 769.2422963381065, 776.6427443376053, 777.0636383158309, 779.8479296537178, 781.0159199408757, 829.9709510167145, 831.6590198018813, 831.7587899509165, 832.097174565597, 832.1886160993043, 706.3395724997118, 832.063928080909, 850.158343240194, 855.4738835616114, 856.1395797223812, 620.2618883528587, 622.5237693164732, 626.8182227154119, 626.8307556959595, 626.9811905642838, 13824.101433406897, 13878.375473103735, 13899.722005559934, 13909.234992075431, 13923.0, 13562.93218533901, 13746.0, 13757.0, 13867.791983120262, 14133.293335333192, 12469.75060498794, 12539.0, 12566.0, 12593.244405335618, 13208.801867971988, 4397.340398940152, 4432.955670443286, 4473.798679059418, 4506.143832671782, 4545.818167273305, 57976.71011644957, 58030.0, 58215.41784582142, 58532.0, 59314.40685593132, 11449.198556100993, 11474.368909710047, 11547.711307217218, 11571.710707232387, 11613.593524226611, 20551.177952882015, 20578.176872924916, 20681.89659051725, 20684.379468615967, 20785.58428831415, 8336.87494687568, 8583.0, 8587.441816281922, 8634.956825215833, 8695.0, 4681.882952926204, 4760.476347601761, 4779.784909679072, 4781.163296423112, 4974.328465657162, 3450.6376830432946, 3514.525539052246, 3554.573451185874, 3555.2178520725397, 3555.7510974232073, 660.9669516524154, 666.2770893580423, 669.3641041011059, 672.8149758816364, 677.8373190434261, 624.753222477119, 638.9042791612407, 642.0593680941278, 642.4378668664918, 716.8996340512332, 9458.810823783486, 9658.179054780423, 9662.806743865083, 9662.951685241529, 9737.318387712934, 658.5949640970769, 702.9121359830021, 725.2457444257913, 731.2431633259657, 748.913874904393, 4168.708190426702, 4288.48538175421, 4411.514733379326, 4427.512973572904, 4461.353103799996, 63181.36818631847, 63672.67764207176, 64155.0, 66029.33970660328, 67575.3242467569, 59308.0, 59740.40259597435, 60781.0, 61385.0, 61914.69042654758, 54039.45960540344, 54573.72713136488, 54635.180472292945, 54980.450195498335, 55318.44681553133, 8751.956240218758, 8807.253617851466, 8812.51531165792, 8886.955565222133, 8890.19988201039, 37011.0, 37338.8133059333, 37517.24965500729, 37607.62392376041, 38146.0, 44872.102557949314, 47949.520504794506, 48485.0, 48584.271235930784, 48878.26682599693, 11083.113350932068, 11263.718407039889, 11549.595764148215, 11613.825792613286, 11635.301881887113, 11493.080553555863, 11800.173987821114, 11866.347350895783, 12089.214201076902, 12729.87270127324, 11470.311781293149, 11649.650510484698, 11774.3524106175, 11811.704707382385, 11996.820047699117, 11411.885881141083, 11635.5927542539, 11973.880261197624, 11993.700157495783, 12011.819822702491, 11590.246633968765, 11771.882281177079, 11907.0, 11929.164958452826, 12436.440360183995, 9530.189933855423, 9690.903090969001, 9746.80506389854, 9816.901830981598, 9964.252681048805, 9160.0, 9253.213476854542, 9562.495638911849, 9617.0, 9934.155596774355], "value": 6810.224785437511, "unit": "score"}], "name": "dromaeo_css", "value": 7169.996041474149, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 112.0, 111.0, 108.0, 108.0, 109.0, 109.0, 111.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 125.0, 209.0, 122.0, 124.0, 150.0, 131.0, 152.0, 125.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 159.0, 159.0, 161.0, 162.0, 162.0, 163.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 135.0, 76.0, 75.0, 75.0, 76.0, 116.0, 75.0], "value": 85.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 161.0, 91.0, 93.0, 92.0, 129.0, 91.0, 92.0, 127.0], "value": 106.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 149.0, 148.0, 149.0, 146.0, 154.0, 147.0, 146.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 94.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 56.0, 54.0, 55.0, 108.0, 54.0, 53.0], "value": 59.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 84.0, 78.0, 81.0, 78.0, 87.0, 78.0, 86.0, 85.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 121.0, 135.0, 127.0, 120.0, 119.0, 118.0, 120.0, 208.0, 119.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 156.0, 154.0, 159.0, 156.0, 158.0, 157.0, 160.0, 161.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 63.0, 71.0, 65.0, 61.0, 63.0, 62.0, 65.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1518.7999999999997, "alertThreshold": 2.0}]} 23:30:22 INFO - Return code: 0 23:30:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:30:22 ERROR - # TBPL SUCCESS # 23:30:22 INFO - Running post-action listener: _resource_record_post_action 23:30:22 INFO - ##### 23:30:22 INFO - ##### Finished run-tests step (success) 23:30:22 INFO - ##### 23:30:22 INFO - Running post-run listener: _resource_record_post_run 23:30:22 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 305971200; Read time: 0; Write time: 489268 23:30:22 INFO - TinderboxPrint: CPU usage
13.1% 23:30:22 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:30:22 INFO - TinderboxPrint: I/O write bytes / time
305,971,200 / 489,268 23:30:22 INFO - TinderboxPrint: CPU idle
8,289.9 (86.8%) 23:30:22 INFO - TinderboxPrint: CPU user
1,206.6 (12.6%) 23:30:22 INFO - TinderboxPrint: Swap in / out
0 / 0 23:30:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 20213760; Read time: 0; Write time: 12496 23:30:22 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 285757440; Read time: 0; Write time: 476772 23:30:23 INFO - Running post-run listener: _upload_blobber_files 23:30:23 INFO - Blob upload gear active. 23:30:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:30:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:30:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:30:23 INFO - (blobuploader) - INFO - Open directory for files ... 23:30:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:30:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:30:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:24 INFO - (blobuploader) - INFO - Done attempting. 23:30:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:30:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:30:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:28 INFO - (blobuploader) - INFO - Done attempting. 23:30:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:30:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:30:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:29 INFO - (blobuploader) - INFO - Done attempting. 23:30:29 INFO - (blobuploader) - INFO - Iteration through files over. 23:30:29 INFO - Return code: 0 23:30:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:30:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:30:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32e3a34a8cbb680aeef7063a32483ea167ace6ae4e0f811e5e1707e715a0a213af22430920aad843e2b31d45e6bc0e194ddbe4a1d8245c6f43305ea0b0331015", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/250fb3aee84449ac8d302495e14362e599d4ff304c523bcc9b4279deeca9362dac63e779e6b073c28d1acb98ad248ca74b515302b7a185a034a2cc61b5bb2545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e36c1222c6fc60cb5bd5d2b0db39449e551757571f6ec1f887b84f2a636c55e2a382dbf7ee945b4a19248a5127bdeefae3193354d0368fa1c6f0c8b7767b919"} 23:30:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:30:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:30:29 INFO - Contents: 23:30:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32e3a34a8cbb680aeef7063a32483ea167ace6ae4e0f811e5e1707e715a0a213af22430920aad843e2b31d45e6bc0e194ddbe4a1d8245c6f43305ea0b0331015", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/250fb3aee84449ac8d302495e14362e599d4ff304c523bcc9b4279deeca9362dac63e779e6b073c28d1acb98ad248ca74b515302b7a185a034a2cc61b5bb2545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e36c1222c6fc60cb5bd5d2b0db39449e551757571f6ec1f887b84f2a636c55e2a382dbf7ee945b4a19248a5127bdeefae3193354d0368fa1c6f0c8b7767b919"} 23:30:29 INFO - Running post-run listener: copy_logs_to_upload_dir 23:30:29 INFO - Copying logs to upload dir... 23:30:29 INFO - mkdir: /builds/slave/test/build/upload/logs 23:30:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.353768 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-05-20 23:30:29.474558) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 23:30:29.477959) ========= 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=8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32e3a34a8cbb680aeef7063a32483ea167ace6ae4e0f811e5e1707e715a0a213af22430920aad843e2b31d45e6bc0e194ddbe4a1d8245c6f43305ea0b0331015", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/250fb3aee84449ac8d302495e14362e599d4ff304c523bcc9b4279deeca9362dac63e779e6b073c28d1acb98ad248ca74b515302b7a185a034a2cc61b5bb2545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e36c1222c6fc60cb5bd5d2b0db39449e551757571f6ec1f887b84f2a636c55e2a382dbf7ee945b4a19248a5127bdeefae3193354d0368fa1c6f0c8b7767b919"} build_url:https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011393 build_url: 'https://queue.taskcluster.net/v1/task/eKJy6gDWTG-cHMld2N__2w/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/Fx-Team/sha512/32e3a34a8cbb680aeef7063a32483ea167ace6ae4e0f811e5e1707e715a0a213af22430920aad843e2b31d45e6bc0e194ddbe4a1d8245c6f43305ea0b0331015", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/250fb3aee84449ac8d302495e14362e599d4ff304c523bcc9b4279deeca9362dac63e779e6b073c28d1acb98ad248ca74b515302b7a185a034a2cc61b5bb2545", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e36c1222c6fc60cb5bd5d2b0db39449e551757571f6ec1f887b84f2a636c55e2a382dbf7ee945b4a19248a5127bdeefae3193354d0368fa1c6f0c8b7767b919"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 23:30:29.502501) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:30:29.502823) ========= 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=8783db0840cc980e80bb0bd400000236-1463809680.491641-1485109975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 23:30:29.585377) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 23:30:29.585705) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 23:30:29.586002) ========= ========= Total master_lag: 0.17 =========