builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1459180816.22 results: success (0) buildid: 20160328081822 builduid: d52e74d9805e44aca9d96abe31d386dd revision: 75a1822f9cb2e95da462e067d1f2cb1cee114f25 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:16.224322) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:16.224712) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:16.225028) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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-1459180280.411497-772721408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006419 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:16.271887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:16.272213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:16.305103) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:16.305399) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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-1459180280.411497-772721408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004627 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:16.371861) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:16.372153) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:16.372568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:16.372912) ========= 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-1459180280.411497-772721408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-28 09:00:16-- 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% 228M=0s 2016-03-28 09:00:16 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096491 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:16.488751) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:16.489076) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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-1459180280.411497-772721408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022634 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:16.539293) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:16.539656) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 75a1822f9cb2e95da462e067d1f2cb1cee114f25 --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 75a1822f9cb2e95da462e067d1f2cb1cee114f25 --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-1459180280.411497-772721408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-28 09:00:16,838 truncating revision to first 12 chars 2016-03-28 09:00:16,838 Setting DEBUG logging. 2016-03-28 09:00:16,838 attempt 1/10 2016-03-28 09:00:16,838 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/75a1822f9cb2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-28 09:00:17,124 unpacking tar archive at: fx-team-75a1822f9cb2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.583064 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:17.136230) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:17.136574) ========= echo 75a1822f9cb2e95da462e067d1f2cb1cee114f25 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'75a1822f9cb2e95da462e067d1f2cb1cee114f25'] 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-1459180280.411497-772721408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 75a1822f9cb2e95da462e067d1f2cb1cee114f25 program finished with exit code 0 elapsedTime=0.004692 script_repo_revision: '75a1822f9cb2e95da462e067d1f2cb1cee114f25' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:17.187111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:17.187463) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:17.201653) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-03-28 09:00:17.201963) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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-1459180280.411497-772721408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:00:17 INFO - MultiFileLogger online at 20160328 09:00:17 in /builds/slave/test 09:00:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:00:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:00:17 INFO - {'append_to_log': False, 09:00:17 INFO - 'base_work_dir': '/builds/slave/test', 09:00:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:00:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:00:17 INFO - 'branch': 'Fx-Team-Non-PGO', 09:00:17 INFO - 'buildbot_json_path': 'buildprops.json', 09:00:17 INFO - 'config_files': ('talos/linux_config.py',), 09:00:17 INFO - 'default_actions': ('clobber', 09:00:17 INFO - 'read-buildbot-config', 09:00:17 INFO - 'download-and-extract', 09:00:17 INFO - 'populate-webroot', 09:00:17 INFO - 'create-virtualenv', 09:00:17 INFO - 'install', 09:00:17 INFO - 'run-tests'), 09:00:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:00:17 INFO - 'download_minidump_stackwalk': True, 09:00:17 INFO - 'download_symbols': 'ondemand', 09:00:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:00:17 INFO - 'tooltool.py': '/tools/tooltool.py', 09:00:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:00:17 INFO - '/tools/misc-python/virtualenv.py')}, 09:00:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:00:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:00:17 INFO - 'installer_path': 'installer.exe', 09:00:17 INFO - 'log_level': 'info', 09:00:17 INFO - 'log_name': 'talos', 09:00:17 INFO - 'log_to_console': True, 09:00:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:00:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:00:17 INFO - 'opt_config_files': (), 09:00:17 INFO - 'pip_index': False, 09:00:17 INFO - 'sps_profile': False, 09:00:17 INFO - 'sps_profile_interval': 0, 09:00:17 INFO - 'suite': 'dromaeojs-e10s', 09:00:17 INFO - 'system_bits': '32', 09:00:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:00:17 INFO - 'title': 'talos-linux64-ix-038', 09:00:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:00:17 INFO - 'use_talos_json': True, 09:00:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:00:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:00:17 INFO - 'work_dir': 'build'} 09:00:17 INFO - ##### 09:00:17 INFO - ##### Running clobber step. 09:00:17 INFO - ##### 09:00:17 INFO - Running pre-action listener: _resource_record_pre_action 09:00:17 INFO - Running main action method: clobber 09:00:17 INFO - rmtree: /builds/slave/test/build 09:00:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:00:18 INFO - Running post-action listener: _resource_record_post_action 09:00:18 INFO - ##### 09:00:18 INFO - ##### Running read-buildbot-config step. 09:00:18 INFO - ##### 09:00:18 INFO - Running pre-action listener: _resource_record_pre_action 09:00:18 INFO - Running main action method: read_buildbot_config 09:00:18 INFO - Using buildbot properties: 09:00:18 INFO - { 09:00:18 INFO - "project": "", 09:00:18 INFO - "product": "firefox", 09:00:18 INFO - "script_repo_revision": "production", 09:00:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:00:18 INFO - "repository": "", 09:00:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:00:18 INFO - "buildid": "20160328081822", 09:00:18 INFO - "pgo_build": "False", 09:00:18 INFO - "basedir": "/builds/slave/test", 09:00:18 INFO - "buildnumber": 1053, 09:00:18 INFO - "slavename": "talos-linux64-ix-038", 09:00:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:00:18 INFO - "platform": "ubuntu64_hw", 09:00:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:00:18 INFO - "branch": "fx-team", 09:00:18 INFO - "repo_path": "integration/fx-team", 09:00:18 INFO - "revision": "75a1822f9cb2e95da462e067d1f2cb1cee114f25", 09:00:18 INFO - "stage_platform": "linux64", 09:00:18 INFO - "builduid": "d52e74d9805e44aca9d96abe31d386dd", 09:00:18 INFO - "slavebuilddir": "test" 09:00:18 INFO - } 09:00:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:00:18 INFO - Running post-action listener: _resource_record_post_action 09:00:18 INFO - ##### 09:00:18 INFO - ##### Running download-and-extract step. 09:00:18 INFO - ##### 09:00:18 INFO - Running pre-action listener: _resource_record_pre_action 09:00:18 INFO - Running main action method: download_and_extract 09:00:18 INFO - mkdir: /builds/slave/test/build/tests 09:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:18 INFO - https://queue.taskcluster.net/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:00:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:00:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:00:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:00:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:00:19 INFO - Downloaded 1361 bytes. 09:00:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:00:19 INFO - Using the following test package requirements: 09:00:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:00:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:00:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:00:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:00:19 INFO - u'jsshell-linux-x86_64.zip'], 09:00:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:00:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:00:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:00:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:00:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:00:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:00:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:00:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:19 INFO - https://queue.taskcluster.net/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:00:22 INFO - Downloaded 22085590 bytes. 09:00:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:00:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:00:24 INFO - Return code: 0 09:00:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:24 INFO - https://queue.taskcluster.net/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:00:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:00:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:00:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:00:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:00:28 INFO - Downloaded 22085590 bytes. 09:00:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:00:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:00:29 INFO - Return code: 0 09:00:29 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')]} 09:00:29 INFO - https://queue.taskcluster.net/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:00:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:00:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:00:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:00:35 INFO - Downloaded 10847531 bytes. 09:00:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:00:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:00:35 INFO - Return code: 0 09:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:35 INFO - https://queue.taskcluster.net/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:00:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:00:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:00:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:00:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:00:37 INFO - Downloaded 54262115 bytes. 09:00:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:00:37 INFO - mkdir: /builds/slave/test/properties 09:00:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:00:37 INFO - Writing to file /builds/slave/test/properties/build_url 09:00:37 INFO - Contents: 09:00:37 INFO - build_url:https://queue.taskcluster.net/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:00:37 INFO - Running post-action listener: _resource_record_post_action 09:00:37 INFO - Running post-action listener: set_extra_try_arguments 09:00:37 INFO - ##### 09:00:37 INFO - ##### Running populate-webroot step. 09:00:37 INFO - ##### 09:00:37 INFO - Running pre-action listener: _resource_record_pre_action 09:00:37 INFO - Running main action method: populate_webroot 09:00:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:00:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:00:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:00:37 INFO - '--tppagecycles', 09:00:37 INFO - '7'], 09:00:37 INFO - 'tests': ['tsvgm']}}, 09:00:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:00:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:00:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:00:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:00:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:00:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:00:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:00:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:37 INFO - 'talos_options': ['--e10s'], 09:00:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:00:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:37 INFO - 'tests': ['damp', 'tps']}, 09:00:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:37 INFO - 'talos_options': ['--e10s'], 09:00:37 INFO - 'tests': ['damp', 'tps']}, 09:00:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:00:37 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 09:00:37 INFO - 'tests': ['dromaeo_dom']}, 09:00:37 INFO - 'other': {'tests': ['a11yr', 09:00:37 INFO - 'ts_paint', 09:00:37 INFO - 'tpaint', 09:00:37 INFO - 'sessionrestore', 09:00:37 INFO - 'sessionrestore_no_auto_restore', 09:00:37 INFO - 'tabpaint']}, 09:00:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:00:37 INFO - 'tests': ['a11yr', 09:00:37 INFO - 'ts_paint', 09:00:37 INFO - 'tpaint', 09:00:37 INFO - 'sessionrestore', 09:00:37 INFO - 'sessionrestore_no_auto_restore', 09:00:37 INFO - 'tabpaint']}, 09:00:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:00:37 INFO - 'tests': ['a11yr', 09:00:37 INFO - 'ts_paint', 09:00:37 INFO - 'tpaint', 09:00:37 INFO - 'sessionrestore', 09:00:37 INFO - 'sessionrestore_no_auto_restore', 09:00:37 INFO - 'tabpaint']}, 09:00:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:00:37 INFO - 'tests': ['a11yr', 09:00:37 INFO - 'ts_paint', 09:00:37 INFO - 'tpaint', 09:00:37 INFO - 'sessionrestore', 09:00:37 INFO - 'sessionrestore_no_auto_restore', 09:00:37 INFO - 'tabpaint']}, 09:00:37 INFO - 'other_l64': {'tests': ['a11yr', 09:00:37 INFO - 'ts_paint', 09:00:37 INFO - 'tpaint', 09:00:37 INFO - 'sessionrestore', 09:00:37 INFO - 'sessionrestore_no_auto_restore', 09:00:37 INFO - 'tabpaint']}, 09:00:37 INFO - 'other_nol64': {'tests': ['a11yr', 09:00:37 INFO - 'ts_paint', 09:00:37 INFO - 'tpaint', 09:00:37 INFO - 'sessionrestore', 09:00:37 INFO - 'sessionrestore_no_auto_restore', 09:00:37 INFO - 'tabpaint']}, 09:00:37 INFO - 'svgr': {'tests': ['tsvgx', 09:00:37 INFO - 'tsvgr_opacity', 09:00:37 INFO - 'tart', 09:00:37 INFO - 'tscrollx', 09:00:37 INFO - 'cart']}, 09:00:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:00:37 INFO - 'tests': ['tsvgx', 09:00:37 INFO - 'tsvgr_opacity', 09:00:37 INFO - 'tart', 09:00:37 INFO - 'tscrollx', 09:00:37 INFO - 'cart']}, 09:00:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:37 INFO - 'tests': ['tp5o']}, 09:00:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:37 INFO - 'talos_options': ['--e10s'], 09:00:37 INFO - 'tests': ['tp5o']}, 09:00:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:37 INFO - 'talos_options': ['--xperf_path', 09:00:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:00:37 INFO - 'tests': ['tp5n']}, 09:00:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:37 INFO - 'talos_options': ['--e10s', 09:00:37 INFO - '--xperf_path', 09:00:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:00:37 INFO - 'tests': ['tp5n']}}, 09:00:37 INFO - 'talos.zip': {'path': '', 09:00:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:00:37 INFO - Running post-action listener: _resource_record_post_action 09:00:37 INFO - ##### 09:00:37 INFO - ##### Running create-virtualenv step. 09:00:37 INFO - ##### 09:00:37 INFO - Running pre-action listener: _resource_record_pre_action 09:00:37 INFO - Running main action method: create_virtualenv 09:00:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:00:37 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 09:00:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:00:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:00:37 INFO - Using real prefix '/usr' 09:00:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:00:38 INFO - Installing distribute.............................................................................................................................................................................................done. 09:00:40 INFO - Installing pip.................done. 09:00:40 INFO - Return code: 0 09:00:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:00:40 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')]} 09:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:40 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')]} 09:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:40 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 0x7ff70f92af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa410>, '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 0x13ab310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ab7a0>, '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-1459180280.411497-772721408', '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 09:00:40 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 09:00:40 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 09:00:40 INFO - Using env: {'DISPLAY': ':0', 09:00:40 INFO - 'HOME': '/home/cltbld', 09:00:40 INFO - 'LANG': 'en_US.UTF-8', 09:00:40 INFO - 'LANGUAGE': 'en_US:en', 09:00:40 INFO - 'LOGNAME': 'cltbld', 09:00:40 INFO - 'MAIL': '/var/mail/cltbld', 09:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:40 INFO - 'MOZ_NO_REMOTE': '1', 09:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:40 INFO - 'NO_EM_RESTART': '1', 09:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:40 INFO - 'PWD': '/builds/slave/test', 09:00:40 INFO - 'SHELL': '/bin/bash', 09:00:40 INFO - 'SHLVL': '1', 09:00:40 INFO - 'TERM': 'linux', 09:00:40 INFO - 'TMOUT': '86400', 09:00:40 INFO - 'USER': 'cltbld', 09:00:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1459180280.411497-772721408', 09:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:40 INFO - '_': '/tools/buildbot/bin/python'} 09:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:40 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 09:00:40 INFO - Cleaning up... 09:00:40 INFO - Return code: 0 09:00:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:00:40 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')]} 09:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:40 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')]} 09:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff70f92af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa410>, '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 0x13ab310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ab7a0>, '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-1459180280.411497-772721408', '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 09:00:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:00:40 INFO - Using env: {'DISPLAY': ':0', 09:00:40 INFO - 'HOME': '/home/cltbld', 09:00:40 INFO - 'LANG': 'en_US.UTF-8', 09:00:40 INFO - 'LANGUAGE': 'en_US:en', 09:00:40 INFO - 'LOGNAME': 'cltbld', 09:00:40 INFO - 'MAIL': '/var/mail/cltbld', 09:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:40 INFO - 'MOZ_NO_REMOTE': '1', 09:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:40 INFO - 'NO_EM_RESTART': '1', 09:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:40 INFO - 'PWD': '/builds/slave/test', 09:00:40 INFO - 'SHELL': '/bin/bash', 09:00:40 INFO - 'SHLVL': '1', 09:00:40 INFO - 'TERM': 'linux', 09:00:40 INFO - 'TMOUT': '86400', 09:00:40 INFO - 'USER': 'cltbld', 09:00:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1459180280.411497-772721408', 09:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:40 INFO - '_': '/tools/buildbot/bin/python'} 09:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:40 INFO - Downloading/unpacking psutil>=0.7.1 09:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:00:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:42 INFO - Installing collected packages: psutil 09:00:42 INFO - Running setup.py install for psutil 09:00:43 INFO - building 'psutil._psutil_linux' extension 09:00:43 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 09:00:43 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 09:00:43 INFO - building 'psutil._psutil_posix' extension 09:00:43 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 09:00:43 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 09:00:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:43 INFO - Successfully installed psutil 09:00:43 INFO - Cleaning up... 09:00:43 INFO - Return code: 0 09:00:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:00: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')]} 09:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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')]} 09:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff70f92af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa410>, '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 0x13ab310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ab7a0>, '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-1459180280.411497-772721408', '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 09:00:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:00:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:00:43 INFO - Using env: {'DISPLAY': ':0', 09:00:43 INFO - 'HOME': '/home/cltbld', 09:00:43 INFO - 'LANG': 'en_US.UTF-8', 09:00:43 INFO - 'LANGUAGE': 'en_US:en', 09:00:43 INFO - 'LOGNAME': 'cltbld', 09:00:43 INFO - 'MAIL': '/var/mail/cltbld', 09:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:43 INFO - 'MOZ_NO_REMOTE': '1', 09:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:43 INFO - 'NO_EM_RESTART': '1', 09:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:43 INFO - 'PWD': '/builds/slave/test', 09:00:43 INFO - 'SHELL': '/bin/bash', 09:00:43 INFO - 'SHLVL': '1', 09:00:43 INFO - 'TERM': 'linux', 09:00:43 INFO - 'TMOUT': '86400', 09:00:43 INFO - 'USER': 'cltbld', 09:00:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1459180280.411497-772721408', 09:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:43 INFO - '_': '/tools/buildbot/bin/python'} 09:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:00:45 INFO - Installing collected packages: mozsystemmonitor 09:00:45 INFO - Running setup.py install for mozsystemmonitor 09:00:46 INFO - Successfully installed mozsystemmonitor 09:00:46 INFO - Cleaning up... 09:00:46 INFO - Return code: 0 09:00:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:00:46 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')]} 09:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:46 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')]} 09:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:46 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 0x7ff70f92af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa410>, '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 0x13ab310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ab7a0>, '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-1459180280.411497-772721408', '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 09:00:46 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 09:00:46 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 09:00:46 INFO - Using env: {'DISPLAY': ':0', 09:00:46 INFO - 'HOME': '/home/cltbld', 09:00:46 INFO - 'LANG': 'en_US.UTF-8', 09:00:46 INFO - 'LANGUAGE': 'en_US:en', 09:00:46 INFO - 'LOGNAME': 'cltbld', 09:00:46 INFO - 'MAIL': '/var/mail/cltbld', 09:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:46 INFO - 'MOZ_NO_REMOTE': '1', 09:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:46 INFO - 'NO_EM_RESTART': '1', 09:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:46 INFO - 'PWD': '/builds/slave/test', 09:00:46 INFO - 'SHELL': '/bin/bash', 09:00:46 INFO - 'SHLVL': '1', 09:00:46 INFO - 'TERM': 'linux', 09:00:46 INFO - 'TMOUT': '86400', 09:00:46 INFO - 'USER': 'cltbld', 09:00:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1459180280.411497-772721408', 09:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:46 INFO - '_': '/tools/buildbot/bin/python'} 09:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:46 INFO - Downloading/unpacking blobuploader==1.2.4 09:00:46 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 09:00:46 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 09:00:46 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 09:00:46 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 09:00:46 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 09:00:46 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 09:00:48 INFO - Downloading blobuploader-1.2.4.tar.gz 09:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:00:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:00:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:00:49 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 09:00:49 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 09:00:49 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 09:00:49 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 09:00:49 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 09:00:49 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 09:00:49 INFO - Downloading docopt-0.6.1.tar.gz 09:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:00:49 INFO - Installing collected packages: blobuploader, requests, docopt 09:00:49 INFO - Running setup.py install for blobuploader 09:00:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:00:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:00:49 INFO - Running setup.py install for requests 09:00:49 INFO - Running setup.py install for docopt 09:00:49 INFO - Successfully installed blobuploader requests docopt 09:00:49 INFO - Cleaning up... 09:00:49 INFO - Return code: 0 09:00:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:49 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 0x7ff70f92af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa410>, '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 0x13ab310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ab7a0>, '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-1459180280.411497-772721408', '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 09:00:49 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 09:00:49 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 09:00:49 INFO - Using env: {'DISPLAY': ':0', 09:00:49 INFO - 'HOME': '/home/cltbld', 09:00:49 INFO - 'LANG': 'en_US.UTF-8', 09:00:49 INFO - 'LANGUAGE': 'en_US:en', 09:00:49 INFO - 'LOGNAME': 'cltbld', 09:00:49 INFO - 'MAIL': '/var/mail/cltbld', 09:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:49 INFO - 'MOZ_NO_REMOTE': '1', 09:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:49 INFO - 'NO_EM_RESTART': '1', 09:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:49 INFO - 'PWD': '/builds/slave/test', 09:00:49 INFO - 'SHELL': '/bin/bash', 09:00:49 INFO - 'SHLVL': '1', 09:00:49 INFO - 'TERM': 'linux', 09:00:49 INFO - 'TMOUT': '86400', 09:00:49 INFO - 'USER': 'cltbld', 09:00:49 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1459180280.411497-772721408', 09:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:49 INFO - '_': '/tools/buildbot/bin/python'} 09:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:50 INFO - Running setup.py (path:/tmp/pip-UM0p2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:50 INFO - Running setup.py (path:/tmp/pip-3tEQE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:50 INFO - Running setup.py (path:/tmp/pip-3LIO7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:50 INFO - Running setup.py (path:/tmp/pip-82m780-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:50 INFO - Running setup.py (path:/tmp/pip-pAazi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:50 INFO - Running setup.py (path:/tmp/pip-ePSoEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:50 INFO - Running setup.py (path:/tmp/pip-Ok8mZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:50 INFO - Running setup.py (path:/tmp/pip-F5hTv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:50 INFO - Running setup.py (path:/tmp/pip-AA6RIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:50 INFO - Running setup.py (path:/tmp/pip-qrnGza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:50 INFO - Running setup.py (path:/tmp/pip-HhnR6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:50 INFO - Running setup.py (path:/tmp/pip-E12Sji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:50 INFO - Running setup.py (path:/tmp/pip-nmUVwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:51 INFO - Running setup.py (path:/tmp/pip-ScmOTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:51 INFO - Running setup.py (path:/tmp/pip-4bPnVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:51 INFO - Running setup.py (path:/tmp/pip-Shj1oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:51 INFO - Running setup.py (path:/tmp/pip-5bOllK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:00:51 INFO - Running setup.py install for manifestparser 09:00:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:00:51 INFO - Running setup.py install for mozcrash 09:00:51 INFO - Running setup.py install for mozdebug 09:00:51 INFO - Running setup.py install for mozdevice 09:00:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:00:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:00:51 INFO - Running setup.py install for mozfile 09:00:51 INFO - Running setup.py install for mozhttpd 09:00:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:00:51 INFO - Running setup.py install for mozinfo 09:00:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:00:52 INFO - Running setup.py install for mozInstall 09:00:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:00:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:00:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:00:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:00:52 INFO - Running setup.py install for mozleak 09:00:52 INFO - Running setup.py install for mozlog 09:00:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:00:52 INFO - Running setup.py install for moznetwork 09:00:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:00:52 INFO - Running setup.py install for mozprocess 09:00:52 INFO - Running setup.py install for mozprofile 09:00:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:00:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:00:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:00:52 INFO - Running setup.py install for mozrunner 09:00:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:00:52 INFO - Running setup.py install for mozscreenshot 09:00:52 INFO - Running setup.py install for moztest 09:00:53 INFO - Running setup.py install for mozversion 09:00:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:00:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:00:53 INFO - Cleaning up... 09:00:53 INFO - Return code: 0 09:00:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:53 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')]} 09:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:53 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')]} 09:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:53 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 0x7ff70f92af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa410>, '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 0x13ab310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ab7a0>, '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-1459180280.411497-772721408', '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 09:00:53 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 09:00:53 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 09:00:53 INFO - Using env: {'DISPLAY': ':0', 09:00:53 INFO - 'HOME': '/home/cltbld', 09:00:53 INFO - 'LANG': 'en_US.UTF-8', 09:00:53 INFO - 'LANGUAGE': 'en_US:en', 09:00:53 INFO - 'LOGNAME': 'cltbld', 09:00:53 INFO - 'MAIL': '/var/mail/cltbld', 09:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:53 INFO - 'MOZ_NO_REMOTE': '1', 09:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:53 INFO - 'NO_EM_RESTART': '1', 09:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:53 INFO - 'PWD': '/builds/slave/test', 09:00:53 INFO - 'SHELL': '/bin/bash', 09:00:53 INFO - 'SHLVL': '1', 09:00:53 INFO - 'TERM': 'linux', 09:00:53 INFO - 'TMOUT': '86400', 09:00:53 INFO - 'USER': 'cltbld', 09:00:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1459180280.411497-772721408', 09:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:53 INFO - '_': '/tools/buildbot/bin/python'} 09:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:53 INFO - Running setup.py (path:/tmp/pip-h2Lw7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:53 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)) 09:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:53 INFO - Running setup.py (path:/tmp/pip-lVFmCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:53 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)) 09:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:53 INFO - Running setup.py (path:/tmp/pip-wT0_ZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:53 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)) 09:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:53 INFO - Running setup.py (path:/tmp/pip-OPQYLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:53 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)) 09:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:53 INFO - Running setup.py (path:/tmp/pip-PnnkEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:53 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)) 09:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:53 INFO - Running setup.py (path:/tmp/pip-BKgPgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:53 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)) 09:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:53 INFO - Running setup.py (path:/tmp/pip-GbBpC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:53 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)) 09:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:53 INFO - Running setup.py (path:/tmp/pip-Z_U3EW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:53 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)) 09:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:53 INFO - Running setup.py (path:/tmp/pip-Xzi23B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:53 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)) 09:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:53 INFO - Running setup.py (path:/tmp/pip-0ZNaFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 09:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:54 INFO - Running setup.py (path:/tmp/pip-1ehQ5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:54 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)) 09:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:54 INFO - Running setup.py (path:/tmp/pip-6E0fXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:54 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)) 09:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:54 INFO - Running setup.py (path:/tmp/pip-kOYodu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:54 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)) 09:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:54 INFO - Running setup.py (path:/tmp/pip-HQm3Ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:54 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)) 09:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:54 INFO - Running setup.py (path:/tmp/pip-me03yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:54 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)) 09:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:54 INFO - Running setup.py (path:/tmp/pip-MnziIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:54 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)) 09:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:54 INFO - Running setup.py (path:/tmp/pip-h5GFo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:54 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)) 09:00:54 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)) 09:00:54 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)) 09:00:54 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)) 09:00:54 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)) 09:00:54 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)) 09:00:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:00:54 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 09:00:54 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 09:00:54 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 09:00:54 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 09:00:54 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 09:00:54 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 09:00:56 INFO - Downloading blessings-1.6.tar.gz 09:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:00:56 INFO - Installing collected packages: blessings 09:00:56 INFO - Running setup.py install for blessings 09:00:56 INFO - Successfully installed blessings 09:00:56 INFO - Cleaning up... 09:00:56 INFO - Return code: 0 09:00:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:00:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:00:57 INFO - Reading from file tmpfile_stdout 09:00:57 INFO - Current package versions: 09:00:57 INFO - argparse == 1.2.1 09:00:57 INFO - blessings == 1.6 09:00:57 INFO - blobuploader == 1.2.4 09:00:57 INFO - docopt == 0.6.1 09:00:57 INFO - manifestparser == 1.1 09:00:57 INFO - mozInstall == 1.12 09:00:57 INFO - mozcrash == 0.17 09:00:57 INFO - mozdebug == 0.1 09:00:57 INFO - mozdevice == 0.48 09:00:57 INFO - mozfile == 1.2 09:00:57 INFO - mozhttpd == 0.7 09:00:57 INFO - mozinfo == 0.9 09:00:57 INFO - mozleak == 0.1 09:00:57 INFO - mozlog == 3.1 09:00:57 INFO - moznetwork == 0.27 09:00:57 INFO - mozprocess == 0.22 09:00:57 INFO - mozprofile == 0.28 09:00:57 INFO - mozrunner == 6.11 09:00:57 INFO - mozscreenshot == 0.1 09:00:57 INFO - mozsystemmonitor == 0.0 09:00:57 INFO - moztest == 0.7 09:00:57 INFO - mozversion == 1.4 09:00:57 INFO - psutil == 3.1.1 09:00:57 INFO - requests == 1.2.3 09:00:57 INFO - wsgiref == 0.1.2 09:00:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:57 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 0x7ff70f92af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa410>, '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 0x13ab310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ab7a0>, '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-1459180280.411497-772721408', '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 09:00:57 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 09:00:57 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 09:00:57 INFO - Using env: {'DISPLAY': ':0', 09:00:57 INFO - 'HOME': '/home/cltbld', 09:00:57 INFO - 'LANG': 'en_US.UTF-8', 09:00:57 INFO - 'LANGUAGE': 'en_US:en', 09:00:57 INFO - 'LOGNAME': 'cltbld', 09:00:57 INFO - 'MAIL': '/var/mail/cltbld', 09:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:57 INFO - 'MOZ_NO_REMOTE': '1', 09:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:57 INFO - 'NO_EM_RESTART': '1', 09:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:57 INFO - 'PWD': '/builds/slave/test', 09:00:57 INFO - 'SHELL': '/bin/bash', 09:00:57 INFO - 'SHLVL': '1', 09:00:57 INFO - 'TERM': 'linux', 09:00:57 INFO - 'TMOUT': '86400', 09:00:57 INFO - 'USER': 'cltbld', 09:00:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1459180280.411497-772721408', 09:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:57 INFO - '_': '/tools/buildbot/bin/python'} 09:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:57 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)) 09:00:57 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)) 09:00:57 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)) 09:00:57 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)) 09:00:57 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)) 09:00:57 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)) 09:00:57 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)) 09:00:57 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)) 09:00:57 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)) 09:00:57 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)) 09:00:57 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)) 09:00:57 INFO - Cleaning up... 09:00:57 INFO - Return code: 0 09:00:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:57 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 0x7ff70f92af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa410>, '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 0x13ab310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ab7a0>, '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-1459180280.411497-772721408', '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 09:00:57 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 09:00:57 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 09:00:57 INFO - Using env: {'DISPLAY': ':0', 09:00:57 INFO - 'HOME': '/home/cltbld', 09:00:57 INFO - 'LANG': 'en_US.UTF-8', 09:00:57 INFO - 'LANGUAGE': 'en_US:en', 09:00:57 INFO - 'LOGNAME': 'cltbld', 09:00:57 INFO - 'MAIL': '/var/mail/cltbld', 09:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:57 INFO - 'MOZ_NO_REMOTE': '1', 09:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:57 INFO - 'NO_EM_RESTART': '1', 09:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:57 INFO - 'PWD': '/builds/slave/test', 09:00:57 INFO - 'SHELL': '/bin/bash', 09:00:57 INFO - 'SHLVL': '1', 09:00:57 INFO - 'TERM': 'linux', 09:00:57 INFO - 'TMOUT': '86400', 09:00:57 INFO - 'USER': 'cltbld', 09:00:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1459180280.411497-772721408', 09:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:57 INFO - '_': '/tools/buildbot/bin/python'} 09:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:57 INFO - Downloading/unpacking jsonschema 09:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:01:00 INFO - Downloading/unpacking functools32 (from jsonschema) 09:01:00 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 09:01:00 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 09:01:00 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 09:01:00 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 09:01:00 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 09:01:00 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 09:01:00 INFO - Downloading functools32-3.2.3-2.tar.gz 09:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:01:00 INFO - warning: no files found matching '*.txt' 09:01:00 INFO - no previously-included directories found matching 'build' 09:01:00 INFO - no previously-included directories found matching 'dist' 09:01:00 INFO - no previously-included directories found matching '.git*' 09:01:00 INFO - Installing collected packages: jsonschema, functools32 09:01:00 INFO - Running setup.py install for functools32 09:01:00 INFO - warning: no files found matching '*.txt' 09:01:00 INFO - no previously-included directories found matching 'build' 09:01:00 INFO - no previously-included directories found matching 'dist' 09:01:00 INFO - no previously-included directories found matching '.git*' 09:01:00 INFO - Successfully installed jsonschema functools32 09:01:00 INFO - Cleaning up... 09:01:00 INFO - Return code: 0 09:01:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:00 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 0x7ff70f92af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa410>, '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 0x13ab310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ab7a0>, '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-1459180280.411497-772721408', '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 09:01:00 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 09:01:00 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 09:01:00 INFO - Using env: {'DISPLAY': ':0', 09:01:00 INFO - 'HOME': '/home/cltbld', 09:01:00 INFO - 'LANG': 'en_US.UTF-8', 09:01:00 INFO - 'LANGUAGE': 'en_US:en', 09:01:00 INFO - 'LOGNAME': 'cltbld', 09:01:00 INFO - 'MAIL': '/var/mail/cltbld', 09:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:00 INFO - 'MOZ_NO_REMOTE': '1', 09:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:00 INFO - 'NO_EM_RESTART': '1', 09:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:00 INFO - 'PWD': '/builds/slave/test', 09:01:00 INFO - 'SHELL': '/bin/bash', 09:01:00 INFO - 'SHLVL': '1', 09:01:00 INFO - 'TERM': 'linux', 09:01:00 INFO - 'TMOUT': '86400', 09:01:00 INFO - 'USER': 'cltbld', 09:01:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1459180280.411497-772721408', 09:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:00 INFO - '_': '/tools/buildbot/bin/python'} 09:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:00 INFO - Downloading/unpacking flake8 09:01:00 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 09:01:00 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 09:01:00 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 09:01:00 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 09:01:00 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 09:01:00 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 09:01:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:01:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:01:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:01:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:01:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:01:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:01:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:01:03 INFO - no previously-included directories found matching 'docs/_build' 09:01:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:01:04 INFO - Running setup.py install for pep8 09:01:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:01:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:01:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:01:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:01:04 INFO - no previously-included directories found matching 'docs/_build' 09:01:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:01:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:01:04 INFO - Cleaning up... 09:01:04 INFO - Return code: 0 09:01:04 INFO - Running post-action listener: _resource_record_post_action 09:01:04 INFO - Running post-action listener: _start_resource_monitoring 09:01:04 INFO - Starting resource monitoring. 09:01:04 INFO - ##### 09:01:04 INFO - ##### Running install step. 09:01:04 INFO - ##### 09:01:04 INFO - Running pre-action listener: _resource_record_pre_action 09:01:04 INFO - Running main action method: install 09:01:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:04 INFO - Reading from file tmpfile_stdout 09:01:04 INFO - Detecting whether we're running mozinstall >=1.0... 09:01:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:01:04 INFO - Reading from file tmpfile_stdout 09:01:04 INFO - Output received: 09:01:04 INFO - Usage: mozinstall [options] installer 09:01:04 INFO - Options: 09:01:04 INFO - -h, --help show this help message and exit 09:01:04 INFO - -d DEST, --destination=DEST 09:01:04 INFO - Directory to install application into. [default: 09:01:04 INFO - "/builds/slave/test"] 09:01:04 INFO - --app=APP Application being installed. [default: firefox] 09:01:04 INFO - mkdir: /builds/slave/test/build/application 09:01:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:01:20 INFO - Reading from file tmpfile_stdout 09:01:20 INFO - Output received: 09:01:20 INFO - /builds/slave/test/build/application/firefox/firefox 09:01:20 INFO - Running post-action listener: _resource_record_post_action 09:01:20 INFO - ##### 09:01:20 INFO - ##### Running run-tests step. 09:01:20 INFO - ##### 09:01:20 INFO - Running pre-action listener: _resource_record_pre_action 09:01:20 INFO - Running main action method: run_tests 09:01:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:01:20 INFO - Python 2.7.3 09:01:20 INFO - Return code: 0 09:01:20 INFO - grabbing minidump binary from tooltool 09:01: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')]} 09:01:20 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa410>, '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 0x13ab310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ab7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:01:20 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 09:01:20 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 09:01:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:01:20 INFO - Return code: 0 09:01:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:01:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:01:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:01:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:01:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:01:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:01:21 INFO - Return code: 0 09:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:01:21 INFO - Using env: {'DISPLAY': ':0', 09:01:21 INFO - 'HOME': '/home/cltbld', 09:01:21 INFO - 'LANG': 'en_US.UTF-8', 09:01:21 INFO - 'LANGUAGE': 'en_US:en', 09:01:21 INFO - 'LOGNAME': 'cltbld', 09:01:21 INFO - 'MAIL': '/var/mail/cltbld', 09:01:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:01:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:21 INFO - 'MOZ_NO_REMOTE': '1', 09:01:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:21 INFO - 'NO_EM_RESTART': '1', 09:01:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:21 INFO - 'PWD': '/builds/slave/test', 09:01:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:01:21 INFO - 'SHELL': '/bin/bash', 09:01:21 INFO - 'SHLVL': '1', 09:01:21 INFO - 'TERM': 'linux', 09:01:21 INFO - 'TMOUT': '86400', 09:01:21 INFO - 'USER': 'cltbld', 09:01:21 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1459180280.411497-772721408', 09:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:21 INFO - '_': '/tools/buildbot/bin/python'} 09:01:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:01:21 INFO - mozversion application_buildid: 20160328081822 09:01:21 INFO - mozversion application_changeset: 75a1822f9cb2e95da462e067d1f2cb1cee114f25 09:01:21 INFO - mozversion application_display_name: Nightly 09:01:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:01:21 INFO - mozversion application_name: Firefox 09:01:21 INFO - mozversion application_remotingname: firefox 09:01:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:01:21 INFO - mozversion application_vendor: Mozilla 09:01:21 INFO - mozversion application_version: 48.0a1 09:01:21 INFO - mozversion platform_buildid: 20160328081822 09:01:21 INFO - mozversion platform_changeset: 75a1822f9cb2e95da462e067d1f2cb1cee114f25 09:01:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:01:21 INFO - mozversion platform_version: 48.0a1 09:01:21 INFO - using testdate: 1459180881 09:01:21 INFO - actual date: 1459180881 09:01:21 INFO - starting webserver on 'localhost:55893' 09:01:21 INFO - SUITE-START | Running 2 tests 09:01:21 INFO - TEST-START | dromaeo_css 09:01:21 INFO - operating with platform_type : linux_ 09:01:21 INFO - Initialising browser for dromaeo_css test... 09:01:21 INFO - TEST-INFO | started process 860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFwgMwa/profile http://localhost:55893/getInfo.html) 09:01:26 INFO - PROCESS | 860 | 09:01:26 INFO - PROCESS | 860 | (process:942): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:01:26 INFO - PROCESS | 860 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 09:01:27 INFO - PROCESS | 860 | __metrics Screen width/height:1600/1200 09:01:27 INFO - PROCESS | 860 | colorDepth:24 09:01:27 INFO - PROCESS | 860 | Browser inner width/height: 1024/697 09:01:27 INFO - PROCESS | 860 | __metrics 09:01:28 ERROR - PROCESS | 860 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 09:01:28 INFO - TEST-INFO | 860: exit 0 09:01:28 INFO - Browser initialized. 09:01:28 INFO - Running cycle 1/1 for dromaeo_css test... 09:01:28 INFO - TEST-INFO | started process 994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFwgMwa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:30 INFO - PROCESS | 994 | 09:01:30 INFO - PROCESS | 994 | (process:1059): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:01:40 INFO - PROCESS | 994 | RSS: Main: 164732928 09:01:40 INFO - PROCESS | 994 | 09:02:30 INFO - PROCESS | 994 | 1459180950552 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] 09:04:42 INFO - PROCESS | 994 | Cycle 1(1): loaded http://localhost:55893/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55893/tests/dromaeo/cssquery-ext.html) 09:04:43 INFO - PROCESS | 994 | RSS: Main: 169873408 09:04:43 INFO - PROCESS | 994 | 09:07:45 INFO - PROCESS | 994 | Cycle 1(1): loaded http://localhost:55893/tests/dromaeo/cssquery-ext.html (next: http://localhost:55893/tests/dromaeo/cssquery-jquery.html) 09:07:45 INFO - PROCESS | 994 | RSS: Main: 165548032 09:07:45 INFO - PROCESS | 994 | 09:10:47 INFO - PROCESS | 994 | Cycle 1(1): loaded http://localhost:55893/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55893/tests/dromaeo/cssquery-mootools.html) 09:10:48 INFO - PROCESS | 994 | RSS: Main: 166715392 09:10:48 INFO - PROCESS | 994 | 09:13:49 INFO - PROCESS | 994 | Cycle 1(1): loaded http://localhost:55893/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55893/tests/dromaeo/cssquery-prototype.html) 09:13:50 INFO - PROCESS | 994 | RSS: Main: 164446208 09:13:50 INFO - PROCESS | 994 | 09:16:53 INFO - PROCESS | 994 | Cycle 1(1): loaded http://localhost:55893/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55893/tests/dromaeo/cssquery-yui.html) 09:16:53 INFO - PROCESS | 994 | RSS: Main: 165715968 09:16:53 INFO - PROCESS | 994 | 09:19:56 INFO - PROCESS | 994 | Cycle 1(1): loaded http://localhost:55893/tests/dromaeo/cssquery-yui.html (next: http://localhost:55893/tests/dromaeo/cssquery-dojo.html) 09:19:56 INFO - PROCESS | 994 | RSS: Main: 168206336 09:19:56 INFO - PROCESS | 994 | 09:19:56 INFO - PROCESS | 994 | __start_tp_report 09:19:56 INFO - PROCESS | 994 | _x_x_mozilla_page_load 09:19:56 INFO - PROCESS | 994 | _x_x_mozilla_page_load_details 09:19:56 INFO - PROCESS | 994 | |i|pagename|runs| 09:19:56 INFO - PROCESS | 994 | |0;dojo.html;2604.45306485638;2687.946241075178;2708.4583083383327;2711.9830063726104;2729.61785350051;4753.120672675557;4772.117158325708;4783.432553004196;4803.9519604803945;4868;4784.688995215309;4808.51914808519;4865.440474345452;4870.196417591102;4882.682625629341;4399.890002749933;4447.977760111195;4497.550244975509;4511.59395654391;4540.772961351936;4493.0564581437775;4504.436945381827;4524.09518096382;4551.067031258584;4583.220852455074;4385.320275357325;4420.0938807544535;4436.3567282743825;4499.437570303712;4524.1630298394575;4437.423134992463;4472.08322293929;4480.529544397824;4482.125985432842;4516.051629157881;4449.199144154051;4450.198964186445;4450.354698568722;4453.933191002137;4477;4690.319903613991;4753.215719406294;4766.308885211625;4791.041791641651;4812.614990800727;5086.491350864921;5106.674408563706;5131.076406246874;5160.638755287131;5187.870303242411;5147.536721695065;5161.329027226474;5169.353830771153;5186.1442861927735;5261.342332208474;4863.489333619955;4866.805327786919;4873.585745211697;4876.561109500162;4896.0942225688;5308.150695888717;5320.973395133077;5328.36059672834;5343.599230057761;5361.249425080492;5008.749562521933;5101.158308878993;5114.87212819675;5178.792848286026;5184.170532714823;5125.641205115606;5139.717315547606;5174.534291913746;5196.220566914993;5210.192420174879;5051.595872330205;5060.190369540929;5062.164742817467;5090.592752579785;5119.283300337956;5056.57019153376;5115.18157094863;5132.127538318495;5176.844694659167;5224.37307523092;4323.783810809447;4325.567443255649;4335.1979883721615;4335.609795118391;4378.496472905593;3761.929550581262;3794.734368594227;3808.4858544096746;3810.9618903810606;3816.2367526494813;4443.688941774045;4456.9331460028125;4458.08609235106;4500.189965806187;4512;5176.8964620707375;5254.868628284324;5267.288915996368;5269.578433725293;5278.8944221116135;4371.650267978618;4497.617702495325;4498.190325741398;4504.752238626907;4565;4655.557722016403;4688.367070445514;4698.36572062774;4756.500567440438;4768.094062128184;4759.524047595212;4782.163121453801;4800.991791723777;4817.373741413594;4859.1010663027455;5064.7467626619255;5167.534921857051;5194.558462530727;5233;5294.338207724035;4779.163646361803;4801.303810947463;4824.469308376006;4850.054239423279;4871.439784424837;5116.565091967224;5138.511841375063;5147.382314122329;5147.639665223398;5195.636305458582;5129.307543481731;5167.58659307262;5203.92194117081;5218.66078704883;5220.425753167225;4955.82654607087;4984.950150498448;5033.92449113271;5036.169032109661;5101.285819985131;4926.4088309403105;5008.799648014038;5017.37282839645;5021.49785021495;5068.442471328225;4888.7311197884455;4937.28409380645;4945.975270123627;4951.232558953368;4963.627727920492;5023.799048038038;5030.547250747304;5043.193089105725;5053.444121146597;5067.7212753297445;4906.533879281463;4910.21436570147;4917.704937703606;4939.506049395031;4954.77703503336 09:19:56 INFO - PROCESS | 994 | |1;ext.html;530.5198795090445;537.5645726961161;554.5369616370331;575.8387651457591;599.3946114424435;35254.82372588137;35943.82028089859;36098.8195059025;36109.638903610954;36152.638473615254;38029.42955855664;38224.80887595565;38495.422568661495;38502.42246366307;38690;7641.12127105383;7801.648925798353;7812.49218800779;7837.059552853666;7849.764507064797;7568.09182898053;7678.155402905704;7718.421118416113;7738.535687858718;7753.728619498319;7848.175941526143;7856.4107691923045;7881.763547093597;7888.40836937232;7904.130545639975;7834.373250139975;7870.252326029018;7925.643346049413;7926.524408535506;7930.762077137666;7810.882836757453;7858.764237072897;7915.920840791634;7917.722879699183;7959.204079592052;38878.80560597207;39009.60990390117;39128.60871391278;39201.21597568033;39297.60702392968;2770.4874598199194;3347.2636020075543;3581.6955558777536;3681.0245284999496;3733.010752150682;25916.222513324632;25962.87018564914;26769.19692409231;27124.321891952663;27284.045058423057;3471.479278108279;3518.5249991251108;3536.504889315498;3597.6402359764074;3699.722520810923;166938;167828;168499;168771;169386.99999999878;43888.561114389086;43890.341644875356;44325;58366.12450813241;58813.41186588165;42493.57506424896;42494.78752606217;42549.14901701949;42600.360994585106;42723.57276427258;13327.533536326377;13384.397702103428;13428.328583570783;13429.127106738031;13432.529861454803;10054.849177262347;10084.394936303845;10110.747231319128;10154.796904061877;10174.084332410119;15124.773128403083;15124.773128403083;15133.924330378497;15282.617934551725;15301.923490382476;5815.82552523425;5996.580239383288;6033.401148695599;6041.486473649701;6042.1843051187525;839.3243439031517;940.5438362394233;941.7975135345796;985.3398223190479;1014.7919676466454;27288.454230915668;27492.862535687193;27842;27876.44247115046;27998.3000424991;983.6163896080534;990.8711867457184;1025.3898930136556;1042.0048853345038;1076.4617691154422;14062.71874562503;14090.929545352208;14451.49419770324;14636.268186590627;14685.118892866249;279758;286622;287467;289887;291102;48505.272420913716;48636;49024.509754902705;49053.26420103701;49079.75460122676;1205.3491114797912;1224.9326287054298;1253.229264002632;1259.659891829201;1266.518722885316;26186.476270474865;26785.464290714466;26899.193024209304;27048.72951270541;27315.726842732114;42655;42775;42918.5708142927;42991.355129672454;43170.35244471273;264814;265886;266818;267852;269084;32428.67571324351;32743.34513309673;33159.50260746139;33188;33299.83350083331;40865;41262;41273.380899285934;42188.78905605452;42528.787356063025;35762.463563047095;35810.8209458951;36066.27867442689;36250.27499450049;36324.818375907955;34790.82604586961;34895.476567850994;35218.295634087684;35292;35855.46216806802;35530;35632;36210.63789362178;36423.453648194765;36570.26859462743;30262.84868575643;31759.682403176597;32122.35755284928;32188.356232875678;32417.51373729443;25060.874695626404;25479.872600636878;25575.48849022972;25586.360340991625;25628.231153065437 09:19:56 INFO - PROCESS | 994 | |2;jquery.html;336.4885374231169;344.7914012022726;351.22905223035434;359.85965473465353;361.36399936112434;15064.397424103023;15731.370745170194;16587.502374928743;17713;17738.29046838128;15244.84755152448;15673.45142919998;15735.527934161964;16214;16301.266443010063;4971.577415919651;4998.500149985009;5171.948280517185;5172.32759741235;5189.636725429222;5155.871103222412;5203.661761985459;5224.764885580139;5227.3465816772905;5230.947690523084;4983.72589507577;5150.1759718445055;5178.508041736029;5187.6628019178825;5200.947990520103;4901.362822833044;5098.311727916739;5146.8198613048735;5174.508421699932;5209.973950130244;5245.659032162897;5271.42014378418;5280.49835265653;5287.497687719699;5295.285136506561;11595.884041159565;11813.586524471602;11862.822057669142;15463.381464741396;19175.424737257905;1950.7366505521716;2003.139842212996;2007.4278830533374;2040.4490787487296;2051.0462634874857;8282.627281772335;8969.775755606162;9062;9095.499747513884;9124.270058395312;1679.6892574873566;1698.4883453726193;1721.1652348610914;1762.9246159842614;1776.3072401763322;59142;60322.69838650822;60978;61031.38968610257;61312.69343653253;9358.859617105749;9370.484623345781;9611.855822162674;9655;9683.9031609683;13022.413991370411;13178.868211317764;13199.94400447962;13219.471221151047;13273.269970151734;6991.755288564876;7076.433885289164;7188.353048225685;7212.495125341281;7229.602371869598;6850.246472887979;6874.518783685094;6898.793036208922;6933.757318493828;6981.581105133709;4046.3728122141115;4074.9796251018556;4075.572064933199;4106.958930410658;4177.5195852476745;1711.563551294412;1778.5642517583276;1786.3211979447985;1805.6569251842109;1814.9909250453927;813.4468561378201;884.5002573545926;893.4237416866215;904.6064961741663;957.3681370295571;16042.518724438285;16121.27454264561;16171.676566468605;16340;16458.341666333214;881.38743573216;891.2736120062128;949.2738055387634;956.5073986896754;1009.7374682582581;9220.354575179674;9344.626214951462;9399.295052871063;9424.858627120599;9551.617935282511;290797;291896;292323;298411;395051;51555.74222128865;61577.38422615806;64626.676866615366;67584.6620766893;74799.62600186965;921.5852866210232;940.3699521320732;953.3755390219279;964.9903500965041;965.6234068713208;15272.923635381752;15407.537773866801;15441.768373474182;15503.224838757791;15711.135887526296;32468.51297230496;32854.342913141125;33510.16224594405;33619.83190084132;33925.32149357048;46200;46394;46948.295775562714;46978.29532557083;47509.81225469391;7133.144022717307;7273.199948005609;7346.081739782528;7438.6652600632015;7530.43521735861;11627;11752.882471175179;11990.580329688419;12102.93948530287;12188.634340969786;10327.741806454598;10562.260641755003;10753.569857205624;10782.191335650015;10898.400587967737;9831.85252221203;9858.211343092678;10131.79736405253;10407.011333923265;10508.68808862049;10376.896231037896;10800.081993030366;10931.781364372828;11109.944450277697;11146.442677866236;7160.319769621878;7202.855942881009;7255.09311336083;7260.636968151677;7510.474266801271;9776;10171.28800983924;10229.795404092025;10243.57856350092;10318.122959548222 09:19:56 INFO - PROCESS | 994 | |3;mootools.html;1455.774354974979;1460.9780853287202;1619.4655763598014;1735.357917570499;1797.8202179782031;6590.736370545173;7181.17416497103;7300.780976570704;7303.744368947088;7356.779296621096;7415.44384171188;7455.030845990027;7464.178940316561;7499.175090740015;7541.736039238628;2219.6004719150546;2242.091952759135;2244.887755612213;2253.1438053539714;2258.435391152212;2162.383720639618;2209.304069218199;2214.5460180662926;2215.8116560092412;2229.3869185973826;2201.7798220178015;2227.6992605998144;2228.142165266376;2246.797788199062;2274.5223503064376;2243.270936945483;2244.517428752818;2246.516998845248;2255.6052690779047;2263.9320820375415;2234.2068565659283;2235.6870038194666;2241.204372447774;2248.5053288276554;2248.9662655060188;7572;7670.923290767077;7696.153423123452;7727.227277272284;7728;4519.774011299455;4617.422822147231;4618.769061546943;4640.860774176746;4643.419572553431;3046.8019578727312;3081.5377693345954;3215.710586047267;3222.693844084808;3225.8064516128875;943.820674071931;955.9283053770926;974.025974025974;978.7210644966151;989.5843745626854;10621.150307975344;10637.414942178177;10647.52086156117;10661.520231589597;10679.57281708723;4249.745015299092;4252.596003379674;4325.3728209409455;4347.891302717458;4348.869533913924;9052.502112383881;9098.590563424661;9103.135202155785;9118.36171468004;9169.495677737788;4735.337052812609;4743.383360163157;4746.02706445178;4753.382060332135;4762.499937506581;3607.6211997740384;4103.179364127186;4182.435371224846;4290.570942905684;4297.39836422901;3519.085037890116;3638.0541059324764;3653.397189463762;3682.6133256007734;3702.241040586673;1201.339263405141;1233.1183204009176;1242.27327013698;1248.650377894191;1251.205484517338;991.3803872579638;1000.6347683095763;1007.6674697349857;1066.9306495077951;1197.6167626359481;6935.167779866449;6966.338197871295;6985.26654701249;7009.334113259232;7015;458.18900546033336;458.9421383710579;462.9051044535862;465.0675395831404;465.3159855013125;5513.862153446196;5555.2222688823595;5565.972170139124;5576.9163462548095;5596.272484576979;9303.395279306958;9511.239100871913;9536.713898582915;9574.808503829885;9577.90422095784;9069.54652267384;9262.583183756748;9305.162535371714;9337.066293370608;9337.953310233406;7051.717931282691;7092.680829362691;7104.147502299757;7137.2149063602965;7138.357547820721;6839.589624622339;6895.931040689529;6938.653067346713;6993.055937448379;6998.895016574857;7823.687052517836;8007.75976720676;8092.393070519617;8112.716054938049;8137.267645911897;8032.63853126599;8115.513069215866;8187.181281872004;8204.83590328202;8227.917720822716;5904.439078287556;6304.873902522016;6322.683865806599;6371.617702937839;6503.577267477599;7049.154101507646;7136.4647651427385;7161.928380716126;7184.568925864465;7221.4222862171955;6243.406876346739;6333.524985626189;6354.4281014708895;6381.298057213796;6422.807315780534;6242.001279795211;6261.123442717932;6319.652419116993;6361.332060133805;6402.071699603624;6683.331666833472;6689.063531105552;6712.2952090031795;6722.764703235363;6723.226828914541;6174.104754810617;6231.657258850625;6233.407826256498;6260.593061450991;6276.089966954857;6216.409441103088;6255.030470277115;6289.528285378707;6296.811095667137;6319.210098737658 09:19:56 INFO - PROCESS | 994 | |4;prototype.html;310.91294437557485;318.118810893824;321.8583823117828;324.57480700282645;324.62830059581785;5626.887462250757;5771;5771.884562308756;5772.45161709638;5810.128480727893;5542.4457554244555;5713.485786279234;5800.506956908657;5800.883982320362;5803.680797556132;4112.272845404922;4188.790560471964;4294.914101717964;4304.053108316165;4361.8037188326525;4311.245532031898;4316.82732690692;4323.459567554056;4329.350597410382;4337.913241735163;4273.059926816111;4274.487061552618;4297.183535128332;4297.226499230137;4299.914001719963;4302.677299202573;4302.935455968163;4304.311310190355;4305.50486694031;4319.092990472004;3728.5712143103347;3730.8880733578035;3733.607971163016;3734.421164719473;3735.028892487973;5464.863378415532;5474.39781624021;5480.424555421703;5481.12302031677;5489.066858634002;4744.217204161309;4892.192788189945;4906.754662266872;4971.726555039471;4979.327790748239;5926.525877929756;5960.360900752285;5986.28164620244;5996.100584912255;5997.7001149942325;4053.6149065838995;4055.945454181934;4074.9185016299803;4075.5924407559305;4080.12277360366;6264.718087686065;6298.937010629881;6345.809625711236;6350.904736428957;6365.1725275714325;4118.773467459318;4138.544760076389;4151.792410379529;4153.480814898137;4161.875143745692;4215.59951804578;4219.767912764827;4220.746755194698;4223.619874211336;4226.6829987750425;4787.928181077286;4926.236433352836;4926.8275610354185;4929.162042452792;4934.950650493521;6003.939960600425;6004.639721616717;6013.488853447506;6021.126936594169;6026.457618814327;1446.5804916574286;1484.1243666236755;1493.3280023989032;1496.0574837852084;1496.4911929943871;949.2643201518878;962.4417837654283;970.5729479029204;979.2459805949379;979.8579206015088;5149.150390185652;5165.9225111623355;5171.095058364771;5198.792048318025;5206.817761378334;6251.3123556408755;6261.530385221035;6266.874662506815;6267.968660156761;6276.843078923063;4971.1797553403285;5065.848024559269;5184.326037615161;5195.922061169085;5210;3355.3960287148548;3400.982995085058;3411.0790086676457;3412.283420481727;3420.7343282984957;5734.856628584235;5788.623739456922;5792.420757924258;5800.24596802413;5802.970985145047;6459.09572659828;6479.060536222221;6525.053867189231;6528.967355163194;6533.150690410216;5713.171590119409;5771.797987070432;5789.3921138279875;5791.420857914175;5799.5070419014855;5726.713664316851;6158.661273629993;6237.345078766845;6321.30465648769;6328.303886572381;6107.236595425572;6134.926387882014;6177.042558403455;6184.907226391698;6190.133381326708;5777.04678728022;5787.508061814793;5788.942110578841;5789.392113828156;5809.070548712186;4151.543330233611;4151.8339266429;4159.10579225468;4162.62536371728;4179.832806687698;5959;6036.577439579363;6229.190205273286;6281.277653069773;6289.874202516015;5876.676782776988;5947.762089516371;6024.909626355696;6066.939330606638;6069.393060693896;6022.789202377896;6037.758489660365;6040.848978775566;6044.697765111639;6079.270487541523;5963.344032156372;5973.313068997121;5974.820755377345;5984.640921544721;5984.730687119003;5858.882822343444;6113.480354169946;6125.938740612715;6128.356522565245;6141.385861414002;5890.587658863838;5937.703114844327;5947.762089516371;5958.046712525975;5967.194428752063 09:19:56 INFO - PROCESS | 994 | |5;yui.html;656.9802905912825;673.5722816011832;701.9473539484538;728.4318231779214;765.9348955338796;12194.390280485974;12254.877451225486;12334.506619735223;12400;12403.751924961507;12331.321777302244;12491.562795302167;12493.750124997494;12505.624831255076;12576.811347829767;803.3974519110652;805.8630032894422;816.073756286613;822.2271065198694;822.9218224268685;816.1756625807917;821.34292565947;824.056455358614;826.7726375246825;827.4042689263721;840.4621042532754;847.4999750147412;849.1423662101291;849.5412477262271;850.3027517435705;845.9619317130744;846.4328899637258;846.5767116441779;847.0132295875297;847.4915050969431;621.1459243540132;625.399616368287;625.4277336237337;628.4783629587478;630.5649102119569;13232;13276.137051091744;13302.068855180045;13331.400086996011;13379.799303010463;11774.823377649256;12079;12313.44589493475;12407.131500794949;12459.314737689423;9934.254930880214;9935.155511781508;10014.148797352234;10031;10073.899261007442;3301.158204657821;3325.8503367348526;3326.866925322984;3364.5457863188403;3373.7807042542404;41772;41913.58086419127;42332.365014525116;45300.77349613231;45796.54203457956;9958.701238962843;10010.849837252446;10011.299209055296;10034.297599168134;10296.536655850505;16905.83094169067;17027.148642567823;17040.659186816196;17131;17154.31382744701;6796.286389929085;6851.897221541681;6887.552309099992;6969.512134150561;6976.616286104313;3885.320068987916;3891.902702432405;3927.7643341399607;3951.9012024699614;3975.20495900821;2831.7451429371454;2874.180858455372;2888.321244507539;2896.5075937090746;2925.6781754007043;527.459354161987;527.9762410691528;528.1022262154277;552.6269767906647;557.8605348662834;600.9663378988133;617.3178637605381;624.519120277393;654.4306453385585;664.1930054983219;7339.74310899116;8449.704260350858;8640.956795216109;8725.127487251224;8747.431416958005;533.6104643610108;542.0378827581075;640.9262934762469;641.9518536109811;646.9514786390945;3634.496305676597;3829.425586162098;3919.8628048018754;4086.6322031016757;4113.444684967491;50078.49921500811;51615;51980.22029669558;52595.73702131465;52710.73644631829;44217.33673994828;44603;44869.55130448719;45020.549794502294;45388.77305613451;41072;42208.788956055025;42411.363829542584;42610;42644.360334595;8013.71905756044;8346.374021948257;8723.345749068718;8816.51509167002;8828.249598784176;31702.207444814063;31915.840420797747;31935.68064319327;32356.35287294288;33225.667743323225;38055.80972095122;40879.59120408758;41082.38376424416;41289.58710412977;41727.791361043;10540.367577945348;10592.754941281106;10644.095251903675;10852.620158294421;10925.07136893373;11492.080633549464;11551.191416601094;11973.221740586834;12106.09204309698;12227;11179.72050698739;11388.302459040844;11465.484053217791;11537.596184133516;11571.305721656727;11062.17033722458;11444.656660300205;11568.582687325665;11812.881871181178;11836.112291577994;10739.570417183226;10843.421670848758;10962.725931851768;10981.670549883516;11024.50389732448;9911.504424778876;10006.949965250418;10116.494175291058;10222.233332499944;10289.639862604772;9939.950300248453;10001.899981000097;10018.749531261778;10117.29178957466;10212.131968782736 09:19:56 INFO - PROCESS | 994 | __end_tp_report 09:19:56 INFO - PROCESS | 994 | __start_cc_report 09:19:56 INFO - PROCESS | 994 | _x_x_mozilla_cycle_collect,363 09:19:56 INFO - PROCESS | 994 | __end_cc_report 09:19:56 INFO - PROCESS | 994 | __startTimestamp1459181996432__endTimestamp 09:19:56 INFO - PROCESS | 994 | 09:19:56 INFO - PROCESS | 994 | ------- Summary: start ------- 09:19:56 INFO - PROCESS | 994 | Number of tests: 6 09:19:56 INFO - PROCESS | 994 | 09:19:56 INFO - PROCESS | 994 | [#0] dojo.html Cycles:165 Average:4778.09 Median:4876.56 stddev:501.05 (10.3%) stddev-sans-first:472.68 09:19:56 INFO - PROCESS | 994 | Values: 2604.5 2687.9 2708.5 2712.0 2729.6 4753.1 4772.1 4783.4 4804.0 4868.0 4784.7 4808.5 4865.4 4870.2 4882.7 4399.9 4448.0 4497.6 4511.6 4540.8 4493.1 4504.4 4524.1 4551.1 4583.2 4385.3 4420.1 4436.4 4499.4 4524.2 4437.4 4472.1 4480.5 4482.1 4516.1 4449.2 4450.2 4450.4 4453.9 4477.0 4690.3 4753.2 4766.3 4791.0 4812.6 5086.5 5106.7 5131.1 5160.6 5187.9 5147.5 5161.3 5169.4 5186.1 5261.3 4863.5 4866.8 4873.6 4876.6 4896.1 5308.2 5321.0 5328.4 5343.6 5361.2 5008.7 5101.2 5114.9 5178.8 5184.2 5125.6 5139.7 5174.5 5196.2 5210.2 5051.6 5060.2 5062.2 5090.6 5119.3 5056.6 5115.2 5132.1 5176.8 5224.4 4323.8 4325.6 4335.2 4335.6 4378.5 3761.9 3794.7 3808.5 3811.0 3816.2 4443.7 4456.9 4458.1 4500.2 4512.0 5176.9 5254.9 5267.3 5269.6 5278.9 4371.7 4497.6 4498.2 4504.8 4565.0 4655.6 4688.4 4698.4 4756.5 4768.1 4759.5 4782.2 4801.0 4817.4 4859.1 5064.7 5167.5 5194.6 5233.0 5294.3 4779.2 4801.3 4824.5 4850.1 4871.4 5116.6 5138.5 5147.4 5147.6 5195.6 5129.3 5167.6 5203.9 5218.7 5220.4 4955.8 4985.0 5033.9 5036.2 5101.3 4926.4 5008.8 5017.4 5021.5 5068.4 4888.7 4937.3 4946.0 4951.2 4963.6 5023.8 5030.5 5043.2 5053.4 5067.7 4906.5 4910.2 4917.7 4939.5 4954.8 09:19:56 INFO - PROCESS | 994 | 09:19:56 INFO - PROCESS | 994 | [#1] ext.html Cycles:180 Average:40250.25 Median:19770.73 stddev:64312.06 (325.3%) stddev-sans-first:64423.32 09:19:56 INFO - PROCESS | 994 | Values: 530.5 537.6 554.5 575.8 599.4 35254.8 35943.8 36098.8 36109.6 36152.6 38029.4 38224.8 38495.4 38502.4 38690.0 7641.1 7801.6 7812.5 7837.1 7849.8 7568.1 7678.2 7718.4 7738.5 7753.7 7848.2 7856.4 7881.8 7888.4 7904.1 7834.4 7870.3 7925.6 7926.5 7930.8 7810.9 7858.8 7915.9 7917.7 7959.2 38878.8 39009.6 39128.6 39201.2 39297.6 2770.5 3347.3 3581.7 3681.0 3733.0 25916.2 25962.9 26769.2 27124.3 27284.0 3471.5 3518.5 3536.5 3597.6 3699.7 166938.0 167828.0 168499.0 168771.0 169387.0 43888.6 43890.3 44325.0 58366.1 58813.4 42493.6 42494.8 42549.1 42600.4 42723.6 13327.5 13384.4 13428.3 13429.1 13432.5 10054.8 10084.4 10110.7 10154.8 10174.1 15124.8 15124.8 15133.9 15282.6 15301.9 5815.8 5996.6 6033.4 6041.5 6042.2 839.3 940.5 941.8 985.3 1014.8 27288.5 27492.9 27842.0 27876.4 27998.3 983.6 990.9 1025.4 1042.0 1076.5 14062.7 14090.9 14451.5 14636.3 14685.1 279758.0 286622.0 287467.0 289887.0 291102.0 48505.3 48636.0 49024.5 49053.3 49079.8 1205.3 1224.9 1253.2 1259.7 1266.5 26186.5 26785.5 26899.2 27048.7 27315.7 42655.0 42775.0 42918.6 42991.4 43170.4 264814.0 265886.0 266818.0 267852.0 269084.0 32428.7 32743.3 33159.5 33188.0 33299.8 40865.0 41262.0 41273.4 42188.8 42528.8 35762.5 35810.8 36066.3 36250.3 36324.8 34790.8 34895.5 35218.3 35292.0 35855.5 35530.0 35632.0 36210.6 36423.5 36570.3 30262.8 31759.7 32122.4 32188.4 32417.5 25060.9 25479.9 25575.5 25586.4 25628.2 09:19:56 INFO - PROCESS | 994 | 09:19:56 INFO - PROCESS | 994 | [#2] jquery.html Cycles:180 Average:21068.32 Median:46963.30 stddev:52274.08 (111.3%) stddev-sans-first:52397.55 09:19:56 INFO - PROCESS | 994 | Values: 336.5 344.8 351.2 359.9 361.4 15064.4 15731.4 16587.5 17713.0 17738.3 15244.8 15673.5 15735.5 16214.0 16301.3 4971.6 4998.5 5171.9 5172.3 5189.6 5155.9 5203.7 5224.8 5227.3 5230.9 4983.7 5150.2 5178.5 5187.7 5200.9 4901.4 5098.3 5146.8 5174.5 5210.0 5245.7 5271.4 5280.5 5287.5 5295.3 11595.9 11813.6 11862.8 15463.4 19175.4 1950.7 2003.1 2007.4 2040.4 2051.0 8282.6 8969.8 9062.0 9095.5 9124.3 1679.7 1698.5 1721.2 1762.9 1776.3 59142.0 60322.7 60978.0 61031.4 61312.7 9358.9 9370.5 9611.9 9655.0 9683.9 13022.4 13178.9 13199.9 13219.5 13273.3 6991.8 7076.4 7188.4 7212.5 7229.6 6850.2 6874.5 6898.8 6933.8 6981.6 4046.4 4075.0 4075.6 4107.0 4177.5 1711.6 1778.6 1786.3 1805.7 1815.0 813.4 884.5 893.4 904.6 957.4 16042.5 16121.3 16171.7 16340.0 16458.3 881.4 891.3 949.3 956.5 1009.7 9220.4 9344.6 9399.3 9424.9 9551.6 290797.0 291896.0 292323.0 298411.0 395051.0 51555.7 61577.4 64626.7 67584.7 74799.6 921.6 940.4 953.4 965.0 965.6 15272.9 15407.5 15441.8 15503.2 15711.1 32468.5 32854.3 33510.2 33619.8 33925.3 46200.0 46394.0 46948.3 46978.3 47509.8 7133.1 7273.2 7346.1 7438.7 7530.4 11627.0 11752.9 11990.6 12102.9 12188.6 10327.7 10562.3 10753.6 10782.2 10898.4 9831.9 9858.2 10131.8 10407.0 10508.7 10376.9 10800.1 10931.8 11109.9 11146.4 7160.3 7202.9 7255.1 7260.6 7510.5 9776.0 10171.3 10229.8 10243.6 10318.1 09:19:56 INFO - PROCESS | 994 | 09:19:56 INFO - PROCESS | 994 | [#3] mootools.html Cycles:180 Average:5276.97 Median:6249.22 stddev:2762.20 (44.2%) stddev-sans-first:2755.02 09:19:56 INFO - PROCESS | 994 | Values: 1455.8 1461.0 1619.5 1735.4 1797.8 6590.7 7181.2 7300.8 7303.7 7356.8 7415.4 7455.0 7464.2 7499.2 7541.7 2219.6 2242.1 2244.9 2253.1 2258.4 2162.4 2209.3 2214.5 2215.8 2229.4 2201.8 2227.7 2228.1 2246.8 2274.5 2243.3 2244.5 2246.5 2255.6 2263.9 2234.2 2235.7 2241.2 2248.5 2249.0 7572.0 7670.9 7696.2 7727.2 7728.0 4519.8 4617.4 4618.8 4640.9 4643.4 3046.8 3081.5 3215.7 3222.7 3225.8 943.8 955.9 974.0 978.7 989.6 10621.2 10637.4 10647.5 10661.5 10679.6 4249.7 4252.6 4325.4 4347.9 4348.9 9052.5 9098.6 9103.1 9118.4 9169.5 4735.3 4743.4 4746.0 4753.4 4762.5 3607.6 4103.2 4182.4 4290.6 4297.4 3519.1 3638.1 3653.4 3682.6 3702.2 1201.3 1233.1 1242.3 1248.7 1251.2 991.4 1000.6 1007.7 1066.9 1197.6 6935.2 6966.3 6985.3 7009.3 7015.0 458.2 458.9 462.9 465.1 465.3 5513.9 5555.2 5566.0 5576.9 5596.3 9303.4 9511.2 9536.7 9574.8 9577.9 9069.5 9262.6 9305.2 9337.1 9338.0 7051.7 7092.7 7104.1 7137.2 7138.4 6839.6 6895.9 6938.7 6993.1 6998.9 7823.7 8007.8 8092.4 8112.7 8137.3 8032.6 8115.5 8187.2 8204.8 8227.9 5904.4 6304.9 6322.7 6371.6 6503.6 7049.2 7136.5 7161.9 7184.6 7221.4 6243.4 6333.5 6354.4 6381.3 6422.8 6242.0 6261.1 6319.7 6361.3 6402.1 6683.3 6689.1 6712.3 6722.8 6723.2 6174.1 6231.7 6233.4 6260.6 6276.1 6216.4 6255.0 6289.5 6296.8 6319.2 09:19:56 INFO - PROCESS | 994 | 09:19:56 INFO - PROCESS | 994 | [#4] prototype.html Cycles:180 Average:4935.27 Median:5752.93 stddev:1490.31 (25.9%) stddev-sans-first:1453.51 09:19:56 INFO - PROCESS | 994 | Values: 310.9 318.1 321.9 324.6 324.6 5626.9 5771.0 5771.9 5772.5 5810.1 5542.4 5713.5 5800.5 5800.9 5803.7 4112.3 4188.8 4294.9 4304.1 4361.8 4311.2 4316.8 4323.5 4329.4 4337.9 4273.1 4274.5 4297.2 4297.2 4299.9 4302.7 4302.9 4304.3 4305.5 4319.1 3728.6 3730.9 3733.6 3734.4 3735.0 5464.9 5474.4 5480.4 5481.1 5489.1 4744.2 4892.2 4906.8 4971.7 4979.3 5926.5 5960.4 5986.3 5996.1 5997.7 4053.6 4055.9 4074.9 4075.6 4080.1 6264.7 6298.9 6345.8 6350.9 6365.2 4118.8 4138.5 4151.8 4153.5 4161.9 4215.6 4219.8 4220.7 4223.6 4226.7 4787.9 4926.2 4926.8 4929.2 4935.0 6003.9 6004.6 6013.5 6021.1 6026.5 1446.6 1484.1 1493.3 1496.1 1496.5 949.3 962.4 970.6 979.2 979.9 5149.2 5165.9 5171.1 5198.8 5206.8 6251.3 6261.5 6266.9 6268.0 6276.8 4971.2 5065.8 5184.3 5195.9 5210.0 3355.4 3401.0 3411.1 3412.3 3420.7 5734.9 5788.6 5792.4 5800.2 5803.0 6459.1 6479.1 6525.1 6529.0 6533.2 5713.2 5771.8 5789.4 5791.4 5799.5 5726.7 6158.7 6237.3 6321.3 6328.3 6107.2 6134.9 6177.0 6184.9 6190.1 5777.0 5787.5 5788.9 5789.4 5809.1 4151.5 4151.8 4159.1 4162.6 4179.8 5959.0 6036.6 6229.2 6281.3 6289.9 5876.7 5947.8 6024.9 6066.9 6069.4 6022.8 6037.8 6040.8 6044.7 6079.3 5963.3 5973.3 5974.8 5984.6 5984.7 5858.9 6113.5 6125.9 6128.4 6141.4 5890.6 5937.7 5947.8 5958.0 5967.2 09:19:56 INFO - PROCESS | 994 | 09:19:56 INFO - PROCESS | 994 | [#5] yui.html Cycles:180 Average:12873.26 Median:40975.80 stddev:14278.82 (34.8%) stddev-sans-first:14289.40 09:19:56 INFO - PROCESS | 994 | Values: 657.0 673.6 701.9 728.4 765.9 12194.4 12254.9 12334.5 12400.0 12403.8 12331.3 12491.6 12493.8 12505.6 12576.8 803.4 805.9 816.1 822.2 822.9 816.2 821.3 824.1 826.8 827.4 840.5 847.5 849.1 849.5 850.3 846.0 846.4 846.6 847.0 847.5 621.1 625.4 625.4 628.5 630.6 13232.0 13276.1 13302.1 13331.4 13379.8 11774.8 12079.0 12313.4 12407.1 12459.3 9934.3 9935.2 10014.1 10031.0 10073.9 3301.2 3325.9 3326.9 3364.5 3373.8 41772.0 41913.6 42332.4 45300.8 45796.5 9958.7 10010.8 10011.3 10034.3 10296.5 16905.8 17027.1 17040.7 17131.0 17154.3 6796.3 6851.9 6887.6 6969.5 6976.6 3885.3 3891.9 3927.8 3951.9 3975.2 2831.7 2874.2 2888.3 2896.5 2925.7 527.5 528.0 528.1 552.6 557.9 601.0 617.3 624.5 654.4 664.2 7339.7 8449.7 8641.0 8725.1 8747.4 533.6 542.0 640.9 642.0 647.0 3634.5 3829.4 3919.9 4086.6 4113.4 50078.5 51615.0 51980.2 52595.7 52710.7 44217.3 44603.0 44869.6 45020.5 45388.8 41072.0 42208.8 42411.4 42610.0 42644.4 8013.7 8346.4 8723.3 8816.5 8828.2 31702.2 31915.8 31935.7 32356.4 33225.7 38055.8 40879.6 41082.4 41289.6 41727.8 10540.4 10592.8 10644.1 10852.6 10925.1 11492.1 11551.2 11973.2 12106.1 12227.0 11179.7 11388.3 11465.5 11537.6 11571.3 11062.2 11444.7 11568.6 11812.9 11836.1 10739.6 10843.4 10962.7 10981.7 11024.5 9911.5 10006.9 10116.5 10222.2 10289.6 9940.0 10001.9 10018.7 10117.3 10212.1 09:19:56 INFO - PROCESS | 994 | -------- Summary: end -------- 09:19:56 INFO - PROCESS | 994 | 09:19:57 INFO - TEST-INFO | 994: exit 0 09:19:57 INFO - TEST-OK | dromaeo_css | took 1115786ms 09:19:57 INFO - TEST-START | kraken 09:19:57 INFO - operating with platform_type : linux_ 09:19:57 INFO - Initialising browser for kraken test... 09:19:57 INFO - TEST-INFO | started process 1313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR175le/profile http://localhost:55893/getInfo.html) 09:20:01 INFO - PROCESS | 1313 | 09:20:01 INFO - PROCESS | 1313 | (process:1383): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:20:01 INFO - PROCESS | 1313 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 09:20:02 INFO - PROCESS | 1313 | __metrics Screen width/height:1600/1200 09:20:02 INFO - PROCESS | 1313 | colorDepth:24 09:20:02 INFO - PROCESS | 1313 | Browser inner width/height: 1024/697 09:20:02 INFO - PROCESS | 1313 | __metrics 09:20:02 ERROR - PROCESS | 1313 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 09:20:03 INFO - TEST-INFO | 1313: exit 0 09:20:03 INFO - Browser initialized. 09:20:03 INFO - Running cycle 1/1 for kraken test... 09:20:03 INFO - TEST-INFO | started process 1434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR175le/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:05 INFO - PROCESS | 1434 | 09:20:05 INFO - PROCESS | 1434 | (process:1496): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:20:15 INFO - PROCESS | 1434 | RSS: Main: 165195776 09:20:15 INFO - PROCESS | 1434 | 09:20:18 INFO - PROCESS | 1434 | Cycle 1(1): loaded http://localhost:55893/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55893/tests/kraken/driver.html?testName=audio-beat-detection) 09:20:19 INFO - PROCESS | 1434 | RSS: Main: 169844736 09:20:19 INFO - PROCESS | 1434 | 09:20:21 INFO - PROCESS | 1434 | Cycle 1(1): loaded http://localhost:55893/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55893/tests/kraken/driver.html?testName=audio-dft) 09:20:22 INFO - PROCESS | 1434 | RSS: Main: 172965888 09:20:22 INFO - PROCESS | 1434 | 09:20:25 INFO - PROCESS | 1434 | Cycle 1(1): loaded http://localhost:55893/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55893/tests/kraken/driver.html?testName=audio-fft) 09:20:25 INFO - PROCESS | 1434 | RSS: Main: 163172352 09:20:25 INFO - PROCESS | 1434 | 09:20:28 INFO - PROCESS | 1434 | Cycle 1(1): loaded http://localhost:55893/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55893/tests/kraken/driver.html?testName=audio-oscillator) 09:20:28 INFO - PROCESS | 1434 | RSS: Main: 163495936 09:20:28 INFO - PROCESS | 1434 | 09:20:30 INFO - PROCESS | 1434 | Cycle 1(1): loaded http://localhost:55893/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55893/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:20:31 INFO - PROCESS | 1434 | RSS: Main: 165085184 09:20:31 INFO - PROCESS | 1434 | 09:20:34 INFO - PROCESS | 1434 | Cycle 1(1): loaded http://localhost:55893/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55893/tests/kraken/driver.html?testName=imaging-darkroom) 09:20:35 INFO - PROCESS | 1434 | RSS: Main: 165441536 09:20:35 INFO - PROCESS | 1434 | 09:20:38 INFO - PROCESS | 1434 | Cycle 1(1): loaded http://localhost:55893/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55893/tests/kraken/driver.html?testName=imaging-desaturate) 09:20:39 INFO - PROCESS | 1434 | RSS: Main: 164032512 09:20:39 INFO - PROCESS | 1434 | 09:20:42 INFO - PROCESS | 1434 | Cycle 1(1): loaded http://localhost:55893/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55893/tests/kraken/driver.html?testName=json-parse-financial) 09:20:43 INFO - PROCESS | 1434 | RSS: Main: 165072896 09:20:43 INFO - PROCESS | 1434 | 09:20:44 INFO - PROCESS | 1434 | Cycle 1(1): loaded http://localhost:55893/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55893/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:20:45 INFO - PROCESS | 1434 | RSS: Main: 164888576 09:20:45 INFO - PROCESS | 1434 | 09:20:47 INFO - PROCESS | 1434 | Cycle 1(1): loaded http://localhost:55893/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55893/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:20:47 INFO - PROCESS | 1434 | RSS: Main: 164917248 09:20:47 INFO - PROCESS | 1434 | 09:20:50 INFO - PROCESS | 1434 | Cycle 1(1): loaded http://localhost:55893/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55893/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:20:50 INFO - PROCESS | 1434 | RSS: Main: 165535744 09:20:50 INFO - PROCESS | 1434 | 09:20:53 INFO - PROCESS | 1434 | Cycle 1(1): loaded http://localhost:55893/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:20:53 INFO - PROCESS | 1434 | RSS: Main: 166006784 09:20:53 INFO - PROCESS | 1434 | 09:20:56 INFO - PROCESS | 1434 | Cycle 1(1): loaded http://localhost:55893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:20:57 INFO - PROCESS | 1434 | RSS: Main: 165568512 09:20:57 INFO - PROCESS | 1434 | 09:20:58 INFO - PROCESS | 1434 | Cycle 1(1): loaded http://localhost:55893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55893/tests/kraken/driver.html?testName=ai-astar) 09:20:59 INFO - PROCESS | 1434 | RSS: Main: 167239680 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - PROCESS | 1434 | __start_tp_report 09:20:59 INFO - PROCESS | 1434 | _x_x_mozilla_page_load 09:20:59 INFO - PROCESS | 1434 | _x_x_mozilla_page_load_details 09:20:59 INFO - PROCESS | 1434 | |i|pagename|runs| 09:20:59 INFO - PROCESS | 1434 | |0;ai-astar;113;108;113;113;113;130;125;114;114;112 09:20:59 INFO - PROCESS | 1434 | |1;audio-beat-detection;158;138;156;182;138;154;165;132;184;133 09:20:59 INFO - PROCESS | 1434 | |2;audio-dft;162;168;162;162;163;165;166;163;166;162 09:20:59 INFO - PROCESS | 1434 | |3;audio-fft;73;74;76;75;73;76;75;153;75;74 09:20:59 INFO - PROCESS | 1434 | |4;audio-oscillator;94;96;139;94;93;94;144;93;94;148 09:20:59 INFO - PROCESS | 1434 | |5;imaging-gaussian-blur;118;118;117;118;117;118;117;118;119;118 09:20:59 INFO - PROCESS | 1434 | |6;imaging-darkroom;148;146;149;147;147;149;148;147;148;147 09:20:59 INFO - PROCESS | 1434 | |7;imaging-desaturate;95;97;97;96;96;96;96;96;96;96 09:20:59 INFO - PROCESS | 1434 | |8;json-parse-financial;65;65;66;65;66;67;65;66;66;64 09:20:59 INFO - PROCESS | 1434 | |9;json-stringify-tinderbox;64;65;66;64;64;64;64;64;64;64 09:20:59 INFO - PROCESS | 1434 | |10;stanford-crypto-aes;84;84;83;86;85;84;83;86;85;85 09:20:59 INFO - PROCESS | 1434 | |11;stanford-crypto-ccm;120;118;124;124;120;130;122;122;132;118 09:20:59 INFO - PROCESS | 1434 | |12;stanford-crypto-pbkdf2;147;143;145;136;132;145;146;150;145;134 09:20:59 INFO - PROCESS | 1434 | |13;stanford-crypto-sha256-iterative;71;72;68;67;67;66;67;67;69;76 09:20:59 INFO - PROCESS | 1434 | __end_tp_report 09:20:59 INFO - PROCESS | 1434 | __start_cc_report 09:20:59 INFO - PROCESS | 1434 | _x_x_mozilla_cycle_collect,917 09:20:59 INFO - PROCESS | 1434 | __end_cc_report 09:20:59 INFO - PROCESS | 1434 | __startTimestamp1459182059027__endTimestamp 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - PROCESS | 1434 | ------- Summary: start ------- 09:20:59 INFO - PROCESS | 1434 | Number of tests: 14 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - PROCESS | 1434 | [#0] ai-astar Cycles:10 Average:115.50 Median:113.50 stddev:6.65 (5.9%) stddev-sans-first:7.00 09:20:59 INFO - PROCESS | 1434 | Values: 113.0 108.0 113.0 113.0 113.0 130.0 125.0 114.0 114.0 112.0 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - PROCESS | 1434 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:157.00 stddev:19.04 (12.1%) stddev-sans-first:20.14 09:20:59 INFO - PROCESS | 1434 | Values: 158.0 138.0 156.0 182.0 138.0 154.0 165.0 132.0 184.0 133.0 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - PROCESS | 1434 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.18 (1.3%) stddev-sans-first:2.20 09:20:59 INFO - PROCESS | 1434 | Values: 162.0 168.0 162.0 162.0 163.0 165.0 166.0 163.0 166.0 162.0 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - PROCESS | 1434 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:24.83 (33.1%) stddev-sans-first:26.10 09:20:59 INFO - PROCESS | 1434 | Values: 73.0 74.0 76.0 75.0 73.0 76.0 75.0 153.0 75.0 74.0 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - PROCESS | 1434 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:94.00 stddev:24.10 (25.6%) stddev-sans-first:24.95 09:20:59 INFO - PROCESS | 1434 | Values: 94.0 96.0 139.0 94.0 93.0 94.0 144.0 93.0 94.0 148.0 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - PROCESS | 1434 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 09:20:59 INFO - PROCESS | 1434 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 117.0 118.0 119.0 118.0 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - PROCESS | 1434 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 09:20:59 INFO - PROCESS | 1434 | Values: 148.0 146.0 149.0 147.0 147.0 149.0 148.0 147.0 148.0 147.0 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - PROCESS | 1434 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 09:20:59 INFO - PROCESS | 1434 | Values: 95.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - PROCESS | 1434 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 09:20:59 INFO - PROCESS | 1434 | Values: 65.0 65.0 66.0 65.0 66.0 67.0 65.0 66.0 66.0 64.0 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - PROCESS | 1434 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 09:20:59 INFO - PROCESS | 1434 | Values: 64.0 65.0 66.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - PROCESS | 1434 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.00 stddev:1.08 (1.3%) stddev-sans-first:1.13 09:20:59 INFO - PROCESS | 1434 | Values: 84.0 84.0 83.0 86.0 85.0 84.0 83.0 86.0 85.0 85.0 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - PROCESS | 1434 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:123.00 stddev:4.74 (3.9%) stddev-sans-first:4.90 09:20:59 INFO - PROCESS | 1434 | Values: 120.0 118.0 124.0 124.0 120.0 130.0 122.0 122.0 132.0 118.0 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - PROCESS | 1434 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:145.00 stddev:6.07 (4.2%) stddev-sans-first:6.20 09:20:59 INFO - PROCESS | 1434 | Values: 147.0 143.0 145.0 136.0 132.0 145.0 146.0 150.0 145.0 134.0 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - PROCESS | 1434 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.50 stddev:3.13 (4.6%) stddev-sans-first:3.23 09:20:59 INFO - PROCESS | 1434 | Values: 71.0 72.0 68.0 67.0 67.0 66.0 67.0 67.0 69.0 76.0 09:20:59 INFO - PROCESS | 1434 | -------- Summary: end -------- 09:20:59 INFO - PROCESS | 1434 | 09:20:59 INFO - TEST-INFO | 1434: exit 0 09:21:00 INFO - TEST-OK | kraken | took 62827ms 09:21:00 INFO - SUITE-END | took 1178s 09:21:00 INFO - Completed test suite (00:19:38) 09:21:00 INFO - javascript benchmark 09:21:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2604.45306485638, 2687.946241075178, 2708.4583083383327, 2711.9830063726104, 2729.61785350051, 4753.120672675557, 4772.117158325708, 4783.432553004196, 4803.9519604803945, 4868.0, 4784.688995215309, 4808.51914808519, 4865.440474345452, 4870.196417591102, 4882.682625629341, 4399.890002749933, 4447.977760111195, 4497.550244975509, 4511.59395654391, 4540.772961351936, 4493.0564581437775, 4504.436945381827, 4524.09518096382, 4551.067031258584, 4583.220852455074, 4385.320275357325, 4420.0938807544535, 4436.3567282743825, 4499.437570303712, 4524.1630298394575, 4437.423134992463, 4472.08322293929, 4480.529544397824, 4482.125985432842, 4516.051629157881, 4449.199144154051, 4450.198964186445, 4450.354698568722, 4453.933191002137, 4477.0, 4690.319903613991, 4753.215719406294, 4766.308885211625, 4791.041791641651, 4812.614990800727, 5086.491350864921, 5106.674408563706, 5131.076406246874, 5160.638755287131, 5187.870303242411, 5147.536721695065, 5161.329027226474, 5169.353830771153, 5186.1442861927735, 5261.342332208474, 4863.489333619955, 4866.805327786919, 4873.585745211697, 4876.561109500162, 4896.0942225688, 5308.150695888717, 5320.973395133077, 5328.36059672834, 5343.599230057761, 5361.249425080492, 5008.749562521933, 5101.158308878993, 5114.87212819675, 5178.792848286026, 5184.170532714823, 5125.641205115606, 5139.717315547606, 5174.534291913746, 5196.220566914993, 5210.192420174879, 5051.595872330205, 5060.190369540929, 5062.164742817467, 5090.592752579785, 5119.283300337956, 5056.57019153376, 5115.18157094863, 5132.127538318495, 5176.844694659167, 5224.37307523092, 4323.783810809447, 4325.567443255649, 4335.1979883721615, 4335.609795118391, 4378.496472905593, 3761.929550581262, 3794.734368594227, 3808.4858544096746, 3810.9618903810606, 3816.2367526494813, 4443.688941774045, 4456.9331460028125, 4458.08609235106, 4500.189965806187, 4512.0, 5176.8964620707375, 5254.868628284324, 5267.288915996368, 5269.578433725293, 5278.8944221116135, 4371.650267978618, 4497.617702495325, 4498.190325741398, 4504.752238626907, 4565.0, 4655.557722016403, 4688.367070445514, 4698.36572062774, 4756.500567440438, 4768.094062128184, 4759.524047595212, 4782.163121453801, 4800.991791723777, 4817.373741413594, 4859.1010663027455, 5064.7467626619255, 5167.534921857051, 5194.558462530727, 5233.0, 5294.338207724035, 4779.163646361803, 4801.303810947463, 4824.469308376006, 4850.054239423279, 4871.439784424837, 5116.565091967224, 5138.511841375063, 5147.382314122329, 5147.639665223398, 5195.636305458582, 5129.307543481731, 5167.58659307262, 5203.92194117081, 5218.66078704883, 5220.425753167225, 4955.82654607087, 4984.950150498448, 5033.92449113271, 5036.169032109661, 5101.285819985131, 4926.4088309403105, 5008.799648014038, 5017.37282839645, 5021.49785021495, 5068.442471328225, 4888.7311197884455, 4937.28409380645, 4945.975270123627, 4951.232558953368, 4963.627727920492, 5023.799048038038, 5030.547250747304, 5043.193089105725, 5053.444121146597, 5067.7212753297445, 4906.533879281463, 4910.21436570147, 4917.704937703606, 4939.506049395031, 4954.77703503336], "unit": "score", "name": "dojo.html", "value": 4745.870232059052}, {"lowerIsBetter": false, "replicates": [530.5198795090445, 537.5645726961161, 554.5369616370331, 575.8387651457591, 599.3946114424435, 35254.82372588137, 35943.82028089859, 36098.8195059025, 36109.638903610954, 36152.638473615254, 38029.42955855664, 38224.80887595565, 38495.422568661495, 38502.42246366307, 38690.0, 7641.12127105383, 7801.648925798353, 7812.49218800779, 7837.059552853666, 7849.764507064797, 7568.09182898053, 7678.155402905704, 7718.421118416113, 7738.535687858718, 7753.728619498319, 7848.175941526143, 7856.4107691923045, 7881.763547093597, 7888.40836937232, 7904.130545639975, 7834.373250139975, 7870.252326029018, 7925.643346049413, 7926.524408535506, 7930.762077137666, 7810.882836757453, 7858.764237072897, 7915.920840791634, 7917.722879699183, 7959.204079592052, 38878.80560597207, 39009.60990390117, 39128.60871391278, 39201.21597568033, 39297.60702392968, 2770.4874598199194, 3347.2636020075543, 3581.6955558777536, 3681.0245284999496, 3733.010752150682, 25916.222513324632, 25962.87018564914, 26769.19692409231, 27124.321891952663, 27284.045058423057, 3471.479278108279, 3518.5249991251108, 3536.504889315498, 3597.6402359764074, 3699.722520810923, 166938.0, 167828.0, 168499.0, 168771.0, 169386.99999999878, 43888.561114389086, 43890.341644875356, 44325.0, 58366.12450813241, 58813.41186588165, 42493.57506424896, 42494.78752606217, 42549.14901701949, 42600.360994585106, 42723.57276427258, 13327.533536326377, 13384.397702103428, 13428.328583570783, 13429.127106738031, 13432.529861454803, 10054.849177262347, 10084.394936303845, 10110.747231319128, 10154.796904061877, 10174.084332410119, 15124.773128403083, 15124.773128403083, 15133.924330378497, 15282.617934551725, 15301.923490382476, 5815.82552523425, 5996.580239383288, 6033.401148695599, 6041.486473649701, 6042.1843051187525, 839.3243439031517, 940.5438362394233, 941.7975135345796, 985.3398223190479, 1014.7919676466454, 27288.454230915668, 27492.862535687193, 27842.0, 27876.44247115046, 27998.3000424991, 983.6163896080534, 990.8711867457184, 1025.3898930136556, 1042.0048853345038, 1076.4617691154422, 14062.71874562503, 14090.929545352208, 14451.49419770324, 14636.268186590627, 14685.118892866249, 279758.0, 286622.0, 287467.0, 289887.0, 291102.0, 48505.272420913716, 48636.0, 49024.509754902705, 49053.26420103701, 49079.75460122676, 1205.3491114797912, 1224.9326287054298, 1253.229264002632, 1259.659891829201, 1266.518722885316, 26186.476270474865, 26785.464290714466, 26899.193024209304, 27048.72951270541, 27315.726842732114, 42655.0, 42775.0, 42918.5708142927, 42991.355129672454, 43170.35244471273, 264814.0, 265886.0, 266818.0, 267852.0, 269084.0, 32428.67571324351, 32743.34513309673, 33159.50260746139, 33188.0, 33299.83350083331, 40865.0, 41262.0, 41273.380899285934, 42188.78905605452, 42528.787356063025, 35762.463563047095, 35810.8209458951, 36066.27867442689, 36250.27499450049, 36324.818375907955, 34790.82604586961, 34895.476567850994, 35218.295634087684, 35292.0, 35855.46216806802, 35530.0, 35632.0, 36210.63789362178, 36423.453648194765, 36570.26859462743, 30262.84868575643, 31759.682403176597, 32122.35755284928, 32188.356232875678, 32417.51373729443, 25060.874695626404, 25479.872600636878, 25575.48849022972, 25586.360340991625, 25628.231153065437], "unit": "score", "name": "ext.html", "value": 16815.23029287535}, {"lowerIsBetter": false, "replicates": [336.4885374231169, 344.7914012022726, 351.22905223035434, 359.85965473465353, 361.36399936112434, 15064.397424103023, 15731.370745170194, 16587.502374928743, 17713.0, 17738.29046838128, 15244.84755152448, 15673.45142919998, 15735.527934161964, 16214.0, 16301.266443010063, 4971.577415919651, 4998.500149985009, 5171.948280517185, 5172.32759741235, 5189.636725429222, 5155.871103222412, 5203.661761985459, 5224.764885580139, 5227.3465816772905, 5230.947690523084, 4983.72589507577, 5150.1759718445055, 5178.508041736029, 5187.6628019178825, 5200.947990520103, 4901.362822833044, 5098.311727916739, 5146.8198613048735, 5174.508421699932, 5209.973950130244, 5245.659032162897, 5271.42014378418, 5280.49835265653, 5287.497687719699, 5295.285136506561, 11595.884041159565, 11813.586524471602, 11862.822057669142, 15463.381464741396, 19175.424737257905, 1950.7366505521716, 2003.139842212996, 2007.4278830533374, 2040.4490787487296, 2051.0462634874857, 8282.627281772335, 8969.775755606162, 9062.0, 9095.499747513884, 9124.270058395312, 1679.6892574873566, 1698.4883453726193, 1721.1652348610914, 1762.9246159842614, 1776.3072401763322, 59142.0, 60322.69838650822, 60978.0, 61031.38968610257, 61312.69343653253, 9358.859617105749, 9370.484623345781, 9611.855822162674, 9655.0, 9683.9031609683, 13022.413991370411, 13178.868211317764, 13199.94400447962, 13219.471221151047, 13273.269970151734, 6991.755288564876, 7076.433885289164, 7188.353048225685, 7212.495125341281, 7229.602371869598, 6850.246472887979, 6874.518783685094, 6898.793036208922, 6933.757318493828, 6981.581105133709, 4046.3728122141115, 4074.9796251018556, 4075.572064933199, 4106.958930410658, 4177.5195852476745, 1711.563551294412, 1778.5642517583276, 1786.3211979447985, 1805.6569251842109, 1814.9909250453927, 813.4468561378201, 884.5002573545926, 893.4237416866215, 904.6064961741663, 957.3681370295571, 16042.518724438285, 16121.27454264561, 16171.676566468605, 16340.0, 16458.341666333214, 881.38743573216, 891.2736120062128, 949.2738055387634, 956.5073986896754, 1009.7374682582581, 9220.354575179674, 9344.626214951462, 9399.295052871063, 9424.858627120599, 9551.617935282511, 290797.0, 291896.0, 292323.0, 298411.0, 395051.0, 51555.74222128865, 61577.38422615806, 64626.676866615366, 67584.6620766893, 74799.62600186965, 921.5852866210232, 940.3699521320732, 953.3755390219279, 964.9903500965041, 965.6234068713208, 15272.923635381752, 15407.537773866801, 15441.768373474182, 15503.224838757791, 15711.135887526296, 32468.51297230496, 32854.342913141125, 33510.16224594405, 33619.83190084132, 33925.32149357048, 46200.0, 46394.0, 46948.295775562714, 46978.29532557083, 47509.81225469391, 7133.144022717307, 7273.199948005609, 7346.081739782528, 7438.6652600632015, 7530.43521735861, 11627.0, 11752.882471175179, 11990.580329688419, 12102.93948530287, 12188.634340969786, 10327.741806454598, 10562.260641755003, 10753.569857205624, 10782.191335650015, 10898.400587967737, 9831.85252221203, 9858.211343092678, 10131.79736405253, 10407.011333923265, 10508.68808862049, 10376.896231037896, 10800.081993030366, 10931.781364372828, 11109.944450277697, 11146.442677866236, 7160.319769621878, 7202.855942881009, 7255.09311336083, 7260.636968151677, 7510.474266801271, 9776.0, 10171.28800983924, 10229.795404092025, 10243.57856350092, 10318.122959548222], "unit": "score", "name": "jquery.html", "value": 7869.350098960308}, {"lowerIsBetter": false, "replicates": [1455.774354974979, 1460.9780853287202, 1619.4655763598014, 1735.357917570499, 1797.8202179782031, 6590.736370545173, 7181.17416497103, 7300.780976570704, 7303.744368947088, 7356.779296621096, 7415.44384171188, 7455.030845990027, 7464.178940316561, 7499.175090740015, 7541.736039238628, 2219.6004719150546, 2242.091952759135, 2244.887755612213, 2253.1438053539714, 2258.435391152212, 2162.383720639618, 2209.304069218199, 2214.5460180662926, 2215.8116560092412, 2229.3869185973826, 2201.7798220178015, 2227.6992605998144, 2228.142165266376, 2246.797788199062, 2274.5223503064376, 2243.270936945483, 2244.517428752818, 2246.516998845248, 2255.6052690779047, 2263.9320820375415, 2234.2068565659283, 2235.6870038194666, 2241.204372447774, 2248.5053288276554, 2248.9662655060188, 7572.0, 7670.923290767077, 7696.153423123452, 7727.227277272284, 7728.0, 4519.774011299455, 4617.422822147231, 4618.769061546943, 4640.860774176746, 4643.419572553431, 3046.8019578727312, 3081.5377693345954, 3215.710586047267, 3222.693844084808, 3225.8064516128875, 943.820674071931, 955.9283053770926, 974.025974025974, 978.7210644966151, 989.5843745626854, 10621.150307975344, 10637.414942178177, 10647.52086156117, 10661.520231589597, 10679.57281708723, 4249.745015299092, 4252.596003379674, 4325.3728209409455, 4347.891302717458, 4348.869533913924, 9052.502112383881, 9098.590563424661, 9103.135202155785, 9118.36171468004, 9169.495677737788, 4735.337052812609, 4743.383360163157, 4746.02706445178, 4753.382060332135, 4762.499937506581, 3607.6211997740384, 4103.179364127186, 4182.435371224846, 4290.570942905684, 4297.39836422901, 3519.085037890116, 3638.0541059324764, 3653.397189463762, 3682.6133256007734, 3702.241040586673, 1201.339263405141, 1233.1183204009176, 1242.27327013698, 1248.650377894191, 1251.205484517338, 991.3803872579638, 1000.6347683095763, 1007.6674697349857, 1066.9306495077951, 1197.6167626359481, 6935.167779866449, 6966.338197871295, 6985.26654701249, 7009.334113259232, 7015.0, 458.18900546033336, 458.9421383710579, 462.9051044535862, 465.0675395831404, 465.3159855013125, 5513.862153446196, 5555.2222688823595, 5565.972170139124, 5576.9163462548095, 5596.272484576979, 9303.395279306958, 9511.239100871913, 9536.713898582915, 9574.808503829885, 9577.90422095784, 9069.54652267384, 9262.583183756748, 9305.162535371714, 9337.066293370608, 9337.953310233406, 7051.717931282691, 7092.680829362691, 7104.147502299757, 7137.2149063602965, 7138.357547820721, 6839.589624622339, 6895.931040689529, 6938.653067346713, 6993.055937448379, 6998.895016574857, 7823.687052517836, 8007.75976720676, 8092.393070519617, 8112.716054938049, 8137.267645911897, 8032.63853126599, 8115.513069215866, 8187.181281872004, 8204.83590328202, 8227.917720822716, 5904.439078287556, 6304.873902522016, 6322.683865806599, 6371.617702937839, 6503.577267477599, 7049.154101507646, 7136.4647651427385, 7161.928380716126, 7184.568925864465, 7221.4222862171955, 6243.406876346739, 6333.524985626189, 6354.4281014708895, 6381.298057213796, 6422.807315780534, 6242.001279795211, 6261.123442717932, 6319.652419116993, 6361.332060133805, 6402.071699603624, 6683.331666833472, 6689.063531105552, 6712.2952090031795, 6722.764703235363, 6723.226828914541, 6174.104754810617, 6231.657258850625, 6233.407826256498, 6260.593061450991, 6276.089966954857, 6216.409441103088, 6255.030470277115, 6289.528285378707, 6296.811095667137, 6319.210098737658], "unit": "score", "name": "mootools.html", "value": 4267.144208744359}, {"lowerIsBetter": false, "replicates": [310.91294437557485, 318.118810893824, 321.8583823117828, 324.57480700282645, 324.62830059581785, 5626.887462250757, 5771.0, 5771.884562308756, 5772.45161709638, 5810.128480727893, 5542.4457554244555, 5713.485786279234, 5800.506956908657, 5800.883982320362, 5803.680797556132, 4112.272845404922, 4188.790560471964, 4294.914101717964, 4304.053108316165, 4361.8037188326525, 4311.245532031898, 4316.82732690692, 4323.459567554056, 4329.350597410382, 4337.913241735163, 4273.059926816111, 4274.487061552618, 4297.183535128332, 4297.226499230137, 4299.914001719963, 4302.677299202573, 4302.935455968163, 4304.311310190355, 4305.50486694031, 4319.092990472004, 3728.5712143103347, 3730.8880733578035, 3733.607971163016, 3734.421164719473, 3735.028892487973, 5464.863378415532, 5474.39781624021, 5480.424555421703, 5481.12302031677, 5489.066858634002, 4744.217204161309, 4892.192788189945, 4906.754662266872, 4971.726555039471, 4979.327790748239, 5926.525877929756, 5960.360900752285, 5986.28164620244, 5996.100584912255, 5997.7001149942325, 4053.6149065838995, 4055.945454181934, 4074.9185016299803, 4075.5924407559305, 4080.12277360366, 6264.718087686065, 6298.937010629881, 6345.809625711236, 6350.904736428957, 6365.1725275714325, 4118.773467459318, 4138.544760076389, 4151.792410379529, 4153.480814898137, 4161.875143745692, 4215.59951804578, 4219.767912764827, 4220.746755194698, 4223.619874211336, 4226.6829987750425, 4787.928181077286, 4926.236433352836, 4926.8275610354185, 4929.162042452792, 4934.950650493521, 6003.939960600425, 6004.639721616717, 6013.488853447506, 6021.126936594169, 6026.457618814327, 1446.5804916574286, 1484.1243666236755, 1493.3280023989032, 1496.0574837852084, 1496.4911929943871, 949.2643201518878, 962.4417837654283, 970.5729479029204, 979.2459805949379, 979.8579206015088, 5149.150390185652, 5165.9225111623355, 5171.095058364771, 5198.792048318025, 5206.817761378334, 6251.3123556408755, 6261.530385221035, 6266.874662506815, 6267.968660156761, 6276.843078923063, 4971.1797553403285, 5065.848024559269, 5184.326037615161, 5195.922061169085, 5210.0, 3355.3960287148548, 3400.982995085058, 3411.0790086676457, 3412.283420481727, 3420.7343282984957, 5734.856628584235, 5788.623739456922, 5792.420757924258, 5800.24596802413, 5802.970985145047, 6459.09572659828, 6479.060536222221, 6525.053867189231, 6528.967355163194, 6533.150690410216, 5713.171590119409, 5771.797987070432, 5789.3921138279875, 5791.420857914175, 5799.5070419014855, 5726.713664316851, 6158.661273629993, 6237.345078766845, 6321.30465648769, 6328.303886572381, 6107.236595425572, 6134.926387882014, 6177.042558403455, 6184.907226391698, 6190.133381326708, 5777.04678728022, 5787.508061814793, 5788.942110578841, 5789.392113828156, 5809.070548712186, 4151.543330233611, 4151.8339266429, 4159.10579225468, 4162.62536371728, 4179.832806687698, 5959.0, 6036.577439579363, 6229.190205273286, 6281.277653069773, 6289.874202516015, 5876.676782776988, 5947.762089516371, 6024.909626355696, 6066.939330606638, 6069.393060693896, 6022.789202377896, 6037.758489660365, 6040.848978775566, 6044.697765111639, 6079.270487541523, 5963.344032156372, 5973.313068997121, 5974.820755377345, 5984.640921544721, 5984.730687119003, 5858.882822343444, 6113.480354169946, 6125.938740612715, 6128.356522565245, 6141.385861414002, 5890.587658863838, 5937.703114844327, 5947.762089516371, 5958.046712525975, 5967.194428752063], "unit": "score", "name": "prototype.html", "value": 4451.118795351728}, {"lowerIsBetter": false, "replicates": [656.9802905912825, 673.5722816011832, 701.9473539484538, 728.4318231779214, 765.9348955338796, 12194.390280485974, 12254.877451225486, 12334.506619735223, 12400.0, 12403.751924961507, 12331.321777302244, 12491.562795302167, 12493.750124997494, 12505.624831255076, 12576.811347829767, 803.3974519110652, 805.8630032894422, 816.073756286613, 822.2271065198694, 822.9218224268685, 816.1756625807917, 821.34292565947, 824.056455358614, 826.7726375246825, 827.4042689263721, 840.4621042532754, 847.4999750147412, 849.1423662101291, 849.5412477262271, 850.3027517435705, 845.9619317130744, 846.4328899637258, 846.5767116441779, 847.0132295875297, 847.4915050969431, 621.1459243540132, 625.399616368287, 625.4277336237337, 628.4783629587478, 630.5649102119569, 13232.0, 13276.137051091744, 13302.068855180045, 13331.400086996011, 13379.799303010463, 11774.823377649256, 12079.0, 12313.44589493475, 12407.131500794949, 12459.314737689423, 9934.254930880214, 9935.155511781508, 10014.148797352234, 10031.0, 10073.899261007442, 3301.158204657821, 3325.8503367348526, 3326.866925322984, 3364.5457863188403, 3373.7807042542404, 41772.0, 41913.58086419127, 42332.365014525116, 45300.77349613231, 45796.54203457956, 9958.701238962843, 10010.849837252446, 10011.299209055296, 10034.297599168134, 10296.536655850505, 16905.83094169067, 17027.148642567823, 17040.659186816196, 17131.0, 17154.31382744701, 6796.286389929085, 6851.897221541681, 6887.552309099992, 6969.512134150561, 6976.616286104313, 3885.320068987916, 3891.902702432405, 3927.7643341399607, 3951.9012024699614, 3975.20495900821, 2831.7451429371454, 2874.180858455372, 2888.321244507539, 2896.5075937090746, 2925.6781754007043, 527.459354161987, 527.9762410691528, 528.1022262154277, 552.6269767906647, 557.8605348662834, 600.9663378988133, 617.3178637605381, 624.519120277393, 654.4306453385585, 664.1930054983219, 7339.74310899116, 8449.704260350858, 8640.956795216109, 8725.127487251224, 8747.431416958005, 533.6104643610108, 542.0378827581075, 640.9262934762469, 641.9518536109811, 646.9514786390945, 3634.496305676597, 3829.425586162098, 3919.8628048018754, 4086.6322031016757, 4113.444684967491, 50078.49921500811, 51615.0, 51980.22029669558, 52595.73702131465, 52710.73644631829, 44217.33673994828, 44603.0, 44869.55130448719, 45020.549794502294, 45388.77305613451, 41072.0, 42208.788956055025, 42411.363829542584, 42610.0, 42644.360334595, 8013.71905756044, 8346.374021948257, 8723.345749068718, 8816.51509167002, 8828.249598784176, 31702.207444814063, 31915.840420797747, 31935.68064319327, 32356.35287294288, 33225.667743323225, 38055.80972095122, 40879.59120408758, 41082.38376424416, 41289.58710412977, 41727.791361043, 10540.367577945348, 10592.754941281106, 10644.095251903675, 10852.620158294421, 10925.07136893373, 11492.080633549464, 11551.191416601094, 11973.221740586834, 12106.09204309698, 12227.0, 11179.72050698739, 11388.302459040844, 11465.484053217791, 11537.596184133516, 11571.305721656727, 11062.17033722458, 11444.656660300205, 11568.582687325665, 11812.881871181178, 11836.112291577994, 10739.570417183226, 10843.421670848758, 10962.725931851768, 10981.670549883516, 11024.50389732448, 9911.504424778876, 10006.949965250418, 10116.494175291058, 10222.233332499944, 10289.639862604772, 9939.950300248453, 10001.899981000097, 10018.749531261778, 10117.29178957466, 10212.131968782736], "unit": "score", "name": "yui.html", "value": 6054.02924723519}], "name": "dromaeo_css", "value": 6453.194097638766}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 113.0, 113.0, 113.0, 130.0, 125.0, 114.0, 114.0, 112.0], "unit": "score", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [158.0, 138.0, 156.0, 182.0, 138.0, 154.0, 165.0, 132.0, 184.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 154.0}, {"lowerIsBetter": true, "replicates": [162.0, 168.0, 162.0, 162.0, 163.0, 165.0, 166.0, 163.0, 166.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 76.0, 75.0, 73.0, 76.0, 75.0, 153.0, 75.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.4}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 139.0, 94.0, 93.0, 94.0, 144.0, 93.0, 94.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 119.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.8}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 149.0, 147.0, 147.0, 149.0, 148.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 67.0, 65.0, 66.0, 66.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 65.5}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 66.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.3}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 83.0, 86.0, 85.0, 84.0, 83.0, 86.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [120.0, 118.0, 124.0, 124.0, 120.0, 130.0, 122.0, 122.0, 132.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [147.0, 143.0, 145.0, 136.0, 132.0, 145.0, 146.0, 150.0, 145.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 68.0, 67.0, 67.0, 66.0, 67.0, 67.0, 69.0, 76.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1534.7999999999997}]} 09:21:00 INFO - Return code: 0 09:21:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:21:00 ERROR - # TBPL SUCCESS # 09:21:00 INFO - Running post-action listener: _resource_record_post_action 09:21:00 INFO - Running post-run listener: _resource_record_post_run 09:21:01 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 385634304; Read time: 12; Write time: 458148 09:21:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99049472; Read time: 0; Write time: 117104 09:21:01 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286584832; Read time: 12; Write time: 341044 09:21:01 INFO - Running post-run listener: _upload_blobber_files 09:21:01 INFO - Blob upload gear active. 09:21:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:21:01 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 09:21:01 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:21:01 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:21:01 INFO - (blobuploader) - INFO - Open directory for files ... 09:21:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:21:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:21:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:02 INFO - (blobuploader) - INFO - Done attempting. 09:21:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:21:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:21:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:03 INFO - (blobuploader) - INFO - Done attempting. 09:21:03 INFO - (blobuploader) - INFO - Iteration through files over. 09:21:03 INFO - Return code: 0 09:21:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:21:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:21:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0467b445429fd9ea0e5a096d3d244c40a75f966e0f8bc86834a706eb28bf76777e001f8430749724db4915d75325ae9be143f99e2003143fbfb416791bca1d7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99e2b9091a85962c9366f181fd69217d2a1e15c60316d3d9aee308502e4d6f8095504349c46b5181c7498d37b14bb7c51faf87ababc06d7811b7b7fdd6f1d1a3"} 09:21:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:21:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:21:03 INFO - Contents: 09:21:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0467b445429fd9ea0e5a096d3d244c40a75f966e0f8bc86834a706eb28bf76777e001f8430749724db4915d75325ae9be143f99e2003143fbfb416791bca1d7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99e2b9091a85962c9366f181fd69217d2a1e15c60316d3d9aee308502e4d6f8095504349c46b5181c7498d37b14bb7c51faf87ababc06d7811b7b7fdd6f1d1a3"} 09:21:03 INFO - Running post-run listener: copy_logs_to_upload_dir 09:21:03 INFO - Copying logs to upload dir... 09:21:03 INFO - mkdir: /builds/slave/test/build/upload/logs 09:21:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.067414 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-03-28 09:21:03.292125) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 09:21:03.295756) ========= 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-1459180280.411497-772721408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0467b445429fd9ea0e5a096d3d244c40a75f966e0f8bc86834a706eb28bf76777e001f8430749724db4915d75325ae9be143f99e2003143fbfb416791bca1d7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99e2b9091a85962c9366f181fd69217d2a1e15c60316d3d9aee308502e4d6f8095504349c46b5181c7498d37b14bb7c51faf87ababc06d7811b7b7fdd6f1d1a3"} build_url:https://queue.taskcluster.net/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011357 build_url: 'https://queue.taskcluster.net/v1/task/GlHd4q50S_Cf2vk-rpf-aA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0467b445429fd9ea0e5a096d3d244c40a75f966e0f8bc86834a706eb28bf76777e001f8430749724db4915d75325ae9be143f99e2003143fbfb416791bca1d7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99e2b9091a85962c9366f181fd69217d2a1e15c60316d3d9aee308502e4d6f8095504349c46b5181c7498d37b14bb7c51faf87ababc06d7811b7b7fdd6f1d1a3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 09:21:03.321487) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:21:03.321850) ========= 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-1459180280.411497-772721408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004776 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:21:03.409546) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 09:21:03.409898) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 09:21:03.410241) ========= ========= Total master_lag: 0.33 =========