builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1457654818.31 results: success (0) buildid: 20160310150717 builduid: 1ca4746b148a4a368a4dfbb43ea5f313 revision: c1d6cd4595a03608cf23c1a6c136ea862dc37fc9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:58.311628) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:58.312075) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:58.312372) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006432 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:58.333586) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:58.333892) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:58.352035) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:58.352398) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:58.401754) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:58.402069) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:58.402427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:58.402699) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-10 16:06:58-- 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% 216M=0s 2016-03-10 16:06:58 (216 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150974 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:58.567526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:58.567859) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018773 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:58.617756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:58.618117) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c1d6cd4595a03608cf23c1a6c136ea862dc37fc9 --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 c1d6cd4595a03608cf23c1a6c136ea862dc37fc9 --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=5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-10 16:06:58,835 truncating revision to first 12 chars 2016-03-10 16:06:58,835 Setting DEBUG logging. 2016-03-10 16:06:58,835 attempt 1/10 2016-03-10 16:06:58,835 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c1d6cd4595a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-10 16:06:59,218 unpacking tar archive at: fx-team-c1d6cd4595a0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679606 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:59.311415) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:59.311773) ========= echo c1d6cd4595a03608cf23c1a6c136ea862dc37fc9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c1d6cd4595a03608cf23c1a6c136ea862dc37fc9'] 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=5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c1d6cd4595a03608cf23c1a6c136ea862dc37fc9 program finished with exit code 0 elapsedTime=0.004076 script_repo_revision: 'c1d6cd4595a03608cf23c1a6c136ea862dc37fc9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:59.364648) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:59.365057) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 16:06:59.375782) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-03-10 16:06:59.376170) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:06:59 INFO - MultiFileLogger online at 20160310 16:06:59 in /builds/slave/test 16:06:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 16:06:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:06:59 INFO - {'append_to_log': False, 16:06:59 INFO - 'base_work_dir': '/builds/slave/test', 16:06:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:06:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:06:59 INFO - 'branch': 'Fx-Team-Non-PGO', 16:06:59 INFO - 'buildbot_json_path': 'buildprops.json', 16:06:59 INFO - 'config_files': ('talos/linux_config.py',), 16:06:59 INFO - 'default_actions': ('clobber', 16:06:59 INFO - 'read-buildbot-config', 16:06:59 INFO - 'download-and-extract', 16:06:59 INFO - 'populate-webroot', 16:06:59 INFO - 'create-virtualenv', 16:06:59 INFO - 'install', 16:06:59 INFO - 'run-tests'), 16:06:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:06:59 INFO - 'download_minidump_stackwalk': True, 16:06:59 INFO - 'download_symbols': 'ondemand', 16:06:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:06:59 INFO - 'tooltool.py': '/tools/tooltool.py', 16:06:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:06:59 INFO - '/tools/misc-python/virtualenv.py')}, 16:06:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:06:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:06:59 INFO - 'installer_path': 'installer.exe', 16:06:59 INFO - 'log_level': 'info', 16:06:59 INFO - 'log_name': 'talos', 16:06:59 INFO - 'log_to_console': True, 16:06:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:06:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:06:59 INFO - 'opt_config_files': (), 16:06:59 INFO - 'pip_index': False, 16:06:59 INFO - 'sps_profile': False, 16:06:59 INFO - 'sps_profile_interval': 0, 16:06:59 INFO - 'suite': 'dromaeojs', 16:06:59 INFO - 'system_bits': '32', 16:06:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:06:59 INFO - 'title': 'talos-linux64-ix-011', 16:06:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:06:59 INFO - 'use_talos_json': True, 16:06:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:06:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:06:59 INFO - 'work_dir': 'build'} 16:06:59 INFO - ##### 16:06:59 INFO - ##### Running clobber step. 16:06:59 INFO - ##### 16:06:59 INFO - Running pre-action listener: _resource_record_pre_action 16:06:59 INFO - Running main action method: clobber 16:06:59 INFO - rmtree: /builds/slave/test/build 16:06:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:07:00 INFO - Running post-action listener: _resource_record_post_action 16:07:00 INFO - ##### 16:07:00 INFO - ##### Running read-buildbot-config step. 16:07:00 INFO - ##### 16:07:00 INFO - Running pre-action listener: _resource_record_pre_action 16:07:00 INFO - Running main action method: read_buildbot_config 16:07:00 INFO - Using buildbot properties: 16:07:00 INFO - { 16:07:00 INFO - "project": "", 16:07:00 INFO - "product": "firefox", 16:07:00 INFO - "script_repo_revision": "production", 16:07:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:07:00 INFO - "repository": "", 16:07:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:07:00 INFO - "buildid": "20160310150717", 16:07:00 INFO - "pgo_build": "False", 16:07:00 INFO - "basedir": "/builds/slave/test", 16:07:00 INFO - "buildnumber": 1433, 16:07:00 INFO - "slavename": "talos-linux64-ix-011", 16:07:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:07:00 INFO - "platform": "ubuntu64_hw", 16:07:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:07:00 INFO - "branch": "fx-team", 16:07:00 INFO - "repo_path": "integration/fx-team", 16:07:00 INFO - "revision": "c1d6cd4595a03608cf23c1a6c136ea862dc37fc9", 16:07:00 INFO - "stage_platform": "linux64", 16:07:00 INFO - "builduid": "1ca4746b148a4a368a4dfbb43ea5f313", 16:07:00 INFO - "slavebuilddir": "test" 16:07:00 INFO - } 16:07:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:07:00 INFO - Running post-action listener: _resource_record_post_action 16:07:00 INFO - ##### 16:07:00 INFO - ##### Running download-and-extract step. 16:07:00 INFO - ##### 16:07:00 INFO - Running pre-action listener: _resource_record_pre_action 16:07:00 INFO - Running main action method: download_and_extract 16:07:00 INFO - mkdir: /builds/slave/test/build/tests 16:07: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')]} 16:07:00 INFO - https://queue.taskcluster.net/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:07:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:07:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:07:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/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 16:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/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 16:07:01 INFO - Downloaded 1361 bytes. 16:07:01 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:07:01 INFO - Using the following test package requirements: 16:07:01 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:07:01 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:07:01 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:07:01 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:01 INFO - u'jsshell-linux-x86_64.zip'], 16:07:01 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:07:01 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:07:01 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:07:01 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:07:01 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:07:01 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:07:01 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:07:01 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:01 INFO - https://queue.taskcluster.net/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:07:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:07:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:07:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/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 16:07:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/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 16:07:02 INFO - Downloaded 22093284 bytes. 16:07:02 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'] 16:07:02 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 16:07:03 INFO - Return code: 0 16:07:03 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 16:07:03 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')]} 16:07:03 INFO - https://queue.taskcluster.net/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:07:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:07:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:07:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/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 16:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/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 16:07:04 INFO - Downloaded 22093284 bytes. 16:07:04 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'] 16:07:04 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 16:07:05 INFO - Return code: 0 16:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:05 INFO - https://queue.taskcluster.net/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:07:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:07:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:07:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/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 16:07:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/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 16:07:06 INFO - Downloaded 10845161 bytes. 16:07:06 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'] 16:07:06 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 16:07:06 INFO - Return code: 0 16:07:06 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')]} 16:07:06 INFO - https://queue.taskcluster.net/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:07:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:07:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:07:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/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 16:07:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JjyZiweBQceWDS4rn4y4cg/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 16:07:08 INFO - Downloaded 54429954 bytes. 16:07:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:07:08 INFO - mkdir: /builds/slave/test/properties 16:07:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:07:08 INFO - Writing to file /builds/slave/test/properties/build_url 16:07:08 INFO - Contents: 16:07:08 INFO - build_url:https://queue.taskcluster.net/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:07:09 INFO - Running post-action listener: _resource_record_post_action 16:07:09 INFO - Running post-action listener: set_extra_try_arguments 16:07:09 INFO - ##### 16:07:09 INFO - ##### Running populate-webroot step. 16:07:09 INFO - ##### 16:07:09 INFO - Running pre-action listener: _resource_record_pre_action 16:07:09 INFO - Running main action method: populate_webroot 16:07:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:07:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:07:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:07:09 INFO - '--tppagecycles', 16:07:09 INFO - '7'], 16:07:09 INFO - 'tests': ['tsvgm']}}, 16:07:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:07:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:07:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:07:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:07:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:07:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:07:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:07:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:09 INFO - 'talos_options': ['--e10s'], 16:07:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:07:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:09 INFO - 'tests': ['damp', 'tps']}, 16:07:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:09 INFO - 'talos_options': ['--e10s'], 16:07:09 INFO - 'tests': ['damp', 'tps']}, 16:07:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:07:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:07:09 INFO - 'other': {'tests': ['a11yr', 16:07:09 INFO - 'ts_paint', 16:07:09 INFO - 'tpaint', 16:07:09 INFO - 'sessionrestore', 16:07:09 INFO - 'sessionrestore_no_auto_restore', 16:07:09 INFO - 'tabpaint']}, 16:07:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:07:09 INFO - 'tests': ['a11yr', 16:07:09 INFO - 'ts_paint', 16:07:09 INFO - 'tpaint', 16:07:09 INFO - 'sessionrestore', 16:07:09 INFO - 'sessionrestore_no_auto_restore', 16:07:09 INFO - 'tabpaint']}, 16:07:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:07:09 INFO - 'tests': ['a11yr', 16:07:09 INFO - 'ts_paint', 16:07:09 INFO - 'tpaint', 16:07:09 INFO - 'sessionrestore', 16:07:09 INFO - 'sessionrestore_no_auto_restore', 16:07:09 INFO - 'tabpaint']}, 16:07:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:07:09 INFO - 'tests': ['a11yr', 16:07:09 INFO - 'ts_paint', 16:07:09 INFO - 'tpaint', 16:07:09 INFO - 'sessionrestore', 16:07:09 INFO - 'sessionrestore_no_auto_restore', 16:07:09 INFO - 'tabpaint']}, 16:07:09 INFO - 'other_l64': {'tests': ['a11yr', 16:07:09 INFO - 'ts_paint', 16:07:09 INFO - 'tpaint', 16:07:09 INFO - 'sessionrestore', 16:07:09 INFO - 'sessionrestore_no_auto_restore', 16:07:09 INFO - 'tabpaint']}, 16:07:09 INFO - 'other_nol64': {'tests': ['a11yr', 16:07:09 INFO - 'ts_paint', 16:07:09 INFO - 'tpaint', 16:07:09 INFO - 'sessionrestore', 16:07:09 INFO - 'sessionrestore_no_auto_restore', 16:07:09 INFO - 'tabpaint']}, 16:07:09 INFO - 'svgr': {'tests': ['tsvgx', 16:07:09 INFO - 'tsvgr_opacity', 16:07:09 INFO - 'tart', 16:07:09 INFO - 'tscrollx', 16:07:09 INFO - 'cart']}, 16:07:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:07:09 INFO - 'tests': ['tsvgx', 16:07:09 INFO - 'tsvgr_opacity', 16:07:09 INFO - 'tart', 16:07:09 INFO - 'tscrollx', 16:07:09 INFO - 'cart']}, 16:07:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:09 INFO - 'tests': ['tp5o']}, 16:07:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:09 INFO - 'talos_options': ['--e10s'], 16:07:09 INFO - 'tests': ['tp5o']}, 16:07:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:09 INFO - 'talos_options': ['--xperf_path', 16:07:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:07:09 INFO - 'tests': ['tp5n']}, 16:07:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:09 INFO - 'talos_options': ['--e10s', 16:07:09 INFO - '--xperf_path', 16:07:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:07:09 INFO - 'tests': ['tp5n']}}, 16:07:09 INFO - 'talos.zip': {'path': '', 16:07:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:07:09 INFO - Running post-action listener: _resource_record_post_action 16:07:09 INFO - ##### 16:07:09 INFO - ##### Running create-virtualenv step. 16:07:09 INFO - ##### 16:07:09 INFO - Running pre-action listener: _resource_record_pre_action 16:07:09 INFO - Running main action method: create_virtualenv 16:07:09 INFO - Creating virtualenv /builds/slave/test/build/venv 16:07:09 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 16:07:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:07:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:07:09 INFO - Using real prefix '/usr' 16:07:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:07:09 INFO - Installing distribute.............................................................................................................................................................................................done. 16:07:11 INFO - Installing pip.................done. 16:07:11 INFO - Return code: 0 16:07:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:11 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 0x7f1a157b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1364160>, '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 0x1365060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13654f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', '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 16:07:11 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 16:07:11 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 16:07:11 INFO - Using env: {'DISPLAY': ':0', 16:07:11 INFO - 'HOME': '/home/cltbld', 16:07:11 INFO - 'LANG': 'en_US.UTF-8', 16:07:11 INFO - 'LANGUAGE': 'en_US:en', 16:07:11 INFO - 'LOGNAME': 'cltbld', 16:07:11 INFO - 'MAIL': '/var/mail/cltbld', 16:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:11 INFO - 'MOZ_NO_REMOTE': '1', 16:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:11 INFO - 'NO_EM_RESTART': '1', 16:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:11 INFO - 'PWD': '/builds/slave/test', 16:07:11 INFO - 'SHELL': '/bin/bash', 16:07:11 INFO - 'SHLVL': '1', 16:07:11 INFO - 'TERM': 'linux', 16:07:11 INFO - 'TMOUT': '86400', 16:07:11 INFO - 'USER': 'cltbld', 16:07:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', 16:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:11 INFO - '_': '/tools/buildbot/bin/python'} 16:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:12 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 16:07:12 INFO - Cleaning up... 16:07:12 INFO - Return code: 0 16:07:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:12 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 0x7f1a157b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1364160>, '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 0x1365060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13654f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', '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 16:07:12 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 16:07:12 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 16:07:12 INFO - Using env: {'DISPLAY': ':0', 16:07:12 INFO - 'HOME': '/home/cltbld', 16:07:12 INFO - 'LANG': 'en_US.UTF-8', 16:07:12 INFO - 'LANGUAGE': 'en_US:en', 16:07:12 INFO - 'LOGNAME': 'cltbld', 16:07:12 INFO - 'MAIL': '/var/mail/cltbld', 16:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:12 INFO - 'MOZ_NO_REMOTE': '1', 16:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:12 INFO - 'NO_EM_RESTART': '1', 16:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:12 INFO - 'PWD': '/builds/slave/test', 16:07:12 INFO - 'SHELL': '/bin/bash', 16:07:12 INFO - 'SHLVL': '1', 16:07:12 INFO - 'TERM': 'linux', 16:07:12 INFO - 'TMOUT': '86400', 16:07:12 INFO - 'USER': 'cltbld', 16:07:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', 16:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:12 INFO - '_': '/tools/buildbot/bin/python'} 16:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:12 INFO - Downloading/unpacking psutil>=0.7.1 16:07:12 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 16:07:12 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 16:07:12 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 16:07:12 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 16:07:12 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 16:07:12 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 16:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:07:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:07:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:07:14 INFO - Installing collected packages: psutil 16:07:14 INFO - Running setup.py install for psutil 16:07:14 INFO - building 'psutil._psutil_linux' extension 16:07:14 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 16:07:14 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 16:07:14 INFO - building 'psutil._psutil_posix' extension 16:07:14 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 16:07:14 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 16:07:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:07:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:07:14 INFO - Successfully installed psutil 16:07:14 INFO - Cleaning up... 16:07:14 INFO - Return code: 0 16:07:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:07:14 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')]} 16:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:14 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')]} 16:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:14 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 0x7f1a157b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1364160>, '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 0x1365060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13654f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', '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 16:07:14 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 16:07:14 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 16:07:14 INFO - Using env: {'DISPLAY': ':0', 16:07:14 INFO - 'HOME': '/home/cltbld', 16:07:14 INFO - 'LANG': 'en_US.UTF-8', 16:07:14 INFO - 'LANGUAGE': 'en_US:en', 16:07:14 INFO - 'LOGNAME': 'cltbld', 16:07:14 INFO - 'MAIL': '/var/mail/cltbld', 16:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:14 INFO - 'MOZ_NO_REMOTE': '1', 16:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:14 INFO - 'NO_EM_RESTART': '1', 16:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:14 INFO - 'PWD': '/builds/slave/test', 16:07:14 INFO - 'SHELL': '/bin/bash', 16:07:14 INFO - 'SHLVL': '1', 16:07:14 INFO - 'TERM': 'linux', 16:07:14 INFO - 'TMOUT': '86400', 16:07:14 INFO - 'USER': 'cltbld', 16:07:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', 16:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:14 INFO - '_': '/tools/buildbot/bin/python'} 16:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:07:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:07:16 INFO - Installing collected packages: mozsystemmonitor 16:07:16 INFO - Running setup.py install for mozsystemmonitor 16:07:17 INFO - Successfully installed mozsystemmonitor 16:07:17 INFO - Cleaning up... 16:07:17 INFO - Return code: 0 16:07:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1a157b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1364160>, '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 0x1365060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13654f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', '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 16:07:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:07:17 INFO - Using env: {'DISPLAY': ':0', 16:07:17 INFO - 'HOME': '/home/cltbld', 16:07:17 INFO - 'LANG': 'en_US.UTF-8', 16:07:17 INFO - 'LANGUAGE': 'en_US:en', 16:07:17 INFO - 'LOGNAME': 'cltbld', 16:07:17 INFO - 'MAIL': '/var/mail/cltbld', 16:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:17 INFO - 'MOZ_NO_REMOTE': '1', 16:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:17 INFO - 'NO_EM_RESTART': '1', 16:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:17 INFO - 'PWD': '/builds/slave/test', 16:07:17 INFO - 'SHELL': '/bin/bash', 16:07:17 INFO - 'SHLVL': '1', 16:07:17 INFO - 'TERM': 'linux', 16:07:17 INFO - 'TMOUT': '86400', 16:07:17 INFO - 'USER': 'cltbld', 16:07:17 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', 16:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:17 INFO - '_': '/tools/buildbot/bin/python'} 16:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:17 INFO - Downloading/unpacking blobuploader==1.2.4 16:07:17 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 16:07:17 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 16:07:17 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 16:07:17 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 16:07:17 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 16:07:17 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 16:07:19 INFO - Downloading blobuploader-1.2.4.tar.gz 16:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:07:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:07:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:19 INFO - Downloading docopt-0.6.1.tar.gz 16:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:07:19 INFO - Installing collected packages: blobuploader, requests, docopt 16:07:19 INFO - Running setup.py install for blobuploader 16:07:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:07:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:07:19 INFO - Running setup.py install for requests 16:07:20 INFO - Running setup.py install for docopt 16:07:20 INFO - Successfully installed blobuploader requests docopt 16:07:20 INFO - Cleaning up... 16:07:20 INFO - Return code: 0 16:07:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07: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')]} 16:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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')]} 16:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:20 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 0x7f1a157b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1364160>, '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 0x1365060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13654f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', '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 16:07:20 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 16:07:20 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 16:07:20 INFO - Using env: {'DISPLAY': ':0', 16:07:20 INFO - 'HOME': '/home/cltbld', 16:07:20 INFO - 'LANG': 'en_US.UTF-8', 16:07:20 INFO - 'LANGUAGE': 'en_US:en', 16:07:20 INFO - 'LOGNAME': 'cltbld', 16:07:20 INFO - 'MAIL': '/var/mail/cltbld', 16:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:20 INFO - 'MOZ_NO_REMOTE': '1', 16:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:20 INFO - 'NO_EM_RESTART': '1', 16:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:20 INFO - 'PWD': '/builds/slave/test', 16:07:20 INFO - 'SHELL': '/bin/bash', 16:07:20 INFO - 'SHLVL': '1', 16:07:20 INFO - 'TERM': 'linux', 16:07:20 INFO - 'TMOUT': '86400', 16:07:20 INFO - 'USER': 'cltbld', 16:07:20 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', 16:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:20 INFO - '_': '/tools/buildbot/bin/python'} 16:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:07:20 INFO - Running setup.py (path:/tmp/pip-HVGOpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:07:20 INFO - Running setup.py (path:/tmp/pip-yLkKJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:07:20 INFO - Running setup.py (path:/tmp/pip-95Lm8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:07:20 INFO - Running setup.py (path:/tmp/pip-KJUDJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:07:20 INFO - Running setup.py (path:/tmp/pip-HhGcd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:07:21 INFO - Running setup.py (path:/tmp/pip-nXhsST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:07:21 INFO - Running setup.py (path:/tmp/pip-APhrMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:07:21 INFO - Running setup.py (path:/tmp/pip-xl1HH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:07:21 INFO - Running setup.py (path:/tmp/pip-bD1bH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:07:21 INFO - Running setup.py (path:/tmp/pip-EDg1N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:07:21 INFO - Running setup.py (path:/tmp/pip-jLMsai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:07:21 INFO - Running setup.py (path:/tmp/pip-HUvoCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:07:21 INFO - Running setup.py (path:/tmp/pip-a3CchD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:07:21 INFO - Running setup.py (path:/tmp/pip-fMg82F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:21 INFO - Running setup.py (path:/tmp/pip-3u9G4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:07:21 INFO - Running setup.py (path:/tmp/pip-M8XxyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:07:21 INFO - Running setup.py (path:/tmp/pip-LUOuPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:07:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:07:21 INFO - Running setup.py install for manifestparser 16:07:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:07:21 INFO - Running setup.py install for mozcrash 16:07:22 INFO - Running setup.py install for mozdebug 16:07:22 INFO - Running setup.py install for mozdevice 16:07:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:07:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:07:22 INFO - Running setup.py install for mozfile 16:07:22 INFO - Running setup.py install for mozhttpd 16:07:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:07:22 INFO - Running setup.py install for mozinfo 16:07:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:07:22 INFO - Running setup.py install for mozInstall 16:07:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:07:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:07:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:07:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:07:22 INFO - Running setup.py install for mozleak 16:07:22 INFO - Running setup.py install for mozlog 16:07:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:07:22 INFO - Running setup.py install for moznetwork 16:07:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:07:23 INFO - Running setup.py install for mozprocess 16:07:23 INFO - Running setup.py install for mozprofile 16:07:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:07:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:07:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:07:23 INFO - Running setup.py install for mozrunner 16:07:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:07:23 INFO - Running setup.py install for mozscreenshot 16:07:23 INFO - Running setup.py install for moztest 16:07:23 INFO - Running setup.py install for mozversion 16:07:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:07:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:07:23 INFO - Cleaning up... 16:07:23 INFO - Return code: 0 16:07:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07:23 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')]} 16:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:23 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')]} 16:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:23 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 0x7f1a157b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1364160>, '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 0x1365060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13654f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', '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 16:07:23 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 16:07:23 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 16:07:23 INFO - Using env: {'DISPLAY': ':0', 16:07:23 INFO - 'HOME': '/home/cltbld', 16:07:23 INFO - 'LANG': 'en_US.UTF-8', 16:07:23 INFO - 'LANGUAGE': 'en_US:en', 16:07:23 INFO - 'LOGNAME': 'cltbld', 16:07:23 INFO - 'MAIL': '/var/mail/cltbld', 16:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:23 INFO - 'MOZ_NO_REMOTE': '1', 16:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:23 INFO - 'NO_EM_RESTART': '1', 16:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:23 INFO - 'PWD': '/builds/slave/test', 16:07:23 INFO - 'SHELL': '/bin/bash', 16:07:23 INFO - 'SHLVL': '1', 16:07:23 INFO - 'TERM': 'linux', 16:07:23 INFO - 'TMOUT': '86400', 16:07:23 INFO - 'USER': 'cltbld', 16:07:23 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', 16:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:23 INFO - '_': '/tools/buildbot/bin/python'} 16:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:07:23 INFO - Running setup.py (path:/tmp/pip-SclWad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:07:23 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)) 16:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:07:23 INFO - Running setup.py (path:/tmp/pip-OjuVia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:07:24 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)) 16:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:07:24 INFO - Running setup.py (path:/tmp/pip-P8E5mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:07:24 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)) 16:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:07:24 INFO - Running setup.py (path:/tmp/pip-3CpqBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:07:24 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)) 16:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:07:24 INFO - Running setup.py (path:/tmp/pip-4lq_S5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:07:24 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)) 16:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:07:24 INFO - Running setup.py (path:/tmp/pip-8oG5LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:07:24 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)) 16:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:07:24 INFO - Running setup.py (path:/tmp/pip-v0dUbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:07:24 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)) 16:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:07:24 INFO - Running setup.py (path:/tmp/pip-J8KuVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:07:24 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)) 16:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:07:24 INFO - Running setup.py (path:/tmp/pip-lz5HdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:07:24 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)) 16:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:07:24 INFO - Running setup.py (path:/tmp/pip-GaccTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:07:24 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)) 16:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:07:24 INFO - Running setup.py (path:/tmp/pip-FeN5nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:07:24 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)) 16:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:07:24 INFO - Running setup.py (path:/tmp/pip-FZ2NsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:07:24 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)) 16:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:07:24 INFO - Running setup.py (path:/tmp/pip-4acaE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:07:24 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)) 16:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:07:24 INFO - Running setup.py (path:/tmp/pip-R08Pka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:07:24 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)) 16:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:24 INFO - Running setup.py (path:/tmp/pip-_ljqUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:24 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)) 16:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:07:24 INFO - Running setup.py (path:/tmp/pip-EDahfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:07:25 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)) 16:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:07:25 INFO - Running setup.py (path:/tmp/pip-GUuo15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:07:25 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)) 16:07:25 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)) 16:07:25 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)) 16:07:25 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)) 16:07:25 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)) 16:07:25 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)) 16:07:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:07:25 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 16:07:25 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 16:07:25 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 16:07:25 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 16:07:25 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 16:07:25 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 16:07:26 INFO - Downloading blessings-1.6.tar.gz 16:07:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:07:26 INFO - Installing collected packages: blessings 16:07:26 INFO - Running setup.py install for blessings 16:07:27 INFO - Successfully installed blessings 16:07:27 INFO - Cleaning up... 16:07:27 INFO - Return code: 0 16:07:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:07:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:07:27 INFO - Reading from file tmpfile_stdout 16:07:27 INFO - Current package versions: 16:07:27 INFO - argparse == 1.2.1 16:07:27 INFO - blessings == 1.6 16:07:27 INFO - blobuploader == 1.2.4 16:07:27 INFO - docopt == 0.6.1 16:07:27 INFO - manifestparser == 1.1 16:07:27 INFO - mozInstall == 1.12 16:07:27 INFO - mozcrash == 0.17 16:07:27 INFO - mozdebug == 0.1 16:07:27 INFO - mozdevice == 0.48 16:07:27 INFO - mozfile == 1.2 16:07:27 INFO - mozhttpd == 0.7 16:07:27 INFO - mozinfo == 0.9 16:07:27 INFO - mozleak == 0.1 16:07:27 INFO - mozlog == 3.1 16:07:27 INFO - moznetwork == 0.27 16:07:27 INFO - mozprocess == 0.22 16:07:27 INFO - mozprofile == 0.28 16:07:27 INFO - mozrunner == 6.11 16:07:27 INFO - mozscreenshot == 0.1 16:07:27 INFO - mozsystemmonitor == 0.0 16:07:27 INFO - moztest == 0.7 16:07:27 INFO - mozversion == 1.4 16:07:27 INFO - psutil == 3.1.1 16:07:27 INFO - requests == 1.2.3 16:07:27 INFO - wsgiref == 0.1.2 16:07:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:27 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 0x7f1a157b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1364160>, '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 0x1365060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13654f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', '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 16:07:27 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 16:07:27 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 16:07:27 INFO - Using env: {'DISPLAY': ':0', 16:07:27 INFO - 'HOME': '/home/cltbld', 16:07:27 INFO - 'LANG': 'en_US.UTF-8', 16:07:27 INFO - 'LANGUAGE': 'en_US:en', 16:07:27 INFO - 'LOGNAME': 'cltbld', 16:07:27 INFO - 'MAIL': '/var/mail/cltbld', 16:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:27 INFO - 'MOZ_NO_REMOTE': '1', 16:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:27 INFO - 'NO_EM_RESTART': '1', 16:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:27 INFO - 'PWD': '/builds/slave/test', 16:07:27 INFO - 'SHELL': '/bin/bash', 16:07:27 INFO - 'SHLVL': '1', 16:07:27 INFO - 'TERM': 'linux', 16:07:27 INFO - 'TMOUT': '86400', 16:07:27 INFO - 'USER': 'cltbld', 16:07:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', 16:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:27 INFO - '_': '/tools/buildbot/bin/python'} 16:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:27 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)) 16:07:27 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)) 16:07:27 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)) 16:07:27 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)) 16:07:27 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)) 16:07:27 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)) 16:07:27 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)) 16:07:27 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)) 16:07:27 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)) 16:07:27 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)) 16:07:27 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)) 16:07:27 INFO - Cleaning up... 16:07:27 INFO - Return code: 0 16:07:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a157b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1364160>, '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 0x1365060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13654f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', '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 16:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:07:27 INFO - Using env: {'DISPLAY': ':0', 16:07:27 INFO - 'HOME': '/home/cltbld', 16:07:27 INFO - 'LANG': 'en_US.UTF-8', 16:07:27 INFO - 'LANGUAGE': 'en_US:en', 16:07:27 INFO - 'LOGNAME': 'cltbld', 16:07:27 INFO - 'MAIL': '/var/mail/cltbld', 16:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:27 INFO - 'MOZ_NO_REMOTE': '1', 16:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:27 INFO - 'NO_EM_RESTART': '1', 16:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:27 INFO - 'PWD': '/builds/slave/test', 16:07:27 INFO - 'SHELL': '/bin/bash', 16:07:27 INFO - 'SHLVL': '1', 16:07:27 INFO - 'TERM': 'linux', 16:07:27 INFO - 'TMOUT': '86400', 16:07:27 INFO - 'USER': 'cltbld', 16:07:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', 16:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:27 INFO - '_': '/tools/buildbot/bin/python'} 16:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:27 INFO - Downloading/unpacking jsonschema 16:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:07:29 INFO - Downloading/unpacking functools32 (from jsonschema) 16:07:29 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 16:07:29 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 16:07:29 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 16:07:29 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 16:07:29 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 16:07:29 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 16:07:29 INFO - Downloading functools32-3.2.3-2.tar.gz 16:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:07:29 INFO - warning: no files found matching '*.txt' 16:07:29 INFO - no previously-included directories found matching 'build' 16:07:29 INFO - no previously-included directories found matching 'dist' 16:07:29 INFO - no previously-included directories found matching '.git*' 16:07:29 INFO - Installing collected packages: jsonschema, functools32 16:07:29 INFO - Running setup.py install for functools32 16:07:29 INFO - warning: no files found matching '*.txt' 16:07:29 INFO - no previously-included directories found matching 'build' 16:07:29 INFO - no previously-included directories found matching 'dist' 16:07:29 INFO - no previously-included directories found matching '.git*' 16:07:30 INFO - Successfully installed jsonschema functools32 16:07:30 INFO - Cleaning up... 16:07:30 INFO - Return code: 0 16:07:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a157b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d5410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1364160>, '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 0x1365060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13654f0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', '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 16:07:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:07:30 INFO - Using env: {'DISPLAY': ':0', 16:07:30 INFO - 'HOME': '/home/cltbld', 16:07:30 INFO - 'LANG': 'en_US.UTF-8', 16:07:30 INFO - 'LANGUAGE': 'en_US:en', 16:07:30 INFO - 'LOGNAME': 'cltbld', 16:07:30 INFO - 'MAIL': '/var/mail/cltbld', 16:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:30 INFO - 'MOZ_NO_REMOTE': '1', 16:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:30 INFO - 'NO_EM_RESTART': '1', 16:07:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:30 INFO - 'PWD': '/builds/slave/test', 16:07:30 INFO - 'SHELL': '/bin/bash', 16:07:30 INFO - 'SHLVL': '1', 16:07:30 INFO - 'TERM': 'linux', 16:07:30 INFO - 'TMOUT': '86400', 16:07:30 INFO - 'USER': 'cltbld', 16:07:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', 16:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:30 INFO - '_': '/tools/buildbot/bin/python'} 16:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:30 INFO - Downloading/unpacking flake8 16:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:07:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:07:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:07:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:07:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:07:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:07:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:07:32 INFO - no previously-included directories found matching 'docs/_build' 16:07:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:07:32 INFO - Running setup.py install for pep8 16:07:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:07:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:07:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:07:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:07:32 INFO - no previously-included directories found matching 'docs/_build' 16:07:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:07:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:07:32 INFO - Cleaning up... 16:07:33 INFO - Return code: 0 16:07:33 INFO - Running post-action listener: _resource_record_post_action 16:07:33 INFO - Running post-action listener: _start_resource_monitoring 16:07:33 INFO - Starting resource monitoring. 16:07:33 INFO - ##### 16:07:33 INFO - ##### Running install step. 16:07:33 INFO - ##### 16:07:33 INFO - Running pre-action listener: _resource_record_pre_action 16:07:33 INFO - Running main action method: install 16:07:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:07:33 INFO - Reading from file tmpfile_stdout 16:07:33 INFO - Detecting whether we're running mozinstall >=1.0... 16:07:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:07:33 INFO - Reading from file tmpfile_stdout 16:07:33 INFO - Output received: 16:07:33 INFO - Usage: mozinstall [options] installer 16:07:33 INFO - Options: 16:07:33 INFO - -h, --help show this help message and exit 16:07:33 INFO - -d DEST, --destination=DEST 16:07:33 INFO - Directory to install application into. [default: 16:07:33 INFO - "/builds/slave/test"] 16:07:33 INFO - --app=APP Application being installed. [default: firefox] 16:07:33 INFO - mkdir: /builds/slave/test/build/application 16:07:33 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'] 16:07:33 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 16:07:49 INFO - Reading from file tmpfile_stdout 16:07:49 INFO - Output received: 16:07:49 INFO - /builds/slave/test/build/application/firefox/firefox 16:07:49 INFO - Running post-action listener: _resource_record_post_action 16:07:49 INFO - ##### 16:07:49 INFO - ##### Running run-tests step. 16:07:49 INFO - ##### 16:07:49 INFO - Running pre-action listener: _resource_record_pre_action 16:07:49 INFO - Running main action method: run_tests 16:07:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:07:49 INFO - Python 2.7.3 16:07:49 INFO - Return code: 0 16:07:49 INFO - grabbing minidump binary from tooltool 16:07: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')]} 16:07:49 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 0x1364160>, '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 0x1365060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13654f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:07:49 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 16:07:49 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 16:07:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:07:50 INFO - Return code: 0 16:07:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:07:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:07:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:07:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:07:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:07:51 INFO - Return code: 0 16:07:51 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:07:51 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:07:51 INFO - Using env: {'DISPLAY': ':0', 16:07:51 INFO - 'HOME': '/home/cltbld', 16:07:51 INFO - 'LANG': 'en_US.UTF-8', 16:07:51 INFO - 'LANGUAGE': 'en_US:en', 16:07:51 INFO - 'LOGNAME': 'cltbld', 16:07:51 INFO - 'MAIL': '/var/mail/cltbld', 16:07:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:07:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:51 INFO - 'MOZ_NO_REMOTE': '1', 16:07:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:51 INFO - 'NO_EM_RESTART': '1', 16:07:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:51 INFO - 'PWD': '/builds/slave/test', 16:07:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:07:51 INFO - 'SHELL': '/bin/bash', 16:07:51 INFO - 'SHLVL': '1', 16:07:51 INFO - 'TERM': 'linux', 16:07:51 INFO - 'TMOUT': '86400', 16:07:51 INFO - 'USER': 'cltbld', 16:07:51 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441', 16:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:51 INFO - '_': '/tools/buildbot/bin/python'} 16:07:51 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:07:51 INFO - mozversion application_buildid: 20160310150717 16:07:51 INFO - mozversion application_changeset: c1d6cd4595a03608cf23c1a6c136ea862dc37fc9 16:07:51 INFO - mozversion application_display_name: Nightly 16:07:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:07:51 INFO - mozversion application_name: Firefox 16:07:51 INFO - mozversion application_remotingname: firefox 16:07:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:07:51 INFO - mozversion application_vendor: Mozilla 16:07:51 INFO - mozversion application_version: 48.0a1 16:07:51 INFO - mozversion platform_buildid: 20160310150717 16:07:51 INFO - mozversion platform_changeset: c1d6cd4595a03608cf23c1a6c136ea862dc37fc9 16:07:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:07:51 INFO - mozversion platform_version: 48.0a1 16:07:51 INFO - using testdate: 1457654871 16:07:51 INFO - actual date: 1457654871 16:07:51 INFO - starting webserver on 'localhost:50245' 16:07:51 INFO - SUITE-START | Running 2 tests 16:07:51 INFO - TEST-START | dromaeo_css 16:07:51 INFO - operating with platform_type : linux_ 16:07:51 INFO - Initialising browser for dromaeo_css test... 16:07:51 INFO - TEST-INFO | started process 3448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKnIeeS/profile http://localhost:50245/getInfo.html) 16:07:57 INFO - PROCESS | 3448 | __metrics Screen width/height:1600/1200 16:07:57 INFO - PROCESS | 3448 | colorDepth:24 16:07:57 INFO - PROCESS | 3448 | Browser inner width/height: 1024/697 16:07:57 INFO - PROCESS | 3448 | __metrics 16:07:59 ERROR - PROCESS | 3448 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:08:00 INFO - TEST-INFO | 3448: exit 0 16:08:00 INFO - Browser initialized. 16:08:00 INFO - Running cycle 1/1 for dromaeo_css test... 16:08:00 INFO - TEST-INFO | started process 3541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKnIeeS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:12 INFO - PROCESS | 3541 | RSS: Main: 154193920 16:08:12 INFO - PROCESS | 3541 | 16:09:03 INFO - PROCESS | 3541 | 1457654943667 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] 16:11:15 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:50245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50245/tests/dromaeo/cssquery-ext.html) 16:11:16 INFO - PROCESS | 3541 | RSS: Main: 240799744 16:11:16 INFO - PROCESS | 3541 | 16:14:18 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:50245/tests/dromaeo/cssquery-ext.html (next: http://localhost:50245/tests/dromaeo/cssquery-jquery.html) 16:14:19 INFO - PROCESS | 3541 | RSS: Main: 232177664 16:14:19 INFO - PROCESS | 3541 | 16:17:21 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:50245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50245/tests/dromaeo/cssquery-mootools.html) 16:17:22 INFO - PROCESS | 3541 | RSS: Main: 229797888 16:17:22 INFO - PROCESS | 3541 | 16:20:24 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:50245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50245/tests/dromaeo/cssquery-prototype.html) 16:20:24 INFO - PROCESS | 3541 | RSS: Main: 216981504 16:20:24 INFO - PROCESS | 3541 | 16:23:27 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:50245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50245/tests/dromaeo/cssquery-yui.html) 16:23:28 INFO - PROCESS | 3541 | RSS: Main: 188186624 16:23:28 INFO - PROCESS | 3541 | 16:26:30 INFO - PROCESS | 3541 | Cycle 1(1): loaded http://localhost:50245/tests/dromaeo/cssquery-yui.html (next: http://localhost:50245/tests/dromaeo/cssquery-dojo.html) 16:26:30 INFO - PROCESS | 3541 | RSS: Main: 267476992 16:26:30 INFO - PROCESS | 3541 | 16:26:30 INFO - PROCESS | 3541 | __start_tp_report 16:26:30 INFO - PROCESS | 3541 | _x_x_mozilla_page_load 16:26:30 INFO - PROCESS | 3541 | _x_x_mozilla_page_load_details 16:26:30 INFO - PROCESS | 3541 | |i|pagename|runs| 16:26:30 INFO - PROCESS | 3541 | |0;dojo.html;2564.358910272432;2618.1883616079017;2623.6720409948757;2645.775109115725;2660.9866950665246;4415.712978656393;4429.490608580014;4449.510553839079;4463.397441345422;4529.682922195448;4470.552944705528;4497.1455423469515;4510.097980403924;4523.163214805263;4557.954420455802;4114.321137012389;4160.646345060673;4210.852620158295;4241.575842415749;4253.872383828475;4083.693722970774;4163.3130533461945;4214.283571792787;4215.620594146526;4226.513950895655;4117.1765646870745;4178.310578754502;4187.790610469464;4233.428487154257;4233.999999999969;4151.6886233532605;4156.397322388267;4169.082801783633;4175.853845115406;4185.4977402711565;4041.717079804415;4136.358864376027;4138.586141385867;4148.23257697327;4180.163967206571;4379.693421460499;4412.3160910059;4438.911221775578;4476.485204201526;4476.664250181217;4750.619950403994;4752.42970843501;4752.727055971698;4757.405324334458;4770.594499467549;4652.651051171142;4774.045190961821;4792.592629626486;4798.688085274446;4827.975860120712;4397.714148580396;4416.094700586372;4459.643228541741;4480.932786008212;4486.865394038184;4863.051704917507;4863.124637565272;4868.537488938545;4883.291922671193;4901.950980490221;4565;4664.067186562633;4680.672352935262;4707.693999889996;4709.976450117796;4825.059113472909;4842.539958703917;4845.1520983828395;4852.8301509447;4886.65793394459;4775.594074503706;4783.95216047842;4786.1863483207935;4789.30555069513;4818.132736107465;4629.583337499574;4677.041206552649;4763.904721905543;4773.427188737304;4817.421909370898;4037.192561487714;4054.493188351456;4059.0258337998666;4076;4091.263572556909;3574.767640103385;3575.588807287143;3577.9105522362147;3603.747737658391;3610.422332426799;4103.466549348565;4143.56492568276;4193.014641559231;4230.894227644333;4238.491381034296;4808.230683090689;4808.591269742041;4812.831550895772;4817.542333478314;4870.756462176877;4137.110521237948;4159.376093585986;4163.02168990287;4171.97914010428;4201.243776120327;4148.377743338463;4274.187904298174;4296.828126874952;4342.174986752507;4352.9129417412105;4515.616172625364;4518.186726389282;4520.819167233274;4573.131105090022;4573.153966516072;4830.106430310404;4832.565069143794;4833.2025215840395;4840.370751802243;4874.025194960951;4464.17412778637;4493;4542.977285113686;4543.318502224693;4582.404287442611;4778.904421911612;4806.375171227858;4809.639277054305;4811.254255590389;4836.177849765478;4680.578747912704;4845.6608037438455;4860.3195552623365;4869.732164730974;4902.338184345211;4635.281531362644;4688.671792974459;4689.062187562569;4703.129920964632;4743.715377077387;4575.062112267044;4615.930761038654;4616.307553866947;4619.260918253063;4660.883477913079;4436.356728274318;4533.478649955166;4540.409746732904;4545.749983750926;4581.198290299118;4673.112108699336;4673.789679464364;4681.250999840009;4687.226607609706;4723.905521889612;4517.344984977226;4522.751248681354;4523.23105072132;4544.159330523864;4575.062112267044 16:26:30 INFO - PROCESS | 3541 | |1;ext.html;491.6484713429899;515.5282916131738;541.9432107390589;550.246162757023;554.794725951398;24161.275161745154;32694.83652581737;32993.50509742356;33006.50490242642;33135.33729325412;37205.44191837118;37552.43671344925;37572.248555028884;37770.24459510808;37781.24437511255;6770.932290677079;7584.810379740509;7791.181925897784;9339.579718912632;9506.334556581041;9524.571394287274;9659.855102173473;9665.806683866318;9673.129418352348;9676.903230967706;9385.906140938605;9424.057594240556;9443;9446.338756287063;9464.526773661324;9660.516974151335;9667.323287369887;9726.2705297103;9742.22062235023;9750.171235444996;9537.856932146024;9710.223182145412;9717.90282097177;10007.149392301662;10088.747781305452;37409.812950935346;37908.43137352942;37915.62084379176;37944.62055379438;38046.42930356047;2802.285417218596;2885.350796070867;2917.868695908689;2965.7627389808763;3011.48804703201;27976.021971582035;28026.159215223575;28172.43655126886;28794.71205287941;28945.276368090756;3456.1705190754287;3503.754737168399;3510.342974836576;3517.736169787276;3535.7171426285836;211522;211639.8942100498;211988;212166;212801;51301.23048154281;51363.48636513662;51590.74204628953;51665;51710.48289517132;56646;56955;59087.704561476916;59940.40059599348;60063.69968150131;10988.340699558052;12393.442295096742;12496.187747796364;12514.749705005848;12516.061295402882;9138.725838224864;9378.249740020781;9387.718368448957;9479.24166066713;9526.047395260557;18298.45104646863;18499.630007400046;18525.44423667292;18528.44414667562;18609.162587683317;7376.815579610553;7681.731139410205;7700.884486732703;7763.262490063435;7777.611119444005;820.4257020085963;844.1769274956868;844.8225872566829;930.8231436027269;999.3254553176577;25653;27747.16758497248;29025.564616530348;29190.854045729637;29345.706542934724;885.7121435533477;910.6539514984264;946.9526523673788;958.9760255993516;1028.7685270814006;12723.491060357483;13154.473821047242;13213.405396756976;14807.259637018105;15621.921890390702;228854;231534;232035;232356;232815;47963.76018119887;48208;48526.514734852906;48566.757166213945;48641.756791216525;1017.7710015246511;1178.640514643042;1188.2157775867886;1307.5946456598294;1341.3628526449859;23030.309090726634;24503.75496245086;26126.34684132912;26617.33456663599;26743.331416714736;34587.827060865544;34786.30427391489;34866.65133348735;34876;34879.82560087183;144074;144596;148343;148355;148594;23109.306720798402;27343.45313093767;27762.72237277682;27884.860575697803;27927.86036069888;32103.197420064684;32320.83839580787;40890.591094088675;41439;41981.79009105057;30874;32878.671213288515;33445.83277083599;33472.330553389285;33534.16164595807;33029.17427064342;33179;33270.50094248637;33427.164320892174;33583.83208083944;33378.49932251067;33593;33596.49605255972;33708.83145584256;34258.828705856315;26162.607560886223;27696.861515692293;29945.70054299429;30060.549091763205;30287.848560757055;23367.065317387794;23570.882145589163;23637.644026910217;23638;23948.281551553482 16:26:30 INFO - PROCESS | 3541 | |2;jquery.html;327.46623004502675;331.96182439019515;332.44315771083427;336.8366342323972;338.828891409838;14591.27043647816;14943.775843362344;15087.92456037721;15417.383304667814;15468.381264749425;13973;13976.510822121229;14240;14552.126872387664;14804.703905921875;4853.44185418677;5014.548690617844;5026.346574945252;5028.2709007193935;5051.873703157432;5004.824831130911;5040.621953353495;5053.949460505403;5240.056789777838;5240.868978275555;5192.299039629658;5195.740212989354;5206.375234971809;5229.790808367661;5232.895342093156;5139.588832893378;5168.9224661630105;5188.610854185951;5192.221166824968;5320.733963301819;5080.847574572768;5081.720505372203;5095.133827249377;5123.87190320245;5127.333446651912;11365.715857103556;11448.885511144865;11655.59205427806;12001.63995080149;12003.459844307026;1667.2497376180645;1674.5646132005766;1921.6060707554918;2404.9519009619708;2436.7075950886006;8589.957050214709;11841.171118021743;12133.696657583543;12377.443015064253;12629.557965471164;1735.297204632126;1740.225599608175;1778.5731424458038;1785.214505617524;1818.0909545227387;53357.733211333696;53619.73190134063;53904.460955390336;56253.43746562564;57098.14352784712;9453.243740500744;9497.715068547956;9511.66709165176;9644.9035509644;10045.899541004643;10626.415547144981;12057.216280941711;12550.686232844251;12806.679833004064;12849.678758031125;6527.640979746065;6655.833604159935;6687.966560167265;6777.8644427111185;6824.41992430639;6668.166479190101;6739.427148692416;6743.123393958754;6827.52207345491;6850.451963842881;3865.8260378283044;3991.1818077294083;4030.5767894371256;4190.161967606491;4267.317229243306;1686.5867862373552;1704.6249825038471;1717.6221231329087;1718.8538974187334;1735.366591194205;804.7103042904549;829.2081062585216;894.458852394305;909.2771246858763;951.4957072751314;14448.783268250985;14480.710385792225;14878.925605371904;15037.924810375878;15130.924345378202;758.4463341760546;769.4267770510893;833.2167762303416;871.4030888841164;887.5650931043871;8677.696280630147;8746.518941458153;8792.78018049541;8833.116688331116;8895.199432051017;346706;347855;352467;354254;354720;65010.67494662497;66138.33861661419;68531;68704.70025218876;68754;829.3531045784177;853.9274161696326;864.8529749942525;866.6013633728429;867.869819527076;10917.617883374043;13865.722685546434;14425.062370945854;14715.411383544539;14768.926155369154;30818.691813081583;31753.68246317507;32364.676353236166;32913.83543082269;33740.15649608681;36990.815045924595;41409.37885931653;43265.567344326155;43655.345169823115;43745.125097497235;6910.412614927586;7220.675069621985;7223.241559636373;7275.454340924558;7321.853562928818;6195.2255968004;7966.924465197124;8947.955260223658;9832.164266037467;10407.074691182155;9381.296402769683;9430.387024843363;9492.905070949202;9510.667126650535;9885.110340069428;9377.484238366682;9540.85688714656;9572.712818615453;9602.66390676351;9622.13400793932;9509.334346595671;9727.173190278623;9760.414375137514;9824.557894894604;10126.088652021353;7166.426685865223;7210.2789721027475;7293.0519032525435;7308.707651693872;7491.138519070377;8555.743327700178;9423.858642120511;9648.324617276723;9653.420794752337;9682.75793105178 16:26:30 INFO - PROCESS | 3541 | |3;mootools.html;1236.8082947143184;1351.2162945491616;1362.8569000254972;1496.6632507685772;1759.0501129390123;6331.5567910246245;7164.355208031277;7271.236520165379;7272.090988626422;7272.563646181233;6995.405390541798;7166.355028047475;7174.21083680796;7188.604626745527;7192.352688258055;1790.7672002639638;2061.628906796776;2102.6425507663694;2125.1393185759716;2130.286354071388;2162.762096169428;2170.924017659382;2171.7936796004356;2174.293354659734;2174.5650869826018;2019.1822311963679;2061.773204947462;2077.968830467544;2078.1064142418754;2079.667253239482;2059.3821853443906;2064.5561204341066;2069.7619773726065;2080.251109600543;2103.5267064910427;2000.0899590686204;2002.3292197113985;2002.7396438463052;2005.31819181479;2009.809068138539;7488.475806693534;7561.621918904033;7562.395008399315;7570.810729731746;7579.431542634325;4288.957110428887;4376.803043863034;4411.6250118739945;4411.933820992687;4415.580519850609;2755.2423083651956;2767.681716602596;2887.364779748452;2908.0548821633056;2914.504534229186;880.515716356008;888.4180861535705;902.0348227396688;943.6131186213688;954.6515521834481;10545;10565.63020294286;10578.312409693346;10580.57677692899;10595.099416549603;3993.2412841560013;4017.4978127734034;4078.2455245779624;4092.1611069730634;4113.095119073799;8665.566721664018;8763.123687631185;8803.779905502413;8818.382713210141;8819.382643214913;3788.109794198361;4258.297380932111;4274.1451709658195;4278.935815962763;4280.59334363235;3830.0999265172663;3906.453096566483;3917.804109794556;3934.016495876031;3945.6251656092627;3341.732661387083;3429.7770644908;3431.1250631088915;3455.87904423344;3477.730628320645;1079.7192729890285;1095.315427857589;1095.6274866545414;1100.6973082402244;1102;851.9787005324916;855.2730179347504;861.1216559109673;861.5261606116611;1131.145984781501;6952.652367381712;6987.510874238857;7005.334493223136;7032.683529241196;7037.683304251321;431.95464476229546;441.6135881104034;452.15221459762944;455.4466323417064;455.4511813265008;5303.363596368384;5307.840764777063;5347.385050719139;5387.595930305243;5395.217693434509;8839.69061082859;9047.864282035775;9283.11810378013;9295.163435290857;9313.674021409219;9011.053839346774;9020.684276050306;9040.276777857756;9072.773180670536;9077.546122693839;6573.868522629617;6753.763618273435;6754.628495432798;7060.082189315356;7140.7857764267155;6987.650617469208;7025.5082144251455;7068.020954132851;7074.257202993817;7111.751088712077;7662.233776622294;7910.7231246906085;8001.079875814123;8031.638576263966;8039.437239393186;7977.5612341321785;8218.547979860927;8226.506409615442;8247.051589067334;8256.711015114442;5440.782368705208;5948.464638182584;6198.101275315144;6312.274088479883;6399.712012959335;7026.894596581157;7040.119985001875;7052.435805135474;7082.468814838805;7102.289771023063;6153.907691384543;6271.905921411091;6300.59046161998;6352.237731472253;6359.554831161774;5706.572007099401;5721.456461636138;5745.454181852718;5755.769769209185;5818.650880947157;6272.372762723691;6332.651704156131;6340.904886426615;6352.269489008639;6355.650439225887;5803.65178089316;5850.795222167204;5863.794767183128;5879.059350503899;5882.49998750111;5724.914126288192;5742.109972954198;5791.015527360443;5825.621334613236;5833.883322333614 16:26:30 INFO - PROCESS | 3541 | |4;prototype.html;298.4538294920296;301.4498540164201;302.31978049388874;305.72179316821695;307.707677706179;5209.374875014999;5228.895422091566;5273.604479664026;5281.683099014062;5330.92003619946;5208.8697782555455;5217.765200565974;5222.973885130569;5230.424653288144;5243.86890327741;3857.3635350167187;3971.305021621219;3985.8007099645047;4062.9796851015703;4065.2885744994583;3963.425303331015;3983.4821473208444;3988.660963818079;4059;4084.387341898724;4026.7986600669997;4053.169100334439;4063.5936406359274;4065.4918135233097;4065.532463766675;4043.818028188724;4048.2915489789316;4054.7972601369815;4055.9391609125887;4057.7768222747736;3380.121168496184;3441.2429265561536;3518.1556426457723;3521.1901262709466;3523.40102182627;4999.625178040438;5001.374828146481;5004.174311238641;5010;5059.671121377099;4629.259318509056;4629.560191781776;4636;4640.396748422683;4643.141018911512;5467.261919640838;5474.37044739856;5493;5493.505584497414;5501.394846566875;3862.671672907806;3864.768113913174;3866.7873266970305;3868.323043467382;3869.3808990561374;5539.473749993744;5782.190493330937;5785.913211301791;5787.8553036174435;5790;3815.1225218199415;3841.4045822897497;3860.903477413031;3863.864764733221;3876;3913.4325522799036;3916.099297161669;3917.882463526099;3918.706097042676;3921.254961557295;4539.954600453953;4546.681732278775;4552.044070745181;4552.954470455319;4553.681242313006;5494.230807686927;5494.725263736797;5494.752736126884;5501.642393244426;5501.889962200814;1367.3915107777143;1391.0679844504207;1391.1861560986733;1393.8188035555313;1395.4348488862026;907.8819753432143;929.3680297397699;929.4980710416299;950.458238803889;951.4291425144858;4669.39297891272;4779.139754844162;4833.3958255218095;4837.201861692782;4840.177169881058;5574.498295153375;5680.375158732536;5687.0616348302065;5694.259746232963;5695.259616249861;4824.831130910471;4833.927491087637;4842.249451335048;4889.48660390661;4889.535494128052;3024.8638811253545;3063.5557844112477;3064.524998625172;3065.509518477033;3067.1871953932227;5385.084535628953;5396.78412863481;5397.082495975694;5397.78408863641;5400.108982017923;5646.661200327993;5882.49998750111;5884.264466941632;5888.499477544371;5891.175235467038;5352.598555108382;5438.129899216106;5440.156775699773;5451.645643033111;5454.209139674725;5746.626469279484;5753.769849206153;5757.337906140848;5766.048601980626;5769.249997500298;5612.915806262991;5640.971795140998;5642.492175704207;5648.152777083306;5662.348829884451;5434.538064264581;5444.373897001737;5445;5451.373092094302;5452.536534394462;3985.143194213258;4034.0721634023753;4034.91930161401;4035.91928161441;4043.8786836394956;5499.4225606310765;5681;5687.3459552152035;5691.345495268097;5695.515881150149;5433.130699088127;5492.4507549246355;5514.503694667499;5517.917231241615;5517.944820551743;5509.696966666712;5510.8071217507195;5512.91730624049;5513.972430137824;5529.778808847601;5407.486288802557;5409.161579955114;5410.756515956713;5411.323584551931;5413.7834486620095;5410.567154627699;5552.5557955362665;5562.249096371938;5564.081926482247;5568.136938774496;5327.547158491417;5351.785928562969;5357.249985002025;5359.571234301325;5360.142377219626 16:26:30 INFO - PROCESS | 3541 | |5;yui.html;689.4794430205194;691.2914262880545;698.1447726534992;715.3311653603881;737.443230361078;11329.660110196697;11430.485628146722;11447.771044579114;11937.283762974228;12153.149279550435;13047.543335983242;13201.141925774818;13214.141080829739;13234.272115033693;13247.735045299112;609.6646844235675;778.5212094561846;786.1666633368619;793.9007624046994;794.3565711773454;798.8881556582083;801.2588355770918;803.6905791270344;807.3137832842096;807.8222790985974;837.6063250272363;841.8989721233461;842.5913431985482;842.7429633961639;843.6288033265374;638.0970926139507;821.1870248453988;833.212614079695;837.5602808525542;840.1178762299561;613.9539534534883;616.8797084568511;617.3178637605427;617.6479406738162;617.7776000639766;12445.315507647076;12451.128421010442;12483.251004939642;12488.313142777144;12494.562690305887;11088.944555277172;11819.409029548575;11896.464659090361;11951.282923024559;12063;9709.854352184722;9755.227076703424;9780.608775648965;9914.652987145415;9990;3209.149575362531;3274.5415641810164;3283.0807373935336;3284.375968565989;3296.5549650797075;41381;41612.58387416117;41879.581204187874;42053.78973105115;42136.157276854596;8966.730998070068;9024.36829421934;9077.77305567366;9108.908910910806;9375.10936461035;16165.434209802836;16197;16213.35146594123;16306.184690765414;16411.42560010394;5912.290525137011;6004.42957918997;6430.935690643034;6662.300458451793;6711;3277.5903012123485;3337.1156643489494;3457.187560923181;3570.285942811448;3645.8359373828243;2819.887204511838;2839.730225628562;2842.4315136972687;2845.743883050494;2850.7006764289868;486.0667518364748;491.5846110037013;503.7934446876763;505.2396143803626;511.4042140905803;575.2808988764045;593.5340757505337;600.0309500157215;605.2434456928839;614.7878981751288;7580.848383032308;7836;7866.881996770053;7942.166072562413;7969.880451793228;544.335910189568;563.3015061323929;569.860384205864;576.1933293389288;596.5257620191958;3597.604263531062;3600.6579374959338;3616.638336166415;3626.3472574936764;3648.21563363878;46476.5352346479;46684.76657616758;46688.766556167;46710.53289467062;47135.764321178176;42062;43002.35496467556;43260.3510947336;43719.56280437155;43889.78055109704;38247.80876095602;39282.41076383857;39855.80072099621;40022.39966400506;40045.79977100096;6528.967355163194;6530.771423000172;6542.953127499768;6567.671616419256;6643.933560664332;30146.84926575353;30640.693593063785;31093.378132437676;31624.209394765316;31791.364172715952;35638.64361356353;36402.635973639924;36470.088247792955;38146;39047.609523905536;8921.776955576162;8965.417247878868;9013.63945442175;9022.503762293138;9097.863532047157;9784.28043543405;9909.30634855582;10009.199264058712;10031.598736050768;10035.949820250851;9151;9170.95414522923;9360.15758581731;9367.906320936703;9372.859407108763;8361.790955226168;9299.256059515357;9300.767480813034;9333.300002499975;9659.517024148905;8881.200691937756;8896.377253592187;8978.281737461119;9020.81958360816;9080.318976076689;7752.26353496417;7810.140884502586;7831.412644051605;7848.450608457581;7888.290053895177;7586.468947173645;7618.276263754934;7768.84462310762;7986.440949133505;8018 16:26:30 INFO - PROCESS | 3541 | __end_tp_report 16:26:30 INFO - PROCESS | 3541 | __start_cc_report 16:26:30 INFO - PROCESS | 3541 | _x_x_mozilla_cycle_collect,833 16:26:30 INFO - PROCESS | 3541 | __end_cc_report 16:26:30 INFO - PROCESS | 3541 | __startTimestamp1457655990588__endTimestamp 16:26:30 INFO - PROCESS | 3541 | 16:26:30 INFO - PROCESS | 3541 | ------- Summary: start ------- 16:26:30 INFO - PROCESS | 3541 | Number of tests: 6 16:26:30 INFO - PROCESS | 3541 | 16:26:30 INFO - PROCESS | 3541 | [#0] dojo.html Cycles:165 Average:4439.32 Median:4529.68 stddev:440.63 (9.7%) stddev-sans-first:416.71 16:26:30 INFO - PROCESS | 3541 | Values: 2564.4 2618.2 2623.7 2645.8 2661.0 4415.7 4429.5 4449.5 4463.4 4529.7 4470.6 4497.1 4510.1 4523.2 4558.0 4114.3 4160.6 4210.9 4241.6 4253.9 4083.7 4163.3 4214.3 4215.6 4226.5 4117.2 4178.3 4187.8 4233.4 4234.0 4151.7 4156.4 4169.1 4175.9 4185.5 4041.7 4136.4 4138.6 4148.2 4180.2 4379.7 4412.3 4438.9 4476.5 4476.7 4750.6 4752.4 4752.7 4757.4 4770.6 4652.7 4774.0 4792.6 4798.7 4828.0 4397.7 4416.1 4459.6 4480.9 4486.9 4863.1 4863.1 4868.5 4883.3 4902.0 4565.0 4664.1 4680.7 4707.7 4710.0 4825.1 4842.5 4845.2 4852.8 4886.7 4775.6 4784.0 4786.2 4789.3 4818.1 4629.6 4677.0 4763.9 4773.4 4817.4 4037.2 4054.5 4059.0 4076.0 4091.3 3574.8 3575.6 3577.9 3603.7 3610.4 4103.5 4143.6 4193.0 4230.9 4238.5 4808.2 4808.6 4812.8 4817.5 4870.8 4137.1 4159.4 4163.0 4172.0 4201.2 4148.4 4274.2 4296.8 4342.2 4352.9 4515.6 4518.2 4520.8 4573.1 4573.2 4830.1 4832.6 4833.2 4840.4 4874.0 4464.2 4493.0 4543.0 4543.3 4582.4 4778.9 4806.4 4809.6 4811.3 4836.2 4680.6 4845.7 4860.3 4869.7 4902.3 4635.3 4688.7 4689.1 4703.1 4743.7 4575.1 4615.9 4616.3 4619.3 4660.9 4436.4 4533.5 4540.4 4545.7 4581.2 4673.1 4673.8 4681.3 4687.2 4723.9 4517.3 4522.8 4523.2 4544.2 4575.1 16:26:30 INFO - PROCESS | 3541 | 16:26:30 INFO - PROCESS | 3541 | [#1] ext.html Cycles:180 Average:36317.98 Median:33588.42 stddev:51924.53 (154.6%) stddev-sans-first:52000.51 16:26:30 INFO - PROCESS | 3541 | Values: 491.6 515.5 541.9 550.2 554.8 24161.3 32694.8 32993.5 33006.5 33135.3 37205.4 37552.4 37572.2 37770.2 37781.2 6770.9 7584.8 7791.2 9339.6 9506.3 9524.6 9659.9 9665.8 9673.1 9676.9 9385.9 9424.1 9443.0 9446.3 9464.5 9660.5 9667.3 9726.3 9742.2 9750.2 9537.9 9710.2 9717.9 10007.1 10088.7 37409.8 37908.4 37915.6 37944.6 38046.4 2802.3 2885.4 2917.9 2965.8 3011.5 27976.0 28026.2 28172.4 28794.7 28945.3 3456.2 3503.8 3510.3 3517.7 3535.7 211522.0 211639.9 211988.0 212166.0 212801.0 51301.2 51363.5 51590.7 51665.0 51710.5 56646.0 56955.0 59087.7 59940.4 60063.7 10988.3 12393.4 12496.2 12514.7 12516.1 9138.7 9378.2 9387.7 9479.2 9526.0 18298.5 18499.6 18525.4 18528.4 18609.2 7376.8 7681.7 7700.9 7763.3 7777.6 820.4 844.2 844.8 930.8 999.3 25653.0 27747.2 29025.6 29190.9 29345.7 885.7 910.7 947.0 959.0 1028.8 12723.5 13154.5 13213.4 14807.3 15621.9 228854.0 231534.0 232035.0 232356.0 232815.0 47963.8 48208.0 48526.5 48566.8 48641.8 1017.8 1178.6 1188.2 1307.6 1341.4 23030.3 24503.8 26126.3 26617.3 26743.3 34587.8 34786.3 34866.7 34876.0 34879.8 144074.0 144596.0 148343.0 148355.0 148594.0 23109.3 27343.5 27762.7 27884.9 27927.9 32103.2 32320.8 40890.6 41439.0 41981.8 30874.0 32878.7 33445.8 33472.3 33534.2 33029.2 33179.0 33270.5 33427.2 33583.8 33378.5 33593.0 33596.5 33708.8 34258.8 26162.6 27696.9 29945.7 30060.5 30287.8 23367.1 23570.9 23637.6 23638.0 23948.3 16:26:30 INFO - PROCESS | 3541 | 16:26:30 INFO - PROCESS | 3541 | [#2] jquery.html Cycles:180 Average:21453.64 Median:5154.26 stddev:57745.47 (1120.3%) stddev-sans-first:57885.67 16:26:30 INFO - PROCESS | 3541 | Values: 327.5 332.0 332.4 336.8 338.8 14591.3 14943.8 15087.9 15417.4 15468.4 13973.0 13976.5 14240.0 14552.1 14804.7 4853.4 5014.5 5026.3 5028.3 5051.9 5004.8 5040.6 5053.9 5240.1 5240.9 5192.3 5195.7 5206.4 5229.8 5232.9 5139.6 5168.9 5188.6 5192.2 5320.7 5080.8 5081.7 5095.1 5123.9 5127.3 11365.7 11448.9 11655.6 12001.6 12003.5 1667.2 1674.6 1921.6 2405.0 2436.7 8590.0 11841.2 12133.7 12377.4 12629.6 1735.3 1740.2 1778.6 1785.2 1818.1 53357.7 53619.7 53904.5 56253.4 57098.1 9453.2 9497.7 9511.7 9644.9 10045.9 10626.4 12057.2 12550.7 12806.7 12849.7 6527.6 6655.8 6688.0 6777.9 6824.4 6668.2 6739.4 6743.1 6827.5 6850.5 3865.8 3991.2 4030.6 4190.2 4267.3 1686.6 1704.6 1717.6 1718.9 1735.4 804.7 829.2 894.5 909.3 951.5 14448.8 14480.7 14878.9 15037.9 15130.9 758.4 769.4 833.2 871.4 887.6 8677.7 8746.5 8792.8 8833.1 8895.2 346706.0 347855.0 352467.0 354254.0 354720.0 65010.7 66138.3 68531.0 68704.7 68754.0 829.4 853.9 864.9 866.6 867.9 10917.6 13865.7 14425.1 14715.4 14768.9 30818.7 31753.7 32364.7 32913.8 33740.2 36990.8 41409.4 43265.6 43655.3 43745.1 6910.4 7220.7 7223.2 7275.5 7321.9 6195.2 7966.9 8948.0 9832.2 10407.1 9381.3 9430.4 9492.9 9510.7 9885.1 9377.5 9540.9 9572.7 9602.7 9622.1 9509.3 9727.2 9760.4 9824.6 10126.1 7166.4 7210.3 7293.1 7308.7 7491.1 8555.7 9423.9 9648.3 9653.4 9682.8 16:26:30 INFO - PROCESS | 3541 | 16:26:30 INFO - PROCESS | 3541 | [#3] mootools.html Cycles:180 Average:5076.98 Median:5822.14 stddev:2751.45 (47.3%) stddev-sans-first:2744.03 16:26:30 INFO - PROCESS | 3541 | Values: 1236.8 1351.2 1362.9 1496.7 1759.1 6331.6 7164.4 7271.2 7272.1 7272.6 6995.4 7166.4 7174.2 7188.6 7192.4 1790.8 2061.6 2102.6 2125.1 2130.3 2162.8 2170.9 2171.8 2174.3 2174.6 2019.2 2061.8 2078.0 2078.1 2079.7 2059.4 2064.6 2069.8 2080.3 2103.5 2000.1 2002.3 2002.7 2005.3 2009.8 7488.5 7561.6 7562.4 7570.8 7579.4 4289.0 4376.8 4411.6 4411.9 4415.6 2755.2 2767.7 2887.4 2908.1 2914.5 880.5 888.4 902.0 943.6 954.7 10545.0 10565.6 10578.3 10580.6 10595.1 3993.2 4017.5 4078.2 4092.2 4113.1 8665.6 8763.1 8803.8 8818.4 8819.4 3788.1 4258.3 4274.1 4278.9 4280.6 3830.1 3906.5 3917.8 3934.0 3945.6 3341.7 3429.8 3431.1 3455.9 3477.7 1079.7 1095.3 1095.6 1100.7 1102.0 852.0 855.3 861.1 861.5 1131.1 6952.7 6987.5 7005.3 7032.7 7037.7 432.0 441.6 452.2 455.4 455.5 5303.4 5307.8 5347.4 5387.6 5395.2 8839.7 9047.9 9283.1 9295.2 9313.7 9011.1 9020.7 9040.3 9072.8 9077.5 6573.9 6753.8 6754.6 7060.1 7140.8 6987.7 7025.5 7068.0 7074.3 7111.8 7662.2 7910.7 8001.1 8031.6 8039.4 7977.6 8218.5 8226.5 8247.1 8256.7 5440.8 5948.5 6198.1 6312.3 6399.7 7026.9 7040.1 7052.4 7082.5 7102.3 6153.9 6271.9 6300.6 6352.2 6359.6 5706.6 5721.5 5745.5 5755.8 5818.7 6272.4 6332.7 6340.9 6352.3 6355.7 5803.7 5850.8 5863.8 5879.1 5882.5 5724.9 5742.1 5791.0 5825.6 5833.9 16:26:30 INFO - PROCESS | 3541 | 16:26:30 INFO - PROCESS | 3541 | [#4] prototype.html Cycles:180 Average:4558.83 Median:5237.15 stddev:1347.67 (25.7%) stddev-sans-first:1312.97 16:26:30 INFO - PROCESS | 3541 | Values: 298.5 301.4 302.3 305.7 307.7 5209.4 5228.9 5273.6 5281.7 5330.9 5208.9 5217.8 5223.0 5230.4 5243.9 3857.4 3971.3 3985.8 4063.0 4065.3 3963.4 3983.5 3988.7 4059.0 4084.4 4026.8 4053.2 4063.6 4065.5 4065.5 4043.8 4048.3 4054.8 4055.9 4057.8 3380.1 3441.2 3518.2 3521.2 3523.4 4999.6 5001.4 5004.2 5010.0 5059.7 4629.3 4629.6 4636.0 4640.4 4643.1 5467.3 5474.4 5493.0 5493.5 5501.4 3862.7 3864.8 3866.8 3868.3 3869.4 5539.5 5782.2 5785.9 5787.9 5790.0 3815.1 3841.4 3860.9 3863.9 3876.0 3913.4 3916.1 3917.9 3918.7 3921.3 4540.0 4546.7 4552.0 4553.0 4553.7 5494.2 5494.7 5494.8 5501.6 5501.9 1367.4 1391.1 1391.2 1393.8 1395.4 907.9 929.4 929.5 950.5 951.4 4669.4 4779.1 4833.4 4837.2 4840.2 5574.5 5680.4 5687.1 5694.3 5695.3 4824.8 4833.9 4842.2 4889.5 4889.5 3024.9 3063.6 3064.5 3065.5 3067.2 5385.1 5396.8 5397.1 5397.8 5400.1 5646.7 5882.5 5884.3 5888.5 5891.2 5352.6 5438.1 5440.2 5451.6 5454.2 5746.6 5753.8 5757.3 5766.0 5769.2 5612.9 5641.0 5642.5 5648.2 5662.3 5434.5 5444.4 5445.0 5451.4 5452.5 3985.1 4034.1 4034.9 4035.9 4043.9 5499.4 5681.0 5687.3 5691.3 5695.5 5433.1 5492.5 5514.5 5517.9 5517.9 5509.7 5510.8 5512.9 5514.0 5529.8 5407.5 5409.2 5410.8 5411.3 5413.8 5410.6 5552.6 5562.2 5564.1 5568.1 5327.5 5351.8 5357.2 5359.6 5360.1 16:26:30 INFO - PROCESS | 3541 | 16:26:30 INFO - PROCESS | 3541 | [#5] yui.html Cycles:180 Average:11829.29 Median:598.28 stddev:13434.92 (2245.6%) stddev-sans-first:13446.57 16:26:30 INFO - PROCESS | 3541 | Values: 689.5 691.3 698.1 715.3 737.4 11329.7 11430.5 11447.8 11937.3 12153.1 13047.5 13201.1 13214.1 13234.3 13247.7 609.7 778.5 786.2 793.9 794.4 798.9 801.3 803.7 807.3 807.8 837.6 841.9 842.6 842.7 843.6 638.1 821.2 833.2 837.6 840.1 614.0 616.9 617.3 617.6 617.8 12445.3 12451.1 12483.3 12488.3 12494.6 11088.9 11819.4 11896.5 11951.3 12063.0 9709.9 9755.2 9780.6 9914.7 9990.0 3209.1 3274.5 3283.1 3284.4 3296.6 41381.0 41612.6 41879.6 42053.8 42136.2 8966.7 9024.4 9077.8 9108.9 9375.1 16165.4 16197.0 16213.4 16306.2 16411.4 5912.3 6004.4 6430.9 6662.3 6711.0 3277.6 3337.1 3457.2 3570.3 3645.8 2819.9 2839.7 2842.4 2845.7 2850.7 486.1 491.6 503.8 505.2 511.4 575.3 593.5 600.0 605.2 614.8 7580.8 7836.0 7866.9 7942.2 7969.9 544.3 563.3 569.9 576.2 596.5 3597.6 3600.7 3616.6 3626.3 3648.2 46476.5 46684.8 46688.8 46710.5 47135.8 42062.0 43002.4 43260.4 43719.6 43889.8 38247.8 39282.4 39855.8 40022.4 40045.8 6529.0 6530.8 6543.0 6567.7 6643.9 30146.8 30640.7 31093.4 31624.2 31791.4 35638.6 36402.6 36470.1 38146.0 39047.6 8921.8 8965.4 9013.6 9022.5 9097.9 9784.3 9909.3 10009.2 10031.6 10035.9 9151.0 9171.0 9360.2 9367.9 9372.9 8361.8 9299.3 9300.8 9333.3 9659.5 8881.2 8896.4 8978.3 9020.8 9080.3 7752.3 7810.1 7831.4 7848.5 7888.3 7586.5 7618.3 7768.8 7986.4 8018.0 16:26:30 INFO - PROCESS | 3541 | -------- Summary: end -------- 16:26:30 INFO - PROCESS | 3541 | 16:26:31 INFO - TEST-INFO | 3541: exit 0 16:26:31 INFO - TEST-OK | dromaeo_css | took 1120218ms 16:26:31 INFO - TEST-START | kraken 16:26:31 INFO - operating with platform_type : linux_ 16:26:31 INFO - Initialising browser for kraken test... 16:26:31 INFO - TEST-INFO | started process 3721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9ajxLG/profile http://localhost:50245/getInfo.html) 16:26:36 INFO - PROCESS | 3721 | __metrics Screen width/height:1600/1200 16:26:36 INFO - PROCESS | 3721 | colorDepth:24 16:26:36 INFO - PROCESS | 3721 | Browser inner width/height: 1024/697 16:26:36 INFO - PROCESS | 3721 | __metrics 16:26:38 ERROR - PROCESS | 3721 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:26:38 INFO - PROCESS | 3721 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 16:26:39 INFO - TEST-INFO | 3721: exit 0 16:26:39 INFO - Browser initialized. 16:26:39 INFO - Running cycle 1/1 for kraken test... 16:26:39 INFO - TEST-INFO | started process 3804 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9ajxLG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:26:51 INFO - PROCESS | 3804 | RSS: Main: 154750976 16:26:51 INFO - PROCESS | 3804 | 16:26:54 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:50245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50245/tests/kraken/driver.html?testName=audio-beat-detection) 16:26:54 INFO - PROCESS | 3804 | RSS: Main: 195977216 16:26:54 INFO - PROCESS | 3804 | 16:26:57 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:50245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50245/tests/kraken/driver.html?testName=audio-dft) 16:26:58 INFO - PROCESS | 3804 | RSS: Main: 185569280 16:26:58 INFO - PROCESS | 3804 | 16:27:01 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:50245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50245/tests/kraken/driver.html?testName=audio-fft) 16:27:01 INFO - PROCESS | 3804 | RSS: Main: 171974656 16:27:01 INFO - PROCESS | 3804 | 16:27:03 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:50245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50245/tests/kraken/driver.html?testName=audio-oscillator) 16:27:04 INFO - PROCESS | 3804 | RSS: Main: 173010944 16:27:04 INFO - PROCESS | 3804 | 16:27:06 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:50245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:27:07 INFO - PROCESS | 3804 | RSS: Main: 173690880 16:27:07 INFO - PROCESS | 3804 | 16:27:10 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:50245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50245/tests/kraken/driver.html?testName=imaging-darkroom) 16:27:10 INFO - PROCESS | 3804 | RSS: Main: 174608384 16:27:10 INFO - PROCESS | 3804 | 16:27:14 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:50245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50245/tests/kraken/driver.html?testName=imaging-desaturate) 16:27:14 INFO - PROCESS | 3804 | RSS: Main: 172244992 16:27:14 INFO - PROCESS | 3804 | 16:27:17 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:50245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50245/tests/kraken/driver.html?testName=json-parse-financial) 16:27:18 INFO - PROCESS | 3804 | RSS: Main: 175247360 16:27:18 INFO - PROCESS | 3804 | 16:27:20 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:50245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:27:20 INFO - PROCESS | 3804 | RSS: Main: 186195968 16:27:20 INFO - PROCESS | 3804 | 16:27:22 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:50245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50245/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:27:23 INFO - PROCESS | 3804 | RSS: Main: 183697408 16:27:23 INFO - PROCESS | 3804 | 16:27:25 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:50245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:27:25 INFO - PROCESS | 3804 | RSS: Main: 193400832 16:27:25 INFO - PROCESS | 3804 | 16:27:28 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:50245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:27:29 INFO - PROCESS | 3804 | RSS: Main: 198430720 16:27:29 INFO - PROCESS | 3804 | 16:27:31 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:50245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:27:32 INFO - PROCESS | 3804 | RSS: Main: 197574656 16:27:32 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:50245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50245/tests/kraken/driver.html?testName=ai-astar) 16:27:34 INFO - PROCESS | 3804 | RSS: Main: 257306624 16:27:34 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | __start_tp_report 16:27:34 INFO - PROCESS | 3804 | _x_x_mozilla_page_load 16:27:34 INFO - PROCESS | 3804 | _x_x_mozilla_page_load_details 16:27:34 INFO - PROCESS | 3804 | |i|pagename|runs| 16:27:34 INFO - PROCESS | 3804 | |0;ai-astar;112;114;107;113;114;114;103;114;115;114 16:27:34 INFO - PROCESS | 3804 | |1;audio-beat-detection;156;132;158;170;135;158;151;141;178;142 16:27:34 INFO - PROCESS | 3804 | |2;audio-dft;161;161;160;162;167;160;164;162;161;161 16:27:34 INFO - PROCESS | 3804 | |3;audio-fft;78;77;102;95;75;74;74;95;91;72 16:27:34 INFO - PROCESS | 3804 | |4;audio-oscillator;94;94;138;95;95;95;149;95;95;139 16:27:34 INFO - PROCESS | 3804 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 16:27:34 INFO - PROCESS | 3804 | |6;imaging-darkroom;146;147;146;147;146;148;146;147;146;145 16:27:34 INFO - PROCESS | 3804 | |7;imaging-desaturate;96;95;96;95;96;95;96;96;95;96 16:27:34 INFO - PROCESS | 3804 | |8;json-parse-financial;65;66;65;65;65;66;65;75;63;63 16:27:34 INFO - PROCESS | 3804 | |9;json-stringify-tinderbox;69;69;69;69;70;70;69;70;71;69 16:27:34 INFO - PROCESS | 3804 | |10;stanford-crypto-aes;83;81;84;83;82;90;84;85;88;91 16:27:34 INFO - PROCESS | 3804 | |11;stanford-crypto-ccm;125;127;120;119;122;121;126;121;119;118 16:27:34 INFO - PROCESS | 3804 | |12;stanford-crypto-pbkdf2;149;139;163;148;157;137;161;141;141;152 16:27:34 INFO - PROCESS | 3804 | |13;stanford-crypto-sha256-iterative;70;70;69;69;69;70;68;71;68;69 16:27:34 INFO - PROCESS | 3804 | __end_tp_report 16:27:34 INFO - PROCESS | 3804 | __start_cc_report 16:27:34 INFO - PROCESS | 3804 | _x_x_mozilla_cycle_collect,1156 16:27:34 INFO - PROCESS | 3804 | __end_cc_report 16:27:34 INFO - PROCESS | 3804 | __startTimestamp1457656054408__endTimestamp 16:27:34 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | ------- Summary: start ------- 16:27:34 INFO - PROCESS | 3804 | Number of tests: 14 16:27:34 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | [#0] ai-astar Cycles:10 Average:112.00 Median:114.00 stddev:3.89 (3.4%) stddev-sans-first:4.12 16:27:34 INFO - PROCESS | 3804 | Values: 112.0 114.0 107.0 113.0 114.0 114.0 103.0 114.0 115.0 114.0 16:27:34 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:157.00 stddev:14.90 (9.5%) stddev-sans-first:15.74 16:27:34 INFO - PROCESS | 3804 | Values: 156.0 132.0 158.0 170.0 135.0 158.0 151.0 141.0 178.0 142.0 16:27:34 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | [#2] audio-dft Cycles:10 Average:161.90 Median:161.50 stddev:2.13 (1.3%) stddev-sans-first:2.24 16:27:34 INFO - PROCESS | 3804 | Values: 161.0 161.0 160.0 162.0 167.0 160.0 164.0 162.0 161.0 161.0 16:27:34 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | [#3] audio-fft Cycles:10 Average:83.30 Median:77.50 stddev:11.16 (14.4%) stddev-sans-first:11.67 16:27:34 INFO - PROCESS | 3804 | Values: 78.0 77.0 102.0 95.0 75.0 74.0 74.0 95.0 91.0 72.0 16:27:34 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:95.00 stddev:23.02 (24.2%) stddev-sans-first:23.78 16:27:34 INFO - PROCESS | 3804 | Values: 94.0 94.0 138.0 95.0 95.0 95.0 149.0 95.0 95.0 139.0 16:27:34 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:27:34 INFO - PROCESS | 3804 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 16:27:34 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 16:27:34 INFO - PROCESS | 3804 | Values: 146.0 147.0 146.0 147.0 146.0 148.0 146.0 147.0 146.0 145.0 16:27:34 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:27:34 INFO - PROCESS | 3804 | Values: 96.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 16:27:34 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:65.00 stddev:3.39 (5.2%) stddev-sans-first:3.59 16:27:34 INFO - PROCESS | 3804 | Values: 65.0 66.0 65.0 65.0 65.0 66.0 65.0 75.0 63.0 63.0 16:27:34 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 16:27:34 INFO - PROCESS | 3804 | Values: 69.0 69.0 69.0 69.0 70.0 70.0 69.0 70.0 71.0 69.0 16:27:34 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.50 stddev:3.41 (4.0%) stddev-sans-first:3.54 16:27:34 INFO - PROCESS | 3804 | Values: 83.0 81.0 84.0 83.0 82.0 90.0 84.0 85.0 88.0 91.0 16:27:34 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:121.50 stddev:3.16 (2.6%) stddev-sans-first:3.13 16:27:34 INFO - PROCESS | 3804 | Values: 125.0 127.0 120.0 119.0 122.0 121.0 126.0 121.0 119.0 118.0 16:27:34 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:150.50 stddev:9.34 (6.2%) stddev-sans-first:9.91 16:27:34 INFO - PROCESS | 3804 | Values: 149.0 139.0 163.0 148.0 157.0 137.0 161.0 141.0 141.0 152.0 16:27:34 INFO - PROCESS | 3804 | 16:27:34 INFO - PROCESS | 3804 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:0.95 (1.4%) stddev-sans-first:0.97 16:27:34 INFO - PROCESS | 3804 | Values: 70.0 70.0 69.0 69.0 69.0 70.0 68.0 71.0 68.0 69.0 16:27:34 INFO - PROCESS | 3804 | -------- Summary: end -------- 16:27:34 INFO - PROCESS | 3804 | 16:27:35 INFO - TEST-INFO | 3804: exit 0 16:27:35 INFO - TEST-OK | kraken | took 63983ms 16:27:35 INFO - SUITE-END | took 1184s 16:27:35 INFO - Completed test suite (00:19:44) 16:27:35 INFO - javascript benchmark 16:27:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2564.358910272432, 2618.1883616079017, 2623.6720409948757, 2645.775109115725, 2660.9866950665246, 4415.712978656393, 4429.490608580014, 4449.510553839079, 4463.397441345422, 4529.682922195448, 4470.552944705528, 4497.1455423469515, 4510.097980403924, 4523.163214805263, 4557.954420455802, 4114.321137012389, 4160.646345060673, 4210.852620158295, 4241.575842415749, 4253.872383828475, 4083.693722970774, 4163.3130533461945, 4214.283571792787, 4215.620594146526, 4226.513950895655, 4117.1765646870745, 4178.310578754502, 4187.790610469464, 4233.428487154257, 4233.999999999969, 4151.6886233532605, 4156.397322388267, 4169.082801783633, 4175.853845115406, 4185.4977402711565, 4041.717079804415, 4136.358864376027, 4138.586141385867, 4148.23257697327, 4180.163967206571, 4379.693421460499, 4412.3160910059, 4438.911221775578, 4476.485204201526, 4476.664250181217, 4750.619950403994, 4752.42970843501, 4752.727055971698, 4757.405324334458, 4770.594499467549, 4652.651051171142, 4774.045190961821, 4792.592629626486, 4798.688085274446, 4827.975860120712, 4397.714148580396, 4416.094700586372, 4459.643228541741, 4480.932786008212, 4486.865394038184, 4863.051704917507, 4863.124637565272, 4868.537488938545, 4883.291922671193, 4901.950980490221, 4565.0, 4664.067186562633, 4680.672352935262, 4707.693999889996, 4709.976450117796, 4825.059113472909, 4842.539958703917, 4845.1520983828395, 4852.8301509447, 4886.65793394459, 4775.594074503706, 4783.95216047842, 4786.1863483207935, 4789.30555069513, 4818.132736107465, 4629.583337499574, 4677.041206552649, 4763.904721905543, 4773.427188737304, 4817.421909370898, 4037.192561487714, 4054.493188351456, 4059.0258337998666, 4076.0, 4091.263572556909, 3574.767640103385, 3575.588807287143, 3577.9105522362147, 3603.747737658391, 3610.422332426799, 4103.466549348565, 4143.56492568276, 4193.014641559231, 4230.894227644333, 4238.491381034296, 4808.230683090689, 4808.591269742041, 4812.831550895772, 4817.542333478314, 4870.756462176877, 4137.110521237948, 4159.376093585986, 4163.02168990287, 4171.97914010428, 4201.243776120327, 4148.377743338463, 4274.187904298174, 4296.828126874952, 4342.174986752507, 4352.9129417412105, 4515.616172625364, 4518.186726389282, 4520.819167233274, 4573.131105090022, 4573.153966516072, 4830.106430310404, 4832.565069143794, 4833.2025215840395, 4840.370751802243, 4874.025194960951, 4464.17412778637, 4493.0, 4542.977285113686, 4543.318502224693, 4582.404287442611, 4778.904421911612, 4806.375171227858, 4809.639277054305, 4811.254255590389, 4836.177849765478, 4680.578747912704, 4845.6608037438455, 4860.3195552623365, 4869.732164730974, 4902.338184345211, 4635.281531362644, 4688.671792974459, 4689.062187562569, 4703.129920964632, 4743.715377077387, 4575.062112267044, 4615.930761038654, 4616.307553866947, 4619.260918253063, 4660.883477913079, 4436.356728274318, 4533.478649955166, 4540.409746732904, 4545.749983750926, 4581.198290299118, 4673.112108699336, 4673.789679464364, 4681.250999840009, 4687.226607609706, 4723.905521889612, 4517.344984977226, 4522.751248681354, 4523.23105072132, 4544.159330523864, 4575.062112267044], "unit": "score", "name": "dojo.html", "value": 4413.1594958627775}, {"lowerIsBetter": false, "replicates": [491.6484713429899, 515.5282916131738, 541.9432107390589, 550.246162757023, 554.794725951398, 24161.275161745154, 32694.83652581737, 32993.50509742356, 33006.50490242642, 33135.33729325412, 37205.44191837118, 37552.43671344925, 37572.248555028884, 37770.24459510808, 37781.24437511255, 6770.932290677079, 7584.810379740509, 7791.181925897784, 9339.579718912632, 9506.334556581041, 9524.571394287274, 9659.855102173473, 9665.806683866318, 9673.129418352348, 9676.903230967706, 9385.906140938605, 9424.057594240556, 9443.0, 9446.338756287063, 9464.526773661324, 9660.516974151335, 9667.323287369887, 9726.2705297103, 9742.22062235023, 9750.171235444996, 9537.856932146024, 9710.223182145412, 9717.90282097177, 10007.149392301662, 10088.747781305452, 37409.812950935346, 37908.43137352942, 37915.62084379176, 37944.62055379438, 38046.42930356047, 2802.285417218596, 2885.350796070867, 2917.868695908689, 2965.7627389808763, 3011.48804703201, 27976.021971582035, 28026.159215223575, 28172.43655126886, 28794.71205287941, 28945.276368090756, 3456.1705190754287, 3503.754737168399, 3510.342974836576, 3517.736169787276, 3535.7171426285836, 211522.0, 211639.8942100498, 211988.0, 212166.0, 212801.0, 51301.23048154281, 51363.48636513662, 51590.74204628953, 51665.0, 51710.48289517132, 56646.0, 56955.0, 59087.704561476916, 59940.40059599348, 60063.69968150131, 10988.340699558052, 12393.442295096742, 12496.187747796364, 12514.749705005848, 12516.061295402882, 9138.725838224864, 9378.249740020781, 9387.718368448957, 9479.24166066713, 9526.047395260557, 18298.45104646863, 18499.630007400046, 18525.44423667292, 18528.44414667562, 18609.162587683317, 7376.815579610553, 7681.731139410205, 7700.884486732703, 7763.262490063435, 7777.611119444005, 820.4257020085963, 844.1769274956868, 844.8225872566829, 930.8231436027269, 999.3254553176577, 25653.0, 27747.16758497248, 29025.564616530348, 29190.854045729637, 29345.706542934724, 885.7121435533477, 910.6539514984264, 946.9526523673788, 958.9760255993516, 1028.7685270814006, 12723.491060357483, 13154.473821047242, 13213.405396756976, 14807.259637018105, 15621.921890390702, 228854.0, 231534.0, 232035.0, 232356.0, 232815.0, 47963.76018119887, 48208.0, 48526.514734852906, 48566.757166213945, 48641.756791216525, 1017.7710015246511, 1178.640514643042, 1188.2157775867886, 1307.5946456598294, 1341.3628526449859, 23030.309090726634, 24503.75496245086, 26126.34684132912, 26617.33456663599, 26743.331416714736, 34587.827060865544, 34786.30427391489, 34866.65133348735, 34876.0, 34879.82560087183, 144074.0, 144596.0, 148343.0, 148355.0, 148594.0, 23109.306720798402, 27343.45313093767, 27762.72237277682, 27884.860575697803, 27927.86036069888, 32103.197420064684, 32320.83839580787, 40890.591094088675, 41439.0, 41981.79009105057, 30874.0, 32878.671213288515, 33445.83277083599, 33472.330553389285, 33534.16164595807, 33029.17427064342, 33179.0, 33270.50094248637, 33427.164320892174, 33583.83208083944, 33378.49932251067, 33593.0, 33596.49605255972, 33708.83145584256, 34258.828705856315, 26162.607560886223, 27696.861515692293, 29945.70054299429, 30060.549091763205, 30287.848560757055, 23367.065317387794, 23570.882145589163, 23637.644026910217, 23638.0, 23948.281551553482], "unit": "score", "name": "ext.html", "value": 16542.78929335623}, {"lowerIsBetter": false, "replicates": [327.46623004502675, 331.96182439019515, 332.44315771083427, 336.8366342323972, 338.828891409838, 14591.27043647816, 14943.775843362344, 15087.92456037721, 15417.383304667814, 15468.381264749425, 13973.0, 13976.510822121229, 14240.0, 14552.126872387664, 14804.703905921875, 4853.44185418677, 5014.548690617844, 5026.346574945252, 5028.2709007193935, 5051.873703157432, 5004.824831130911, 5040.621953353495, 5053.949460505403, 5240.056789777838, 5240.868978275555, 5192.299039629658, 5195.740212989354, 5206.375234971809, 5229.790808367661, 5232.895342093156, 5139.588832893378, 5168.9224661630105, 5188.610854185951, 5192.221166824968, 5320.733963301819, 5080.847574572768, 5081.720505372203, 5095.133827249377, 5123.87190320245, 5127.333446651912, 11365.715857103556, 11448.885511144865, 11655.59205427806, 12001.63995080149, 12003.459844307026, 1667.2497376180645, 1674.5646132005766, 1921.6060707554918, 2404.9519009619708, 2436.7075950886006, 8589.957050214709, 11841.171118021743, 12133.696657583543, 12377.443015064253, 12629.557965471164, 1735.297204632126, 1740.225599608175, 1778.5731424458038, 1785.214505617524, 1818.0909545227387, 53357.733211333696, 53619.73190134063, 53904.460955390336, 56253.43746562564, 57098.14352784712, 9453.243740500744, 9497.715068547956, 9511.66709165176, 9644.9035509644, 10045.899541004643, 10626.415547144981, 12057.216280941711, 12550.686232844251, 12806.679833004064, 12849.678758031125, 6527.640979746065, 6655.833604159935, 6687.966560167265, 6777.8644427111185, 6824.41992430639, 6668.166479190101, 6739.427148692416, 6743.123393958754, 6827.52207345491, 6850.451963842881, 3865.8260378283044, 3991.1818077294083, 4030.5767894371256, 4190.161967606491, 4267.317229243306, 1686.5867862373552, 1704.6249825038471, 1717.6221231329087, 1718.8538974187334, 1735.366591194205, 804.7103042904549, 829.2081062585216, 894.458852394305, 909.2771246858763, 951.4957072751314, 14448.783268250985, 14480.710385792225, 14878.925605371904, 15037.924810375878, 15130.924345378202, 758.4463341760546, 769.4267770510893, 833.2167762303416, 871.4030888841164, 887.5650931043871, 8677.696280630147, 8746.518941458153, 8792.78018049541, 8833.116688331116, 8895.199432051017, 346706.0, 347855.0, 352467.0, 354254.0, 354720.0, 65010.67494662497, 66138.33861661419, 68531.0, 68704.70025218876, 68754.0, 829.3531045784177, 853.9274161696326, 864.8529749942525, 866.6013633728429, 867.869819527076, 10917.617883374043, 13865.722685546434, 14425.062370945854, 14715.411383544539, 14768.926155369154, 30818.691813081583, 31753.68246317507, 32364.676353236166, 32913.83543082269, 33740.15649608681, 36990.815045924595, 41409.37885931653, 43265.567344326155, 43655.345169823115, 43745.125097497235, 6910.412614927586, 7220.675069621985, 7223.241559636373, 7275.454340924558, 7321.853562928818, 6195.2255968004, 7966.924465197124, 8947.955260223658, 9832.164266037467, 10407.074691182155, 9381.296402769683, 9430.387024843363, 9492.905070949202, 9510.667126650535, 9885.110340069428, 9377.484238366682, 9540.85688714656, 9572.712818615453, 9602.66390676351, 9622.13400793932, 9509.334346595671, 9727.173190278623, 9760.414375137514, 9824.557894894604, 10126.088652021353, 7166.426685865223, 7210.2789721027475, 7293.0519032525435, 7308.707651693872, 7491.138519070377, 8555.743327700178, 9423.858642120511, 9648.324617276723, 9653.420794752337, 9682.75793105178], "unit": "score", "name": "jquery.html", "value": 7513.058860958977}, {"lowerIsBetter": false, "replicates": [1236.8082947143184, 1351.2162945491616, 1362.8569000254972, 1496.6632507685772, 1759.0501129390123, 6331.5567910246245, 7164.355208031277, 7271.236520165379, 7272.090988626422, 7272.563646181233, 6995.405390541798, 7166.355028047475, 7174.21083680796, 7188.604626745527, 7192.352688258055, 1790.7672002639638, 2061.628906796776, 2102.6425507663694, 2125.1393185759716, 2130.286354071388, 2162.762096169428, 2170.924017659382, 2171.7936796004356, 2174.293354659734, 2174.5650869826018, 2019.1822311963679, 2061.773204947462, 2077.968830467544, 2078.1064142418754, 2079.667253239482, 2059.3821853443906, 2064.5561204341066, 2069.7619773726065, 2080.251109600543, 2103.5267064910427, 2000.0899590686204, 2002.3292197113985, 2002.7396438463052, 2005.31819181479, 2009.809068138539, 7488.475806693534, 7561.621918904033, 7562.395008399315, 7570.810729731746, 7579.431542634325, 4288.957110428887, 4376.803043863034, 4411.6250118739945, 4411.933820992687, 4415.580519850609, 2755.2423083651956, 2767.681716602596, 2887.364779748452, 2908.0548821633056, 2914.504534229186, 880.515716356008, 888.4180861535705, 902.0348227396688, 943.6131186213688, 954.6515521834481, 10545.0, 10565.63020294286, 10578.312409693346, 10580.57677692899, 10595.099416549603, 3993.2412841560013, 4017.4978127734034, 4078.2455245779624, 4092.1611069730634, 4113.095119073799, 8665.566721664018, 8763.123687631185, 8803.779905502413, 8818.382713210141, 8819.382643214913, 3788.109794198361, 4258.297380932111, 4274.1451709658195, 4278.935815962763, 4280.59334363235, 3830.0999265172663, 3906.453096566483, 3917.804109794556, 3934.016495876031, 3945.6251656092627, 3341.732661387083, 3429.7770644908, 3431.1250631088915, 3455.87904423344, 3477.730628320645, 1079.7192729890285, 1095.315427857589, 1095.6274866545414, 1100.6973082402244, 1102.0, 851.9787005324916, 855.2730179347504, 861.1216559109673, 861.5261606116611, 1131.145984781501, 6952.652367381712, 6987.510874238857, 7005.334493223136, 7032.683529241196, 7037.683304251321, 431.95464476229546, 441.6135881104034, 452.15221459762944, 455.4466323417064, 455.4511813265008, 5303.363596368384, 5307.840764777063, 5347.385050719139, 5387.595930305243, 5395.217693434509, 8839.69061082859, 9047.864282035775, 9283.11810378013, 9295.163435290857, 9313.674021409219, 9011.053839346774, 9020.684276050306, 9040.276777857756, 9072.773180670536, 9077.546122693839, 6573.868522629617, 6753.763618273435, 6754.628495432798, 7060.082189315356, 7140.7857764267155, 6987.650617469208, 7025.5082144251455, 7068.020954132851, 7074.257202993817, 7111.751088712077, 7662.233776622294, 7910.7231246906085, 8001.079875814123, 8031.638576263966, 8039.437239393186, 7977.5612341321785, 8218.547979860927, 8226.506409615442, 8247.051589067334, 8256.711015114442, 5440.782368705208, 5948.464638182584, 6198.101275315144, 6312.274088479883, 6399.712012959335, 7026.894596581157, 7040.119985001875, 7052.435805135474, 7082.468814838805, 7102.289771023063, 6153.907691384543, 6271.905921411091, 6300.59046161998, 6352.237731472253, 6359.554831161774, 5706.572007099401, 5721.456461636138, 5745.454181852718, 5755.769769209185, 5818.650880947157, 6272.372762723691, 6332.651704156131, 6340.904886426615, 6352.269489008639, 6355.650439225887, 5803.65178089316, 5850.795222167204, 5863.794767183128, 5879.059350503899, 5882.49998750111, 5724.914126288192, 5742.109972954198, 5791.015527360443, 5825.621334613236, 5833.883322333614], "unit": "score", "name": "mootools.html", "value": 4048.0632953814584}, {"lowerIsBetter": false, "replicates": [298.4538294920296, 301.4498540164201, 302.31978049388874, 305.72179316821695, 307.707677706179, 5209.374875014999, 5228.895422091566, 5273.604479664026, 5281.683099014062, 5330.92003619946, 5208.8697782555455, 5217.765200565974, 5222.973885130569, 5230.424653288144, 5243.86890327741, 3857.3635350167187, 3971.305021621219, 3985.8007099645047, 4062.9796851015703, 4065.2885744994583, 3963.425303331015, 3983.4821473208444, 3988.660963818079, 4059.0, 4084.387341898724, 4026.7986600669997, 4053.169100334439, 4063.5936406359274, 4065.4918135233097, 4065.532463766675, 4043.818028188724, 4048.2915489789316, 4054.7972601369815, 4055.9391609125887, 4057.7768222747736, 3380.121168496184, 3441.2429265561536, 3518.1556426457723, 3521.1901262709466, 3523.40102182627, 4999.625178040438, 5001.374828146481, 5004.174311238641, 5010.0, 5059.671121377099, 4629.259318509056, 4629.560191781776, 4636.0, 4640.396748422683, 4643.141018911512, 5467.261919640838, 5474.37044739856, 5493.0, 5493.505584497414, 5501.394846566875, 3862.671672907806, 3864.768113913174, 3866.7873266970305, 3868.323043467382, 3869.3808990561374, 5539.473749993744, 5782.190493330937, 5785.913211301791, 5787.8553036174435, 5790.0, 3815.1225218199415, 3841.4045822897497, 3860.903477413031, 3863.864764733221, 3876.0, 3913.4325522799036, 3916.099297161669, 3917.882463526099, 3918.706097042676, 3921.254961557295, 4539.954600453953, 4546.681732278775, 4552.044070745181, 4552.954470455319, 4553.681242313006, 5494.230807686927, 5494.725263736797, 5494.752736126884, 5501.642393244426, 5501.889962200814, 1367.3915107777143, 1391.0679844504207, 1391.1861560986733, 1393.8188035555313, 1395.4348488862026, 907.8819753432143, 929.3680297397699, 929.4980710416299, 950.458238803889, 951.4291425144858, 4669.39297891272, 4779.139754844162, 4833.3958255218095, 4837.201861692782, 4840.177169881058, 5574.498295153375, 5680.375158732536, 5687.0616348302065, 5694.259746232963, 5695.259616249861, 4824.831130910471, 4833.927491087637, 4842.249451335048, 4889.48660390661, 4889.535494128052, 3024.8638811253545, 3063.5557844112477, 3064.524998625172, 3065.509518477033, 3067.1871953932227, 5385.084535628953, 5396.78412863481, 5397.082495975694, 5397.78408863641, 5400.108982017923, 5646.661200327993, 5882.49998750111, 5884.264466941632, 5888.499477544371, 5891.175235467038, 5352.598555108382, 5438.129899216106, 5440.156775699773, 5451.645643033111, 5454.209139674725, 5746.626469279484, 5753.769849206153, 5757.337906140848, 5766.048601980626, 5769.249997500298, 5612.915806262991, 5640.971795140998, 5642.492175704207, 5648.152777083306, 5662.348829884451, 5434.538064264581, 5444.373897001737, 5445.0, 5451.373092094302, 5452.536534394462, 3985.143194213258, 4034.0721634023753, 4034.91930161401, 4035.91928161441, 4043.8786836394956, 5499.4225606310765, 5681.0, 5687.3459552152035, 5691.345495268097, 5695.515881150149, 5433.130699088127, 5492.4507549246355, 5514.503694667499, 5517.917231241615, 5517.944820551743, 5509.696966666712, 5510.8071217507195, 5512.91730624049, 5513.972430137824, 5529.778808847601, 5407.486288802557, 5409.161579955114, 5410.756515956713, 5411.323584551931, 5413.7834486620095, 5410.567154627699, 5552.5557955362665, 5562.249096371938, 5564.081926482247, 5568.136938774496, 5327.547158491417, 5351.785928562969, 5357.249985002025, 5359.571234301325, 5360.142377219626], "unit": "score", "name": "prototype.html", "value": 4124.6865229652985}, {"lowerIsBetter": false, "replicates": [689.4794430205194, 691.2914262880545, 698.1447726534992, 715.3311653603881, 737.443230361078, 11329.660110196697, 11430.485628146722, 11447.771044579114, 11937.283762974228, 12153.149279550435, 13047.543335983242, 13201.141925774818, 13214.141080829739, 13234.272115033693, 13247.735045299112, 609.6646844235675, 778.5212094561846, 786.1666633368619, 793.9007624046994, 794.3565711773454, 798.8881556582083, 801.2588355770918, 803.6905791270344, 807.3137832842096, 807.8222790985974, 837.6063250272363, 841.8989721233461, 842.5913431985482, 842.7429633961639, 843.6288033265374, 638.0970926139507, 821.1870248453988, 833.212614079695, 837.5602808525542, 840.1178762299561, 613.9539534534883, 616.8797084568511, 617.3178637605427, 617.6479406738162, 617.7776000639766, 12445.315507647076, 12451.128421010442, 12483.251004939642, 12488.313142777144, 12494.562690305887, 11088.944555277172, 11819.409029548575, 11896.464659090361, 11951.282923024559, 12063.0, 9709.854352184722, 9755.227076703424, 9780.608775648965, 9914.652987145415, 9990.0, 3209.149575362531, 3274.5415641810164, 3283.0807373935336, 3284.375968565989, 3296.5549650797075, 41381.0, 41612.58387416117, 41879.581204187874, 42053.78973105115, 42136.157276854596, 8966.730998070068, 9024.36829421934, 9077.77305567366, 9108.908910910806, 9375.10936461035, 16165.434209802836, 16197.0, 16213.35146594123, 16306.184690765414, 16411.42560010394, 5912.290525137011, 6004.42957918997, 6430.935690643034, 6662.300458451793, 6711.0, 3277.5903012123485, 3337.1156643489494, 3457.187560923181, 3570.285942811448, 3645.8359373828243, 2819.887204511838, 2839.730225628562, 2842.4315136972687, 2845.743883050494, 2850.7006764289868, 486.0667518364748, 491.5846110037013, 503.7934446876763, 505.2396143803626, 511.4042140905803, 575.2808988764045, 593.5340757505337, 600.0309500157215, 605.2434456928839, 614.7878981751288, 7580.848383032308, 7836.0, 7866.881996770053, 7942.166072562413, 7969.880451793228, 544.335910189568, 563.3015061323929, 569.860384205864, 576.1933293389288, 596.5257620191958, 3597.604263531062, 3600.6579374959338, 3616.638336166415, 3626.3472574936764, 3648.21563363878, 46476.5352346479, 46684.76657616758, 46688.766556167, 46710.53289467062, 47135.764321178176, 42062.0, 43002.35496467556, 43260.3510947336, 43719.56280437155, 43889.78055109704, 38247.80876095602, 39282.41076383857, 39855.80072099621, 40022.39966400506, 40045.79977100096, 6528.967355163194, 6530.771423000172, 6542.953127499768, 6567.671616419256, 6643.933560664332, 30146.84926575353, 30640.693593063785, 31093.378132437676, 31624.209394765316, 31791.364172715952, 35638.64361356353, 36402.635973639924, 36470.088247792955, 38146.0, 39047.609523905536, 8921.776955576162, 8965.417247878868, 9013.63945442175, 9022.503762293138, 9097.863532047157, 9784.28043543405, 9909.30634855582, 10009.199264058712, 10031.598736050768, 10035.949820250851, 9151.0, 9170.95414522923, 9360.15758581731, 9367.906320936703, 9372.859407108763, 8361.790955226168, 9299.256059515357, 9300.767480813034, 9333.300002499975, 9659.517024148905, 8881.200691937756, 8896.377253592187, 8978.281737461119, 9020.81958360816, 9080.318976076689, 7752.26353496417, 7810.140884502586, 7831.412644051605, 7848.450608457581, 7888.290053895177, 7586.468947173645, 7618.276263754934, 7768.84462310762, 7986.440949133505, 8018.0], "unit": "score", "name": "yui.html", "value": 5546.005068877862}], "name": "dromaeo_css", "value": 6085.6429539879455}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 107.0, 113.0, 114.0, 114.0, 103.0, 114.0, 115.0, 114.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [156.0, 132.0, 158.0, 170.0, 135.0, 158.0, 151.0, 141.0, 178.0, 142.0], "unit": "score", "name": "audio-beat-detection", "value": 152.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 162.0, 167.0, 160.0, 164.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [78.0, 77.0, 102.0, 95.0, 75.0, 74.0, 74.0, 95.0, 91.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.3}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 138.0, 95.0, 95.0, 95.0, 149.0, 95.0, 95.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 148.0, 146.0, 147.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 75.0, 63.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 65.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 70.0, 70.0, 69.0, 70.0, 71.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 84.0, 83.0, 82.0, 90.0, 84.0, 85.0, 88.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [125.0, 127.0, 120.0, 119.0, 122.0, 121.0, 126.0, 121.0, 119.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.8}, {"lowerIsBetter": true, "replicates": [149.0, 139.0, 163.0, 148.0, 157.0, 137.0, 161.0, 141.0, 141.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 69.0, 69.0, 70.0, 68.0, 71.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1537.3999999999999}]} 16:27:35 INFO - Return code: 0 16:27:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:27:35 ERROR - # TBPL SUCCESS # 16:27:35 INFO - Running post-action listener: _resource_record_post_action 16:27:35 INFO - Running post-run listener: _resource_record_post_run 16:27:36 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 523808768; Read time: 12; Write time: 1266544 16:27:36 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 233795584; Read time: 0; Write time: 776148 16:27:36 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286068736; Read time: 12; Write time: 489452 16:27:36 INFO - Running post-run listener: _upload_blobber_files 16:27:36 INFO - Blob upload gear active. 16:27:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:27:36 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 16:27:36 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'] 16:27:36 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 16:27:37 INFO - (blobuploader) - INFO - Open directory for files ... 16:27:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:27:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:27:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:38 INFO - (blobuploader) - INFO - Done attempting. 16:27:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:27:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:27:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:38 INFO - (blobuploader) - INFO - Done attempting. 16:27:38 INFO - (blobuploader) - INFO - Iteration through files over. 16:27:38 INFO - Return code: 0 16:27:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:27:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:27:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d87cdd4f10b7c34715625dd57c628170ab17bea7594075c5448e8a5d7fc2e5e2bf14b9e0706b956ef9081e6af8fe2ac6d2a4459bd899c8e10c314a3b4b119eca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bec098ffe17c771a15c598f8cd551e5c848c0928a7e34293fc2b59725c5adab90515404ca681334e56b42a91f185c25f4de201baf9b16d05d49c571712481093"} 16:27:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:27:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:27:38 INFO - Contents: 16:27:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d87cdd4f10b7c34715625dd57c628170ab17bea7594075c5448e8a5d7fc2e5e2bf14b9e0706b956ef9081e6af8fe2ac6d2a4459bd899c8e10c314a3b4b119eca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bec098ffe17c771a15c598f8cd551e5c848c0928a7e34293fc2b59725c5adab90515404ca681334e56b42a91f185c25f4de201baf9b16d05d49c571712481093"} 16:27:38 INFO - Running post-run listener: copy_logs_to_upload_dir 16:27:38 INFO - Copying logs to upload dir... 16:27:38 INFO - mkdir: /builds/slave/test/build/upload/logs 16:27:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.459326 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-03-10 16:27:38.859368) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 16:27:38.863412) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d87cdd4f10b7c34715625dd57c628170ab17bea7594075c5448e8a5d7fc2e5e2bf14b9e0706b956ef9081e6af8fe2ac6d2a4459bd899c8e10c314a3b4b119eca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bec098ffe17c771a15c598f8cd551e5c848c0928a7e34293fc2b59725c5adab90515404ca681334e56b42a91f185c25f4de201baf9b16d05d49c571712481093"} build_url:https://queue.taskcluster.net/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011530 build_url: 'https://queue.taskcluster.net/v1/task/JjyZiweBQceWDS4rn4y4cg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d87cdd4f10b7c34715625dd57c628170ab17bea7594075c5448e8a5d7fc2e5e2bf14b9e0706b956ef9081e6af8fe2ac6d2a4459bd899c8e10c314a3b4b119eca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bec098ffe17c771a15c598f8cd551e5c848c0928a7e34293fc2b59725c5adab90515404ca681334e56b42a91f185c25f4de201baf9b16d05d49c571712481093"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 16:27:38.889630) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 16:27:38.890016) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457654772.445159-117379441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 16:27:38.974076) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 16:27:38.974428) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 16:27:38.974755) ========= ========= Total master_lag: 0.29 =========