builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1458341465.0 results: success (0) buildid: 20160318150839 builduid: 6f3bc82d6a7b4bc3a3528c69164fed69 revision: 37cf1aab905f16960dd88b015057f6cd9dd02991 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:05.001849) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:05.002274) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:05.002554) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006377 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:05.027283) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:05.027556) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:05.082113) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:05.082396) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004716 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:05.198843) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:05.199102) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:05.199441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:05.199706) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-18 15:51:05-- 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% 227M=0s 2016-03-18 15:51:05 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177746 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:05.394888) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:05.395162) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014602 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:05.481220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 15:51:05.481542) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 37cf1aab905f16960dd88b015057f6cd9dd02991 --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 37cf1aab905f16960dd88b015057f6cd9dd02991 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-18 15:51:05,483 truncating revision to first 12 chars 2016-03-18 15:51:05,483 Setting DEBUG logging. 2016-03-18 15:51:05,484 attempt 1/10 2016-03-18 15:51:05,484 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/37cf1aab905f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 15:51:06,670 unpacking tar archive at: fx-team-37cf1aab905f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.489173 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 15:51:07.109934) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:07.113317) ========= echo 37cf1aab905f16960dd88b015057f6cd9dd02991 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'37cf1aab905f16960dd88b015057f6cd9dd02991'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 37cf1aab905f16960dd88b015057f6cd9dd02991 program finished with exit code 0 elapsedTime=0.004776 script_repo_revision: '37cf1aab905f16960dd88b015057f6cd9dd02991' ========= master_lag: 0.07 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:07.184996) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:07.185303) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 15:51:07.485725) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-03-18 15:51:07.486009) ========= /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=8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:51:07 INFO - MultiFileLogger online at 20160318 15:51:07 in /builds/slave/test 15:51:07 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 15:51:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:51:07 INFO - {'append_to_log': False, 15:51:07 INFO - 'base_work_dir': '/builds/slave/test', 15:51:07 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:51:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:51:07 INFO - 'branch': 'Fx-Team-Non-PGO', 15:51:07 INFO - 'buildbot_json_path': 'buildprops.json', 15:51:07 INFO - 'config_files': ('talos/linux_config.py',), 15:51:07 INFO - 'default_actions': ('clobber', 15:51:07 INFO - 'read-buildbot-config', 15:51:07 INFO - 'download-and-extract', 15:51:07 INFO - 'populate-webroot', 15:51:07 INFO - 'create-virtualenv', 15:51:07 INFO - 'install', 15:51:07 INFO - 'run-tests'), 15:51:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:51:07 INFO - 'download_minidump_stackwalk': True, 15:51:07 INFO - 'download_symbols': 'ondemand', 15:51:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:51:07 INFO - 'tooltool.py': '/tools/tooltool.py', 15:51:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:51:07 INFO - '/tools/misc-python/virtualenv.py')}, 15:51:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:51:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:51:07 INFO - 'installer_path': 'installer.exe', 15:51:07 INFO - 'log_level': 'info', 15:51:07 INFO - 'log_name': 'talos', 15:51:07 INFO - 'log_to_console': True, 15:51:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:51:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:51:07 INFO - 'opt_config_files': (), 15:51:07 INFO - 'pip_index': False, 15:51:07 INFO - 'sps_profile': False, 15:51:07 INFO - 'sps_profile_interval': 0, 15:51:07 INFO - 'suite': 'dromaeojs', 15:51:07 INFO - 'system_bits': '32', 15:51:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:51:07 INFO - 'title': 'talos-linux64-ix-038', 15:51:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:51:07 INFO - 'use_talos_json': True, 15:51:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:51:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:51:07 INFO - 'work_dir': 'build'} 15:51:07 INFO - ##### 15:51:07 INFO - ##### Running clobber step. 15:51:07 INFO - ##### 15:51:07 INFO - Running pre-action listener: _resource_record_pre_action 15:51:07 INFO - Running main action method: clobber 15:51:07 INFO - rmtree: /builds/slave/test/build 15:51:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:51:08 INFO - Running post-action listener: _resource_record_post_action 15:51:08 INFO - ##### 15:51:08 INFO - ##### Running read-buildbot-config step. 15:51:08 INFO - ##### 15:51:08 INFO - Running pre-action listener: _resource_record_pre_action 15:51:08 INFO - Running main action method: read_buildbot_config 15:51:08 INFO - Using buildbot properties: 15:51:08 INFO - { 15:51:08 INFO - "project": "", 15:51:08 INFO - "product": "firefox", 15:51:08 INFO - "script_repo_revision": "production", 15:51:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:51:08 INFO - "repository": "", 15:51:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:51:08 INFO - "buildid": "20160318150839", 15:51:08 INFO - "pgo_build": "False", 15:51:08 INFO - "basedir": "/builds/slave/test", 15:51:08 INFO - "buildnumber": 1556, 15:51:08 INFO - "slavename": "talos-linux64-ix-038", 15:51:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:51:08 INFO - "platform": "ubuntu64_hw", 15:51:08 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:51:08 INFO - "branch": "fx-team", 15:51:08 INFO - "repo_path": "integration/fx-team", 15:51:08 INFO - "revision": "37cf1aab905f16960dd88b015057f6cd9dd02991", 15:51:08 INFO - "stage_platform": "linux64", 15:51:08 INFO - "builduid": "6f3bc82d6a7b4bc3a3528c69164fed69", 15:51:08 INFO - "slavebuilddir": "test" 15:51:08 INFO - } 15:51:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:51:08 INFO - Running post-action listener: _resource_record_post_action 15:51:08 INFO - ##### 15:51:08 INFO - ##### Running download-and-extract step. 15:51:08 INFO - ##### 15:51:08 INFO - Running pre-action listener: _resource_record_pre_action 15:51:08 INFO - Running main action method: download_and_extract 15:51:08 INFO - mkdir: /builds/slave/test/build/tests 15:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:08 INFO - https://queue.taskcluster.net/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:51:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:51:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:51:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/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 15:51:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/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 15:51:12 INFO - Downloaded 1361 bytes. 15:51:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:51:12 INFO - Using the following test package requirements: 15:51:12 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:51:12 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:51:12 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:51:12 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:12 INFO - u'jsshell-linux-x86_64.zip'], 15:51:12 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:51:12 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:51:12 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:51:12 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:51:12 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:51:12 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:51:12 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:51:12 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:51: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')]} 15:51:12 INFO - https://queue.taskcluster.net/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:51:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:51:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:51:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/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 15:51:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/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 15:51:14 INFO - Downloaded 22009824 bytes. 15:51:14 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'] 15:51:14 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 15:51:15 INFO - Return code: 0 15:51:15 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 15:51:15 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')]} 15:51:15 INFO - https://queue.taskcluster.net/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:51:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:51:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:51:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/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 15:51:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/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 15:51:16 INFO - Downloaded 22009824 bytes. 15:51:16 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'] 15:51:16 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 15:51:18 INFO - Return code: 0 15:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:18 INFO - https://queue.taskcluster.net/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:51:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:51:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:51:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/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 15:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/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 15:51:19 INFO - Downloaded 10846565 bytes. 15:51:19 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'] 15:51:19 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 15:51:19 INFO - Return code: 0 15:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:19 INFO - https://queue.taskcluster.net/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:51:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:51:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:51:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/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 15:51:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NHPa8PvqQf-gDE37jmcYvg/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 15:51:21 INFO - Downloaded 54148159 bytes. 15:51:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:51:21 INFO - mkdir: /builds/slave/test/properties 15:51:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:21 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:21 INFO - Contents: 15:51:21 INFO - build_url:https://queue.taskcluster.net/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:51:21 INFO - Running post-action listener: _resource_record_post_action 15:51:21 INFO - Running post-action listener: set_extra_try_arguments 15:51:21 INFO - ##### 15:51:21 INFO - ##### Running populate-webroot step. 15:51:21 INFO - ##### 15:51:21 INFO - Running pre-action listener: _resource_record_pre_action 15:51:21 INFO - Running main action method: populate_webroot 15:51:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:21 INFO - '--tppagecycles', 15:51:21 INFO - '7'], 15:51:21 INFO - 'tests': ['tsvgm']}}, 15:51:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:51:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:51:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:51:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:51:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:21 INFO - 'talos_options': ['--e10s'], 15:51:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:21 INFO - 'tests': ['damp', 'tps']}, 15:51:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:21 INFO - 'talos_options': ['--e10s'], 15:51:21 INFO - 'tests': ['damp', 'tps']}, 15:51:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:51:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:21 INFO - 'other': {'tests': ['a11yr', 15:51:21 INFO - 'ts_paint', 15:51:21 INFO - 'tpaint', 15:51:21 INFO - 'sessionrestore', 15:51:21 INFO - 'sessionrestore_no_auto_restore', 15:51:21 INFO - 'tabpaint']}, 15:51:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:51:21 INFO - 'tests': ['a11yr', 15:51:21 INFO - 'ts_paint', 15:51:21 INFO - 'tpaint', 15:51:21 INFO - 'sessionrestore', 15:51:21 INFO - 'sessionrestore_no_auto_restore', 15:51:21 INFO - 'tabpaint']}, 15:51:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:51:21 INFO - 'tests': ['a11yr', 15:51:21 INFO - 'ts_paint', 15:51:21 INFO - 'tpaint', 15:51:21 INFO - 'sessionrestore', 15:51:21 INFO - 'sessionrestore_no_auto_restore', 15:51:21 INFO - 'tabpaint']}, 15:51:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:51:21 INFO - 'tests': ['a11yr', 15:51:21 INFO - 'ts_paint', 15:51:21 INFO - 'tpaint', 15:51:21 INFO - 'sessionrestore', 15:51:21 INFO - 'sessionrestore_no_auto_restore', 15:51:21 INFO - 'tabpaint']}, 15:51:21 INFO - 'other_l64': {'tests': ['a11yr', 15:51:21 INFO - 'ts_paint', 15:51:21 INFO - 'tpaint', 15:51:21 INFO - 'sessionrestore', 15:51:21 INFO - 'sessionrestore_no_auto_restore', 15:51:21 INFO - 'tabpaint']}, 15:51:21 INFO - 'other_nol64': {'tests': ['a11yr', 15:51:21 INFO - 'ts_paint', 15:51:21 INFO - 'tpaint', 15:51:21 INFO - 'sessionrestore', 15:51:21 INFO - 'sessionrestore_no_auto_restore', 15:51:21 INFO - 'tabpaint']}, 15:51:21 INFO - 'svgr': {'tests': ['tsvgx', 15:51:21 INFO - 'tsvgr_opacity', 15:51:21 INFO - 'tart', 15:51:21 INFO - 'tscrollx', 15:51:21 INFO - 'cart']}, 15:51:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:51:21 INFO - 'tests': ['tsvgx', 15:51:21 INFO - 'tsvgr_opacity', 15:51:21 INFO - 'tart', 15:51:21 INFO - 'tscrollx', 15:51:21 INFO - 'cart']}, 15:51:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:21 INFO - 'tests': ['tp5o']}, 15:51:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:21 INFO - 'talos_options': ['--e10s'], 15:51:21 INFO - 'tests': ['tp5o']}, 15:51:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:21 INFO - 'talos_options': ['--xperf_path', 15:51:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:21 INFO - 'tests': ['tp5n']}, 15:51:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:21 INFO - 'talos_options': ['--e10s', 15:51:21 INFO - '--xperf_path', 15:51:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:21 INFO - 'tests': ['tp5n']}}, 15:51:21 INFO - 'talos.zip': {'path': '', 15:51:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:21 INFO - Running post-action listener: _resource_record_post_action 15:51:21 INFO - ##### 15:51:21 INFO - ##### Running create-virtualenv step. 15:51:21 INFO - ##### 15:51:21 INFO - Running pre-action listener: _resource_record_pre_action 15:51:21 INFO - Running main action method: create_virtualenv 15:51:21 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:21 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 15:51:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:22 INFO - Using real prefix '/usr' 15:51:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:22 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:24 INFO - Installing pip.................done. 15:51:24 INFO - Return code: 0 15:51:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbd7998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aae5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d410>, '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 0x1b3e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', '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 15:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:51:24 INFO - Using env: {'DISPLAY': ':0', 15:51:24 INFO - 'HOME': '/home/cltbld', 15:51:24 INFO - 'LANG': 'en_US.UTF-8', 15:51:24 INFO - 'LANGUAGE': 'en_US:en', 15:51:24 INFO - 'LOGNAME': 'cltbld', 15:51:24 INFO - 'MAIL': '/var/mail/cltbld', 15:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:24 INFO - 'MOZ_NO_REMOTE': '1', 15:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:24 INFO - 'NO_EM_RESTART': '1', 15:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:24 INFO - 'PWD': '/builds/slave/test', 15:51:24 INFO - 'SHELL': '/bin/bash', 15:51:24 INFO - 'SHLVL': '1', 15:51:24 INFO - 'TERM': 'linux', 15:51:24 INFO - 'TMOUT': '86400', 15:51:24 INFO - 'USER': 'cltbld', 15:51:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', 15:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:24 INFO - '_': '/tools/buildbot/bin/python'} 15:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:24 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 15:51:24 INFO - Cleaning up... 15:51:24 INFO - Return code: 0 15:51:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbbd7998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aae5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d410>, '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 0x1b3e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', '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 15:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:51:24 INFO - Using env: {'DISPLAY': ':0', 15:51:24 INFO - 'HOME': '/home/cltbld', 15:51:24 INFO - 'LANG': 'en_US.UTF-8', 15:51:24 INFO - 'LANGUAGE': 'en_US:en', 15:51:24 INFO - 'LOGNAME': 'cltbld', 15:51:24 INFO - 'MAIL': '/var/mail/cltbld', 15:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:24 INFO - 'MOZ_NO_REMOTE': '1', 15:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:24 INFO - 'NO_EM_RESTART': '1', 15:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:24 INFO - 'PWD': '/builds/slave/test', 15:51:24 INFO - 'SHELL': '/bin/bash', 15:51:24 INFO - 'SHLVL': '1', 15:51:24 INFO - 'TERM': 'linux', 15:51:24 INFO - 'TMOUT': '86400', 15:51:24 INFO - 'USER': 'cltbld', 15:51:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', 15:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:24 INFO - '_': '/tools/buildbot/bin/python'} 15:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:25 INFO - Downloading/unpacking psutil>=0.7.1 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:26 INFO - Installing collected packages: psutil 15:51:26 INFO - Running setup.py install for psutil 15:51:27 INFO - building 'psutil._psutil_linux' extension 15:51:27 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 15:51:27 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 15:51:27 INFO - building 'psutil._psutil_posix' extension 15:51:27 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 15:51:27 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 15:51:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:29 INFO - Successfully installed psutil 15:51:29 INFO - Cleaning up... 15:51:29 INFO - Return code: 0 15:51:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:29 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 0x7fbbd7998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aae5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d410>, '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 0x1b3e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', '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 15:51:29 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 15:51:29 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 15:51:29 INFO - Using env: {'DISPLAY': ':0', 15:51:29 INFO - 'HOME': '/home/cltbld', 15:51:29 INFO - 'LANG': 'en_US.UTF-8', 15:51:29 INFO - 'LANGUAGE': 'en_US:en', 15:51:29 INFO - 'LOGNAME': 'cltbld', 15:51:29 INFO - 'MAIL': '/var/mail/cltbld', 15:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:29 INFO - 'MOZ_NO_REMOTE': '1', 15:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:29 INFO - 'NO_EM_RESTART': '1', 15:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:29 INFO - 'PWD': '/builds/slave/test', 15:51:29 INFO - 'SHELL': '/bin/bash', 15:51:29 INFO - 'SHLVL': '1', 15:51:29 INFO - 'TERM': 'linux', 15:51:29 INFO - 'TMOUT': '86400', 15:51:29 INFO - 'USER': 'cltbld', 15:51:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', 15:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:29 INFO - '_': '/tools/buildbot/bin/python'} 15:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:51:31 INFO - Installing collected packages: mozsystemmonitor 15:51:31 INFO - Running setup.py install for mozsystemmonitor 15:51:31 INFO - Successfully installed mozsystemmonitor 15:51:31 INFO - Cleaning up... 15:51:31 INFO - Return code: 0 15:51:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:51:31 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')]} 15:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:31 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')]} 15:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:31 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 0x7fbbd7998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aae5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d410>, '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 0x1b3e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', '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 15:51:31 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 15:51:31 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 15:51:31 INFO - Using env: {'DISPLAY': ':0', 15:51:31 INFO - 'HOME': '/home/cltbld', 15:51:31 INFO - 'LANG': 'en_US.UTF-8', 15:51:31 INFO - 'LANGUAGE': 'en_US:en', 15:51:31 INFO - 'LOGNAME': 'cltbld', 15:51:31 INFO - 'MAIL': '/var/mail/cltbld', 15:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:31 INFO - 'MOZ_NO_REMOTE': '1', 15:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:31 INFO - 'NO_EM_RESTART': '1', 15:51:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:31 INFO - 'PWD': '/builds/slave/test', 15:51:31 INFO - 'SHELL': '/bin/bash', 15:51:31 INFO - 'SHLVL': '1', 15:51:31 INFO - 'TERM': 'linux', 15:51:31 INFO - 'TMOUT': '86400', 15:51:31 INFO - 'USER': 'cltbld', 15:51:31 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', 15:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:31 INFO - '_': '/tools/buildbot/bin/python'} 15:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:31 INFO - Downloading/unpacking blobuploader==1.2.4 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 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 15:51:31 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 15:51:33 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51:33 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 15:51:33 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 15:51:33 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 15:51:33 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 15:51:33 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 15:51:33 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 15:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:51:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51:34 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 15:51:34 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 15:51:34 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 15:51:34 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 15:51:34 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 15:51:34 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 15:51:34 INFO - Downloading docopt-0.6.1.tar.gz 15:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:34 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:34 INFO - Running setup.py install for blobuploader 15:51:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:51:34 INFO - Running setup.py install for requests 15:51:34 INFO - Running setup.py install for docopt 15:51:35 INFO - Successfully installed blobuploader requests docopt 15:51:35 INFO - Cleaning up... 15:51:35 INFO - Return code: 0 15:51:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:35 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 0x7fbbd7998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aae5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d410>, '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 0x1b3e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', '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 15:51:35 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 15:51:35 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 15:51:35 INFO - Using env: {'DISPLAY': ':0', 15:51:35 INFO - 'HOME': '/home/cltbld', 15:51:35 INFO - 'LANG': 'en_US.UTF-8', 15:51:35 INFO - 'LANGUAGE': 'en_US:en', 15:51:35 INFO - 'LOGNAME': 'cltbld', 15:51:35 INFO - 'MAIL': '/var/mail/cltbld', 15:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:35 INFO - 'MOZ_NO_REMOTE': '1', 15:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:35 INFO - 'NO_EM_RESTART': '1', 15:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:35 INFO - 'PWD': '/builds/slave/test', 15:51:35 INFO - 'SHELL': '/bin/bash', 15:51:35 INFO - 'SHLVL': '1', 15:51:35 INFO - 'TERM': 'linux', 15:51:35 INFO - 'TMOUT': '86400', 15:51:35 INFO - 'USER': 'cltbld', 15:51:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', 15:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:35 INFO - '_': '/tools/buildbot/bin/python'} 15:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:35 INFO - Running setup.py (path:/tmp/pip-X3TCSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:35 INFO - Running setup.py (path:/tmp/pip-bIHlc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:35 INFO - Running setup.py (path:/tmp/pip-p8kXeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:35 INFO - Running setup.py (path:/tmp/pip-HOURXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:35 INFO - Running setup.py (path:/tmp/pip-OnGoNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:35 INFO - Running setup.py (path:/tmp/pip-_rrvod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:35 INFO - Running setup.py (path:/tmp/pip-KalOY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:35 INFO - Running setup.py (path:/tmp/pip-HlHfL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:35 INFO - Running setup.py (path:/tmp/pip-UBUEoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:36 INFO - Running setup.py (path:/tmp/pip-EsqY0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:36 INFO - Running setup.py (path:/tmp/pip-q5c1Je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:36 INFO - Running setup.py (path:/tmp/pip-TSBriH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:36 INFO - Running setup.py (path:/tmp/pip-Xu45m4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:36 INFO - Running setup.py (path:/tmp/pip-nLoTP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:36 INFO - Running setup.py (path:/tmp/pip-UKDMd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:36 INFO - Running setup.py (path:/tmp/pip-0AMVzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:36 INFO - Running setup.py (path:/tmp/pip-6_SFoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:36 INFO - Running setup.py install for manifestparser 15:51:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:36 INFO - Running setup.py install for mozcrash 15:51:36 INFO - Running setup.py install for mozdebug 15:51:36 INFO - Running setup.py install for mozdevice 15:51:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:51:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:36 INFO - Running setup.py install for mozfile 15:51:37 INFO - Running setup.py install for mozhttpd 15:51:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:37 INFO - Running setup.py install for mozinfo 15:51:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:37 INFO - Running setup.py install for mozInstall 15:51:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:37 INFO - Running setup.py install for mozleak 15:51:37 INFO - Running setup.py install for mozlog 15:51:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:37 INFO - Running setup.py install for moznetwork 15:51:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:37 INFO - Running setup.py install for mozprocess 15:51:37 INFO - Running setup.py install for mozprofile 15:51:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:37 INFO - Running setup.py install for mozrunner 15:51:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:38 INFO - Running setup.py install for mozscreenshot 15:51:38 INFO - Running setup.py install for moztest 15:51:38 INFO - Running setup.py install for mozversion 15:51:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:38 INFO - Cleaning up... 15:51:38 INFO - Return code: 0 15:51:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:38 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')]} 15:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:38 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')]} 15:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:38 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 0x7fbbd7998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aae5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d410>, '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 0x1b3e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', '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 15:51:38 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 15:51:38 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 15:51:38 INFO - Using env: {'DISPLAY': ':0', 15:51:38 INFO - 'HOME': '/home/cltbld', 15:51:38 INFO - 'LANG': 'en_US.UTF-8', 15:51:38 INFO - 'LANGUAGE': 'en_US:en', 15:51:38 INFO - 'LOGNAME': 'cltbld', 15:51:38 INFO - 'MAIL': '/var/mail/cltbld', 15:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:38 INFO - 'MOZ_NO_REMOTE': '1', 15:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:38 INFO - 'NO_EM_RESTART': '1', 15:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:38 INFO - 'PWD': '/builds/slave/test', 15:51:38 INFO - 'SHELL': '/bin/bash', 15:51:38 INFO - 'SHLVL': '1', 15:51:38 INFO - 'TERM': 'linux', 15:51:38 INFO - 'TMOUT': '86400', 15:51:38 INFO - 'USER': 'cltbld', 15:51:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', 15:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:38 INFO - '_': '/tools/buildbot/bin/python'} 15:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:38 INFO - Running setup.py (path:/tmp/pip-KCtOVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:38 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)) 15:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:38 INFO - Running setup.py (path:/tmp/pip-liqiTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:38 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)) 15:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:38 INFO - Running setup.py (path:/tmp/pip-Q7sg6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:38 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)) 15:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:38 INFO - Running setup.py (path:/tmp/pip-xI7wP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:38 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)) 15:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:38 INFO - Running setup.py (path:/tmp/pip-ic0KoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:38 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)) 15:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:38 INFO - Running setup.py (path:/tmp/pip-RcjIno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:39 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)) 15:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:39 INFO - Running setup.py (path:/tmp/pip-gE4u7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:39 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)) 15:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:39 INFO - Running setup.py (path:/tmp/pip-YiwDEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:39 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)) 15:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:39 INFO - Running setup.py (path:/tmp/pip-E4YTpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:39 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)) 15:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:39 INFO - Running setup.py (path:/tmp/pip-Gdo9bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:39 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)) 15:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:39 INFO - Running setup.py (path:/tmp/pip-zBAC8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:39 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)) 15:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:39 INFO - Running setup.py (path:/tmp/pip-NaGpwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:39 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)) 15:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:39 INFO - Running setup.py (path:/tmp/pip-xkdJOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:39 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)) 15:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:39 INFO - Running setup.py (path:/tmp/pip-ye5m0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:39 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)) 15:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:39 INFO - Running setup.py (path:/tmp/pip-OxKkZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:39 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)) 15:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:39 INFO - Running setup.py (path:/tmp/pip-tCe8kW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:39 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)) 15:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:39 INFO - Running setup.py (path:/tmp/pip-ws07kK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:39 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)) 15:51:39 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)) 15:51:39 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)) 15:51:39 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)) 15:51:39 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)) 15:51:39 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)) 15:51:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:41 INFO - Downloading blessings-1.6.tar.gz 15:51:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:41 INFO - Installing collected packages: blessings 15:51:41 INFO - Running setup.py install for blessings 15:51:41 INFO - Successfully installed blessings 15:51:41 INFO - Cleaning up... 15:51:41 INFO - Return code: 0 15:51:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:42 INFO - Reading from file tmpfile_stdout 15:51:42 INFO - Current package versions: 15:51:42 INFO - argparse == 1.2.1 15:51:42 INFO - blessings == 1.6 15:51:42 INFO - blobuploader == 1.2.4 15:51:42 INFO - docopt == 0.6.1 15:51:42 INFO - manifestparser == 1.1 15:51:42 INFO - mozInstall == 1.12 15:51:42 INFO - mozcrash == 0.17 15:51:42 INFO - mozdebug == 0.1 15:51:42 INFO - mozdevice == 0.48 15:51:42 INFO - mozfile == 1.2 15:51:42 INFO - mozhttpd == 0.7 15:51:42 INFO - mozinfo == 0.9 15:51:42 INFO - mozleak == 0.1 15:51:42 INFO - mozlog == 3.1 15:51:42 INFO - moznetwork == 0.27 15:51:42 INFO - mozprocess == 0.22 15:51:42 INFO - mozprofile == 0.28 15:51:42 INFO - mozrunner == 6.11 15:51:42 INFO - mozscreenshot == 0.1 15:51:42 INFO - mozsystemmonitor == 0.0 15:51:42 INFO - moztest == 0.7 15:51:42 INFO - mozversion == 1.4 15:51:42 INFO - psutil == 3.1.1 15:51:42 INFO - requests == 1.2.3 15:51:42 INFO - wsgiref == 0.1.2 15:51:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:42 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')]} 15:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:42 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')]} 15:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:42 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 0x7fbbd7998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aae5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d410>, '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 0x1b3e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', '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 15:51:42 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 15:51:42 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 15:51:42 INFO - Using env: {'DISPLAY': ':0', 15:51:42 INFO - 'HOME': '/home/cltbld', 15:51:42 INFO - 'LANG': 'en_US.UTF-8', 15:51:42 INFO - 'LANGUAGE': 'en_US:en', 15:51:42 INFO - 'LOGNAME': 'cltbld', 15:51:42 INFO - 'MAIL': '/var/mail/cltbld', 15:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:42 INFO - 'MOZ_NO_REMOTE': '1', 15:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:42 INFO - 'NO_EM_RESTART': '1', 15:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:42 INFO - 'PWD': '/builds/slave/test', 15:51:42 INFO - 'SHELL': '/bin/bash', 15:51:42 INFO - 'SHLVL': '1', 15:51:42 INFO - 'TERM': 'linux', 15:51:42 INFO - 'TMOUT': '86400', 15:51:42 INFO - 'USER': 'cltbld', 15:51:42 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', 15:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:42 INFO - '_': '/tools/buildbot/bin/python'} 15:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:42 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)) 15:51:42 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)) 15:51:42 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)) 15:51:42 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)) 15:51:42 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)) 15:51:42 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)) 15:51:42 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)) 15:51:42 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)) 15:51:42 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)) 15:51:42 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)) 15:51:42 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)) 15:51:42 INFO - Cleaning up... 15:51:42 INFO - Return code: 0 15:51:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:51:42 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')]} 15:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:42 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')]} 15:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:42 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 0x7fbbd7998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aae5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d410>, '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 0x1b3e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', '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 15:51:42 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 15:51:42 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 15:51:42 INFO - Using env: {'DISPLAY': ':0', 15:51:42 INFO - 'HOME': '/home/cltbld', 15:51:42 INFO - 'LANG': 'en_US.UTF-8', 15:51:42 INFO - 'LANGUAGE': 'en_US:en', 15:51:42 INFO - 'LOGNAME': 'cltbld', 15:51:42 INFO - 'MAIL': '/var/mail/cltbld', 15:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:42 INFO - 'MOZ_NO_REMOTE': '1', 15:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:42 INFO - 'NO_EM_RESTART': '1', 15:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:42 INFO - 'PWD': '/builds/slave/test', 15:51:42 INFO - 'SHELL': '/bin/bash', 15:51:42 INFO - 'SHLVL': '1', 15:51:42 INFO - 'TERM': 'linux', 15:51:42 INFO - 'TMOUT': '86400', 15:51:42 INFO - 'USER': 'cltbld', 15:51:42 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', 15:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:42 INFO - '_': '/tools/buildbot/bin/python'} 15:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:42 INFO - Downloading/unpacking jsonschema 15:51:42 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 15:51:42 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 15:51:42 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 15:51:42 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 15:51:42 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 15:51:42 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 15:51:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:51:44 INFO - Downloading/unpacking functools32 (from jsonschema) 15:51:44 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 15:51:44 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 15:51:44 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 15:51:44 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 15:51:44 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 15:51:44 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 15:51:44 INFO - Downloading functools32-3.2.3-2.tar.gz 15:51:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:51:44 INFO - warning: no files found matching '*.txt' 15:51:44 INFO - no previously-included directories found matching 'build' 15:51:44 INFO - no previously-included directories found matching 'dist' 15:51:44 INFO - no previously-included directories found matching '.git*' 15:51:44 INFO - Installing collected packages: jsonschema, functools32 15:51:44 INFO - Running setup.py install for functools32 15:51:44 INFO - warning: no files found matching '*.txt' 15:51:44 INFO - no previously-included directories found matching 'build' 15:51:44 INFO - no previously-included directories found matching 'dist' 15:51:44 INFO - no previously-included directories found matching '.git*' 15:51:44 INFO - Successfully installed jsonschema functools32 15:51:44 INFO - Cleaning up... 15:51:44 INFO - Return code: 0 15:51:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:44 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 0x7fbbd7998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aae5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3d410>, '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 0x1b3e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', '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 15:51:44 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 15:51:44 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 15:51:44 INFO - Using env: {'DISPLAY': ':0', 15:51:44 INFO - 'HOME': '/home/cltbld', 15:51:44 INFO - 'LANG': 'en_US.UTF-8', 15:51:44 INFO - 'LANGUAGE': 'en_US:en', 15:51:44 INFO - 'LOGNAME': 'cltbld', 15:51:44 INFO - 'MAIL': '/var/mail/cltbld', 15:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:44 INFO - 'MOZ_NO_REMOTE': '1', 15:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:44 INFO - 'NO_EM_RESTART': '1', 15:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:44 INFO - 'PWD': '/builds/slave/test', 15:51:44 INFO - 'SHELL': '/bin/bash', 15:51:44 INFO - 'SHLVL': '1', 15:51:44 INFO - 'TERM': 'linux', 15:51:44 INFO - 'TMOUT': '86400', 15:51:44 INFO - 'USER': 'cltbld', 15:51:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', 15:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:44 INFO - '_': '/tools/buildbot/bin/python'} 15:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:45 INFO - Downloading/unpacking flake8 15:51:45 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 15:51:45 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 15:51:45 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 15:51:45 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 15:51:45 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 15:51:45 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 15:51:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:51:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:51:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:51:47 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 15:51:47 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 15:51:47 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 15:51:47 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 15:51:47 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 15:51:47 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 15:51:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:51:47 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 15:51:47 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 15:51:47 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 15:51:47 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 15:51:47 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 15:51:47 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 15:51:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:47 INFO - no previously-included directories found matching 'docs/_build' 15:51:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:51:47 INFO - Running setup.py install for pep8 15:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:47 INFO - no previously-included directories found matching 'docs/_build' 15:51:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:51:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:51:47 INFO - Cleaning up... 15:51:47 INFO - Return code: 0 15:51:47 INFO - Running post-action listener: _resource_record_post_action 15:51:47 INFO - Running post-action listener: _start_resource_monitoring 15:51:47 INFO - Starting resource monitoring. 15:51:47 INFO - ##### 15:51:47 INFO - ##### Running install step. 15:51:47 INFO - ##### 15:51:47 INFO - Running pre-action listener: _resource_record_pre_action 15:51:47 INFO - Running main action method: install 15:51:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:48 INFO - Reading from file tmpfile_stdout 15:51:48 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:48 INFO - Reading from file tmpfile_stdout 15:51:48 INFO - Output received: 15:51:48 INFO - Usage: mozinstall [options] installer 15:51:48 INFO - Options: 15:51:48 INFO - -h, --help show this help message and exit 15:51:48 INFO - -d DEST, --destination=DEST 15:51:48 INFO - Directory to install application into. [default: 15:51:48 INFO - "/builds/slave/test"] 15:51:48 INFO - --app=APP Application being installed. [default: firefox] 15:51:48 INFO - mkdir: /builds/slave/test/build/application 15:51:48 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'] 15:51:48 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 15:52:03 INFO - Reading from file tmpfile_stdout 15:52:03 INFO - Output received: 15:52:03 INFO - /builds/slave/test/build/application/firefox/firefox 15:52:03 INFO - Running post-action listener: _resource_record_post_action 15:52:03 INFO - ##### 15:52:03 INFO - ##### Running run-tests step. 15:52:03 INFO - ##### 15:52:03 INFO - Running pre-action listener: _resource_record_pre_action 15:52:03 INFO - Running main action method: run_tests 15:52:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:52:03 INFO - Python 2.7.3 15:52:03 INFO - Return code: 0 15:52:03 INFO - grabbing minidump binary from tooltool 15:52: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')]} 15:52:03 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 0x1b3d410>, '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 0x1b3e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b3e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:52:03 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 15:52:03 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 15:52:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:52:03 INFO - Return code: 0 15:52:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:52:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:52:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:52:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:52:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:52:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:52:04 INFO - Return code: 0 15:52:04 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/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:52:04 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/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:52:04 INFO - Using env: {'DISPLAY': ':0', 15:52:04 INFO - 'HOME': '/home/cltbld', 15:52:04 INFO - 'LANG': 'en_US.UTF-8', 15:52:04 INFO - 'LANGUAGE': 'en_US:en', 15:52:04 INFO - 'LOGNAME': 'cltbld', 15:52:04 INFO - 'MAIL': '/var/mail/cltbld', 15:52:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:52:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:04 INFO - 'MOZ_NO_REMOTE': '1', 15:52:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:04 INFO - 'NO_EM_RESTART': '1', 15:52:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:04 INFO - 'PWD': '/builds/slave/test', 15:52:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:52:04 INFO - 'SHELL': '/bin/bash', 15:52:04 INFO - 'SHLVL': '1', 15:52:04 INFO - 'TERM': 'linux', 15:52:04 INFO - 'TMOUT': '86400', 15:52:04 INFO - 'USER': 'cltbld', 15:52:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423', 15:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:04 INFO - '_': '/tools/buildbot/bin/python'} 15:52:04 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/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:52:05 INFO - mozversion application_buildid: 20160318150839 15:52:05 INFO - mozversion application_changeset: 37cf1aab905f16960dd88b015057f6cd9dd02991 15:52:05 INFO - mozversion application_display_name: Nightly 15:52:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:52:05 INFO - mozversion application_name: Firefox 15:52:05 INFO - mozversion application_remotingname: firefox 15:52:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:52:05 INFO - mozversion application_vendor: Mozilla 15:52:05 INFO - mozversion application_version: 48.0a1 15:52:05 INFO - mozversion platform_buildid: 20160318150839 15:52:05 INFO - mozversion platform_changeset: 37cf1aab905f16960dd88b015057f6cd9dd02991 15:52:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:52:05 INFO - mozversion platform_version: 48.0a1 15:52:05 INFO - using testdate: 1458341525 15:52:05 INFO - actual date: 1458341525 15:52:05 INFO - starting webserver on 'localhost:44195' 15:52:05 INFO - SUITE-START | Running 2 tests 15:52:05 INFO - TEST-START | dromaeo_css 15:52:05 INFO - operating with platform_type : linux_ 15:52:05 INFO - Initialising browser for dromaeo_css test... 15:52:05 INFO - TEST-INFO | started process 3903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc3i3fC/profile http://localhost:44195/getInfo.html) 15:52:12 INFO - PROCESS | 3903 | __metrics Screen width/height:1600/1200 15:52:12 INFO - PROCESS | 3903 | colorDepth:24 15:52:12 INFO - PROCESS | 3903 | Browser inner width/height: 1024/697 15:52:12 INFO - PROCESS | 3903 | __metrics 15:52:13 ERROR - PROCESS | 3903 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:52:14 INFO - TEST-INFO | 3903: exit 0 15:52:14 INFO - Browser initialized. 15:52:14 INFO - Running cycle 1/1 for dromaeo_css test... 15:52:14 INFO - TEST-INFO | started process 3995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc3i3fC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:26 INFO - PROCESS | 3995 | RSS: Main: 154533888 15:52:26 INFO - PROCESS | 3995 | 15:53:17 INFO - PROCESS | 3995 | 1458341597263 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] 15:55:31 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:44195/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44195/tests/dromaeo/cssquery-ext.html) 15:55:32 INFO - PROCESS | 3995 | RSS: Main: 244879360 15:55:32 INFO - PROCESS | 3995 | 15:58:34 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:44195/tests/dromaeo/cssquery-ext.html (next: http://localhost:44195/tests/dromaeo/cssquery-jquery.html) 15:58:35 INFO - PROCESS | 3995 | RSS: Main: 235634688 15:58:35 INFO - PROCESS | 3995 | 16:01:36 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:44195/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44195/tests/dromaeo/cssquery-mootools.html) 16:01:37 INFO - PROCESS | 3995 | RSS: Main: 224948224 16:01:37 INFO - PROCESS | 3995 | 16:04:39 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:44195/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44195/tests/dromaeo/cssquery-prototype.html) 16:04:39 INFO - PROCESS | 3995 | RSS: Main: 210448384 16:04:39 INFO - PROCESS | 3995 | 16:07:42 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:44195/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44195/tests/dromaeo/cssquery-yui.html) 16:07:43 INFO - PROCESS | 3995 | RSS: Main: 204218368 16:07:43 INFO - PROCESS | 3995 | 16:10:45 INFO - PROCESS | 3995 | Cycle 1(1): loaded http://localhost:44195/tests/dromaeo/cssquery-yui.html (next: http://localhost:44195/tests/dromaeo/cssquery-dojo.html) 16:10:46 INFO - PROCESS | 3995 | RSS: Main: 266616832 16:10:46 INFO - PROCESS | 3995 | 16:10:46 INFO - PROCESS | 3995 | __start_tp_report 16:10:46 INFO - PROCESS | 3995 | _x_x_mozilla_page_load 16:10:46 INFO - PROCESS | 3995 | _x_x_mozilla_page_load_details 16:10:46 INFO - PROCESS | 3995 | |i|pagename|runs| 16:10:46 INFO - PROCESS | 3995 | |0;dojo.html;2591.2355855022774;2633.4996350693377;2635.3938594123338;2638.8416694998314;2684.5436275833117;4528.796204170812;4688.179568575499;4699.953000469995;4721.055788842236;4723.0317784854105;4782.713037217761;4783.234682450809;4785.18651829189;4810.4708482067035;4811.5910147637405;4356.716813407118;4366.4978527469275;4396.406485124515;4415.161119387322;4473.7986790594505;4190.161967606476;4309.806058727365;4366.8908277293;4370.147821174872;4395.142947125312;4368.868933931987;4375.12497500498;4388.166248412791;4414.05097903949;4422.292433210703;4360.520342762294;4366.19225443294;4388.092172889041;4400.889977750549;4443.555644435531;4261.041265715189;4294.914101717979;4319.460067491564;4357.019670574127;4375.912481750347;4643.16165801559;4646.86059418218;4648.209804333272;4656.278276867091;4703.7883295251795;5122.103631864409;5128.102582048126;5132.538071573539;5133.897322053575;5136;4994.750262486861;5164.6384753067305;5219.791208351661;5249.842504724865;5255.842324730264;4781.2111001685025;4786.210275304536;4797.064572408347;4797.5682188602495;4801.4718380978065;5163.457836927144;5259.263703081571;5262.92105618416;5268.552173065255;5310.336207974004;5003.099442100384;5020.49795020495;5039;5064.82273120439;5091.08360495107;5103.515166059218;5132;5132.666376685504;5133.974330128325;5184.0927837629015;5011.699298042129;5047.545720885065;5066.4680208577565;5092.872678183075;5097.0315640028275;5056.292119103328;5078.492150784892;5096.413912400121;5115.1559992600805;5151.356080489939;4388.034632380871;4399.912001759947;4421.469423669116;4442.044960333479;4461.353103799931;3734.2158146788934;3778.3576791944884;3820.560635526894;3823.4073718573663;3842.9615703843165;4364.738115713004;4365.170617582713;4379.277419225856;4389.604935555815;4406.691531592758;5112.923306150411;5114.105031619451;5114.718690471986;5120.1039818031695;5126.743662816844;4275.700700950903;4371.147626212922;4377.868663940087;4409.272470042407;4431.357453169337;4653.744044077608;4676.625869930397;4678.95321046792;4699.600533954652;4725.3384526166365;4838.903221935612;4842.22524396102;4846.854594362175;4848.442429120555;4895.265710143507;5035.320231768665;5121.359830021247;5128.692278463304;5170.922436163385;5209.973950130377;4739.289106634033;4740.549647783455;4760.857394225431;4787.736674482798;4793.32893394918;4959.9008019838675;4964.25536169563;4970;4989.775460104376;5015.548600625962;4993.925091123563;5008.874778130576;5033.546980771748;5041.117804384291;5067.239914012927;4985.825496107619;4992.051510213048;4996.200607902718;5003.099442100457;5042.84871453857;4974.751262436791;4974.776135073858;4977;4979.078870408841;4981.726005069756;4829.420469543677;4859.927101093415;4880.365552478155;4929.112759703145;4987.127252730685;4981.850544483671;4999.500049994971;5001.599872010303;5004.524570165829;5031.899362012812;4896.1921282987905;4900.926486102782;4901.5588597026435;4902.142125128017;4946.777395017161 16:10:46 INFO - PROCESS | 3995 | |1;ext.html;516.0556182186599;543.9836804895855;546.8851541176352;567.1124689860369;579.2007030298188;26793.732062679366;27273.863630681844;34547.13632159197;35043.12392190196;35107.29785404297;38116;38573.80713096438;38576.80711596438;38636.420453693216;38667;7358.6688599012905;7768.300852923236;7958.641861116234;7960.800979975518;9786.412815231073;9796.853047204298;9995.70012899614;9998.750031249205;10003.449810260432;10004.449755263495;9968.750781230454;10076.94961525195;10080.899191008106;10089.747756306115;10090.646827361044;9948.701538953843;10045.849312260321;10050.246231532592;10055.446950417723;10056.849147262797;9997.950010249975;10190.286679932407;10256.128229100535;10266.281360304782;10271.640492582725;36394;36731.26537469262;36758.816205918796;36776;36800.44799328012;3167.160702413862;3178.936421271562;3211.389835931189;3302.7192688621494;3629.491871138043;28276.29309267264;29717.257068573243;30306.84846575775;30369.392612147632;30417.391652167054;3542.4221536248315;3547.396942519778;3552.4316109422625;3576.5714143351906;3680.2823449427374;270919;274813;275149;275275;275717;53818.192727109126;54269.72865135649;54503.45496545063;54566.72716636471;54699;58110.709446453344;58391.70804146037;58439.70780146157;62425.37574624286;64682.17860392587;13167.53913613019;13248.337583120805;13261.336933153303;13296;13303.600891973256;8987.41581797181;10448.582056717647;10747.247692661595;10809.67570972872;10824.458777061116;19472.877811659167;20637.58724825495;20685.276015339692;20728.445366597567;20738.274160404315;7655.387568994467;7805.180456052033;7851.528908265523;7943.24539168778;7977.242161994601;886.3706768194526;902.566767951387;926.7173512078881;935.4854829843558;977.5503268496429;26615.600765988525;27514.587281190798;28088;28096.43807123846;28121.156365309074;963.5615794813343;975.4439969217478;1013.4729940430934;1046.5499835070993;1054.5676272728144;14096.859031409555;14529.927350363392;14545.599976003841;14781.187034713193;14842.628934276514;296437;301290;301454;302144;302201;46870.53129468662;47094.76452617715;47497.762511187226;47576.524234757904;47590.76204619024;1009.2783659683362;1114.5263263113145;1185.3302883870758;1213.3811756004502;1213.696575856036;23987.87637881375;27246.72753272442;27584;27816;27852.442951141267;36541.634583654886;36593.81703091467;36737.26525469422;36889.26221475609;37459.81270093632;165855;169715.1514242421;170178;170682;177135;28996.27509312284;30559;31306.373872522876;31911.68088319087;32059.839700801345;35548;35774.8211258942;36036.4594531077;36413.27173456463;36505.63494365022;32719.672803271664;32773.836130819196;33893.491597625565;34353;34615.653843461245;32950.67049329572;33323.500147497325;33428.49857252095;33484.49773253452;33806.32387352288;29893;30169.245768855955;30359.848200758854;30366;30374.54438183385;28328.85835570809;30424.84787576048;30722.846385767927;30771.384572308878;30883.84558077195;23623.64564531568;23989.880050599637;24159.75840241575;24240.272791816275;24362.390940226636 16:10:46 INFO - PROCESS | 3995 | |2;jquery.html;352.47129306040955;364.6663303077684;365.8884040367687;366.9101070237791;369.58790948092866;15576.45482408116;15590.688186236268;16129.677406451878;16170.514884553453;16179.271932763024;15190.392384304614;15348.386064557431;16329.428470003551;16353.509394718178;16354.427595034176;5040.042391945528;5175.922361164586;5181.896362072756;5239.21411788231;5468;4403.933940990888;4424.623906967911;4430.955690443103;4434.423524941769;4440.955590444087;4413.4262545869;4444.866654000385;4449.26587113126;4457.420535330402;4457.84397546086;4051.493563304572;4223.880671622007;4357.760323182224;5224.190250511177;5534.169874518814;5302.469753024705;5389.272448219479;5403.108487099624;5403.621746477748;5405.891882162335;17275.481735547954;18049.7292540612;19251;19251.90374048135;19259.903700481547;1989.631918095157;2008.126464987735;2027.7769445360998;2075.7094006839056;2171.576542574199;8957.104289571056;9560.713178604654;9593.184579310768;11699.824502632468;12799.168054076456;1783.4471313892734;1857.535616095976;1862.6181632765386;1879.7274395212617;1883.7268596053632;57974;60567;61754.691226544026;62187.37812621861;63141.36858631447;10180.185585153169;10269.332493387907;10499.790004199873;10514.158867290598;10578.735531611772;13225.537106201236;13292.534761283308;13306.800397994039;13314.201147931155;13318.800217996737;7016.2632923543315;7020.859582808417;7111.146662400545;7114.039604653305;7143.107111611049;6387.904181437282;6499.837504062341;6573.638449885302;6685.598864068172;6757.189137303555;4382.53983331752;4399.846005389796;4460.0633866887665;4489.708168969007;4497.235469970113;1737.574294297905;1793.237873903612;1812.6012277298973;1819.5905921167896;1830.9908450457663;827.7765003449035;869.5956380283072;877.2192748453881;913.8766266554063;930.8510638297976;14641.853581464049;15448;15687;15985.680286394207;16287;880.3529405886668;909.8544232922833;912.5938957164132;922.6217250927087;928.8885333759857;8883.156100170474;9226.90773092274;9264.67573634933;9288.535573221312;9384.343095983215;299459;305079;306576;374534;385185;62746.68626656837;66492;71489.6425517869;73846.26153738501;75415.62292188503;965.2953344058876;967.56943160293;984.4241118945497;999.93000489965;1002.3985608634761;11745.354005529436;13945.790813138014;14625.268736563343;14641.121532708072;15082.849171508584;21899.67150492712;29254.41491170122;33408;34523.82738086294;35035.47446788249;43573;44207.55792442035;44621.77689111534;45576;46180.769096154305;7059.82350441243;7287.781366559012;7416.0729908761405;7508.43686723487;7567.697292108254;8314.542700151549;10357;10855.565777368816;10983;11233.382163980732;5598.936202121584;6140.140380346666;9872.01279872007;9889.604415823287;10216.540255688364;9659.758506037406;9894.406335619886;10189.286749927434;10212.336198147097;10244.948775256076;10078.546465409221;10328;10559.683209503728;10586.364818110938;10607.628732994308;7480;7525.849483010418;7638.961805190938;7650.5027173235785;7653.57905315213;8037;9413.670521531714;9580.856287155559;10171.13545348624;10348.22388320894 16:10:46 INFO - PROCESS | 3995 | |3;mootools.html;1280.5198050730976;1428.6428392901776;1431.4059665238926;1598.46451438768;1789.7673302470678;7381.1880693123785;7528.322450979411;7531.849363012737;7540.095188577365;7550.282723141299;7471.178170401252;7575.128860181081;7629.618519074052;7632.084149902005;7643.388528917687;1990.7710613279442;2217.833662475317;2243.741969673484;2247.6628505724107;2302.654601809734;2276.64711969645;2278.7265528136563;2290.5075408787106;2294.3461113582634;2294.4952110535655;2194.2320187934256;2271.4434963433982;2273.533925545259;2274.3404412720374;2275.5335156293004;2192.9451763705874;2199.2742395009686;2211.5355775287208;2256.6163752162006;2261.8642881427168;2211.0381983837083;2240.0815665577034;2244.472548950995;2255.548890221962;2256.413332533553;7505.812354691122;7558.886616700699;7559.395248380117;7568.356689681384;7578.507397019176;4631.652626053059;4775.594074503671;4782.545658162469;4783.473817880031;4783.928241076386;3173.1908363367193;3177.205698575356;3183.71346578809;3237.5791147150953;3267.39553182662;950.3062764182185;963.5134257200069;970.6505657963128;985.8866230383526;1006.109593010184;10653.094486968539;10660.786784264348;10673.412962287071;10708.46457677113;10714.464276786208;4273.594008569181;4328.761918094472;4439.889002774957;4458.8439404620685;4460.487043989918;9104.362694611315;9171.954140229256;9173.35786494939;9189.264858811279;9194.356395052417;4178.101708132705;4818.831340903052;4845.200541910545;4845.927311090337;4855.344528488679;4111.321631930758;4125.463689720377;4131.793410329532;4162.646175075092;4187.350960601112;3672.8347224374966;3738.532683414573;3741.6071312511795;3757.643023912724;3782.0544863784053;1167.0313639679046;1168.4216312925157;1177.9705507362385;1184.390039129849;1191.5650787462514;1200.9459574319176;1200.9699757506132;1221.0292817210338;1245.8940990015951;1260.7226410189744;7196.364610515278;7258.963705181441;7272.672729727175;7283.781486555412;7303.269673032761;448.61195066268095;458.7981288233167;460.2130357089348;462.26730631948067;462.36194052207736;5526.253955715927;5545.223668686387;5549.694766787866;5557;5590;9160.725178244664;9382.85925711115;9570.90429095714;9695.6121755129;9706.126448619658;9435;9449.574769135406;9510.239180865514;9542.61829526825;9589.42463452181;6838.452923766087;6895.965520172367;7366.926330736731;7391.334779869838;7439.479236453504;6966.79099627012;6994.930050699428;6996.405305549085;7029.3673569379;7041.5422997505;8318.292945099734;8324.916750832414;8392.4544904581;8441.451305665112;8554.957225213833;8662.696805611773;8665.350098742745;8693.34799889998;8791.912080879109;8801.735947921572;5972.372900845348;6439.388258115471;6595.538312318092;6835.863282734417;6940.305969403019;7140.321669441395;7141.107361579802;7162.033125528195;7189;7193.892091618525;6402.231732191981;6563.683416432705;6593.901091483535;6652.068710380648;6662.933370666231;6433;6476.967615161894;6489.286178520453;6504.869902602016;6526.412622863965;6728.226253980855;6735.831604209934;6776.322367763381;6778.762743303961;6788.524803263724;6375.298717141203;6404.4876409886165;6420.1974753155855;6449.451796597342;6451.096846441408;6230.626162430269;6267.091271765659;6300.306966233619;6301.779437719658;6322.178116844781 16:10:46 INFO - PROCESS | 3995 | |4;prototype.html;321.26430474214044;322.07564290486306;322.52266645364864;327.62486952439474;331.842374871936;5479;5493.862653433666;5528.308961379827;5531.474509921561;5577.8605534861645;5453.481919217678;5471.644343117695;5477.397486276506;5482.369527504338;5486.3690675572325;4026.9798651006704;4176.958230417687;4283.700140990132;4295.806688699008;4304.354346847982;4298.398224248608;4299.398084268189;4302.849400270991;4305.849295274666;4312.460942382202;4253.702240843142;4266.06146647737;4268.6798490113215;4274.252005898971;4277.443932288798;3988.8603898863544;4121.9587804121875;4204.2432362174795;4210.136921930997;4223.746575205498;3699.722520810923;3704.0554658561896;3706.944395834065;3709.77741335518;3709.8516059357594;5254.7635356409055;5281.52466278033;5281.894362112775;5284.841454756363;5287.259783630295;4892.094962431962;4896.363472748555;4900.926486102676;4901.240307752304;4906.31311616374;5777.508911742507;5791.059994901713;5798.3911689272445;5801.941980580183;5807.593468457209;3846.499955005859;4092.6112019358116;4094.3653733671326;4095.0786073133604;4095.262852686515;6023.457888789986;6027.186329845458;6048.153258543852;6075;6107.694615269219;4107.732997355162;4107.774072425986;4108.1783643271465;4108.322126849096;4113.136241389282;4161.417401563784;4172.853950111731;4180.080382315886;4183.581641835792;4192.616436575922;4810.494898035656;4827.951720482821;4832.685875418087;4835.443923948791;4840.903181936412;5798.275215598051;5808.709564521757;5813.970930145322;5817.360090390053;5825.679587622637;1417.1497101738873;1458.3437453146128;1479.3342995652;1484.64368551549;1486.717523670499;895.0735988252258;916.5371487398821;960.370957023137;962.499500259861;962.9229661627053;4938.111139994836;4964.975175124101;4975.502449754996;5071.923921141186;5091.159958606789;6041.426064523863;6042.184305118841;6079.422454866781;6084.574079814459;6085.513158947274;5109.20807274873;5109.616778741609;5111.539961403491;5111.744412779346;5116.232565115262;3224.161717953349;3232.5474433579316;3250.333681595267;3252.7885687430717;3256.6743325667717;5475.7262136893;5580.079286917694;5625.746841392065;5627.212190293362;5627.971860140673;6097.207363042776;6172.938270617326;6181;6184.350643182491;6190.133381326618;5593.133064375028;5617.662940223599;5622.297212848394;5626.465485778845;5626.943730562642;6021.42796434338;6030.276366836008;6033.849153771191;6035.064564992434;6036.426539478743;5898.882022359443;5900.262467191601;5902.848944455962;5909.143174239625;5918.615290006136;5452.563794896319;5602.467765562265;5622.550195984393;5641.492265696107;5645.209670646195;4091.8363265469047;4126.381042843597;4127.318992366226;4130.690198235085;4161.583841615814;6001.789937352171;6008.218931538872;6017.819465416044;6052.6973651316375;6084.452399284086;5834.824955251349;5835.095560188178;5835.212246346859;5836.795712150054;5838.211841401357;5794.159846822272;5813.912791308218;5820.796272130455;5821.592488525763;5824.271966004249;5575.677752167755;5677.148427735708;5717.656940583578;5726.370099289158;5739.512141468022;5822.301323841166;5848.239728835224;5857.384974577608;5861.208736820475;5866.413358664099;5701.486866182064;5701.8859622806485;5702.059160238514;5707.971460142673;5708.143778433102 16:10:46 INFO - PROCESS | 3995 | |5;yui.html;702.3678689179741;702.5573888450275;765.6363227466952;786.9134395216525;796.6375299238845;11983.880161198385;12178.208416452935;14118.576442706722;14241.643958901033;14267;13849.861501384983;13922.234277114754;13922.512712055055;13923.860761392383;13930.233837138954;650.8145178624093;792.8652129138061;804.6982381606912;819.9098099209082;820.8932838730957;815.3355015662246;821.7699044267615;824.2581676491146;825.9628316725762;826.0624191542582;861.5950503263456;869.613022205119;870.1602953150209;871.0505548951642;871.1810897756121;686.7870960002415;832.5629044751494;854.0264098927228;855.2559273432123;859.9785005374885;615.9507239420835;620.602814198913;620.633826042637;620.9037599172091;621.3444815719414;13035.60893173197;13091.672708182276;13099.738005239937;13106.541271055563;13110.47558097675;12182.81725774114;12423.254604723745;12444.688882777913;12599.559015434508;12659.810102848465;9890.80218395628;9995.200383969264;10033.59865605375;10080.092791648787;10270.332428392205;3342.4819153031317;3363.5110613106945;3405.9318813623836;3441.913952151191;3493.406120959443;46387.30419043684;46455.07089858218;46587.30119048217;46753.532464675256;46823.36118235879;9903.851442228372;10198.286119971679;10229.283950123569;10279.537420816081;10372.481375931324;18154.18306176225;18187;18253.45239642813;18277.725834112498;18288.994105324335;6859;7014.22843487216;7043;7081.221065682771;7234.74678386254;3823.541175058955;3873.2447172801035;3887.4168874669026;3934.9213015740097;3964.147708242684;3030.1364111228195;3050.8779648813797;3076.1694342527394;3083.922901927425;3083.953740693891;544.5235419008368;553.8338498450448;554.7115499940008;560.9887802243933;574.0814696485589;481.71578768526035;555.7388027627009;572.3446653581626;624.6501958903029;627.8242092214188;8232.62953167109;8237.917620823835;8330.666773329;8352.749417517483;8636.740897773077;449.4606472233333;476.345025589814;514.9948500515022;546.9972650136724;551.4650788734921;3817.5037245158505;3868.7291889568023;3875.418687196943;3882.6311500407414;3929.115948911472;52744;53936.190957135674;55376.723116384965;55461.44538554563;55518.44481555133;47007.05985880263;47095.76452117786;47249.291260631115;47631.76184119057;47834.76082619565;42369.788151059045;42398.15203695909;42739.93150171208;43050.78474607669;43106.35340469895;7385.03994480714;7387.630618469163;7410.5183163094225;7439.851202975802;7529.8494030118;32765.836170818995;32869.34261314713;33353;33543;33783.83108084542;38173.80913095417;42030.36954445747;42133;42476;42499;9203.263738900738;9394.859077113986;9417.905820941703;9488.810223795623;9498.810023799348;10556.947215263874;10660.89339106599;10707.678769636923;11630.53477860876;11769.411529423665;8679.218870301704;10007.949960250153;10225.079742823182;11272.154588405738;11523.884761152616;10523.94738026305;10721.785564288826;10792.892071079503;10909.83635245456;11144.554217831195;10632.468376580986;10844.511996960313;10964.396958167377;10972.780544389227;11216.607418740305;8297;8473;8618.525981071101;8677.219050285505;8913.910860891567;8717.738467845975;8755.562221888753;8855.867161992446;8926.910730892609;8991 16:10:46 INFO - PROCESS | 3995 | __end_tp_report 16:10:46 INFO - PROCESS | 3995 | __start_cc_report 16:10:46 INFO - PROCESS | 3995 | _x_x_mozilla_cycle_collect,869 16:10:46 INFO - PROCESS | 3995 | __end_cc_report 16:10:46 INFO - PROCESS | 3995 | __startTimestamp1458342646150__endTimestamp 16:10:46 INFO - PROCESS | 3995 | 16:10:46 INFO - PROCESS | 3995 | ------- Summary: start ------- 16:10:46 INFO - PROCESS | 3995 | Number of tests: 6 16:10:46 INFO - PROCESS | 3995 | 16:10:46 INFO - PROCESS | 3995 | [#0] dojo.html Cycles:165 Average:4716.04 Median:4842.23 stddev:500.41 (10.3%) stddev-sans-first:473.38 16:10:46 INFO - PROCESS | 3995 | Values: 2591.2 2633.5 2635.4 2638.8 2684.5 4528.8 4688.2 4700.0 4721.1 4723.0 4782.7 4783.2 4785.2 4810.5 4811.6 4356.7 4366.5 4396.4 4415.2 4473.8 4190.2 4309.8 4366.9 4370.1 4395.1 4368.9 4375.1 4388.2 4414.1 4422.3 4360.5 4366.2 4388.1 4400.9 4443.6 4261.0 4294.9 4319.5 4357.0 4375.9 4643.2 4646.9 4648.2 4656.3 4703.8 5122.1 5128.1 5132.5 5133.9 5136.0 4994.8 5164.6 5219.8 5249.8 5255.8 4781.2 4786.2 4797.1 4797.6 4801.5 5163.5 5259.3 5262.9 5268.6 5310.3 5003.1 5020.5 5039.0 5064.8 5091.1 5103.5 5132.0 5132.7 5134.0 5184.1 5011.7 5047.5 5066.5 5092.9 5097.0 5056.3 5078.5 5096.4 5115.2 5151.4 4388.0 4399.9 4421.5 4442.0 4461.4 3734.2 3778.4 3820.6 3823.4 3843.0 4364.7 4365.2 4379.3 4389.6 4406.7 5112.9 5114.1 5114.7 5120.1 5126.7 4275.7 4371.1 4377.9 4409.3 4431.4 4653.7 4676.6 4679.0 4699.6 4725.3 4838.9 4842.2 4846.9 4848.4 4895.3 5035.3 5121.4 5128.7 5170.9 5210.0 4739.3 4740.5 4760.9 4787.7 4793.3 4959.9 4964.3 4970.0 4989.8 5015.5 4993.9 5008.9 5033.5 5041.1 5067.2 4985.8 4992.1 4996.2 5003.1 5042.8 4974.8 4974.8 4977.0 4979.1 4981.7 4829.4 4859.9 4880.4 4929.1 4987.1 4981.9 4999.5 5001.6 5004.5 5031.9 4896.2 4900.9 4901.6 4902.1 4946.8 16:10:46 INFO - PROCESS | 3995 | 16:10:46 INFO - PROCESS | 3995 | [#1] ext.html Cycles:180 Average:41114.91 Median:17236.77 stddev:66612.50 (386.5%) stddev-sans-first:66729.62 16:10:46 INFO - PROCESS | 3995 | Values: 516.1 544.0 546.9 567.1 579.2 26793.7 27273.9 34547.1 35043.1 35107.3 38116.0 38573.8 38576.8 38636.4 38667.0 7358.7 7768.3 7958.6 7960.8 9786.4 9796.9 9995.7 9998.8 10003.4 10004.4 9968.8 10076.9 10080.9 10089.7 10090.6 9948.7 10045.8 10050.2 10055.4 10056.8 9998.0 10190.3 10256.1 10266.3 10271.6 36394.0 36731.3 36758.8 36776.0 36800.4 3167.2 3178.9 3211.4 3302.7 3629.5 28276.3 29717.3 30306.8 30369.4 30417.4 3542.4 3547.4 3552.4 3576.6 3680.3 270919.0 274813.0 275149.0 275275.0 275717.0 53818.2 54269.7 54503.5 54566.7 54699.0 58110.7 58391.7 58439.7 62425.4 64682.2 13167.5 13248.3 13261.3 13296.0 13303.6 8987.4 10448.6 10747.2 10809.7 10824.5 19472.9 20637.6 20685.3 20728.4 20738.3 7655.4 7805.2 7851.5 7943.2 7977.2 886.4 902.6 926.7 935.5 977.6 26615.6 27514.6 28088.0 28096.4 28121.2 963.6 975.4 1013.5 1046.5 1054.6 14096.9 14529.9 14545.6 14781.2 14842.6 296437.0 301290.0 301454.0 302144.0 302201.0 46870.5 47094.8 47497.8 47576.5 47590.8 1009.3 1114.5 1185.3 1213.4 1213.7 23987.9 27246.7 27584.0 27816.0 27852.4 36541.6 36593.8 36737.3 36889.3 37459.8 165855.0 169715.2 170178.0 170682.0 177135.0 28996.3 30559.0 31306.4 31911.7 32059.8 35548.0 35774.8 36036.5 36413.3 36505.6 32719.7 32773.8 33893.5 34353.0 34615.7 32950.7 33323.5 33428.5 33484.5 33806.3 29893.0 30169.2 30359.8 30366.0 30374.5 28328.9 30424.8 30722.8 30771.4 30883.8 23623.6 23989.9 24159.8 24240.3 24362.4 16:10:46 INFO - PROCESS | 3995 | 16:10:46 INFO - PROCESS | 3995 | [#2] jquery.html Cycles:180 Average:21644.40 Median:24310.49 stddev:55550.99 (228.5%) stddev-sans-first:55683.82 16:10:46 INFO - PROCESS | 3995 | Values: 352.5 364.7 365.9 366.9 369.6 15576.5 15590.7 16129.7 16170.5 16179.3 15190.4 15348.4 16329.4 16353.5 16354.4 5040.0 5175.9 5181.9 5239.2 5468.0 4403.9 4424.6 4431.0 4434.4 4441.0 4413.4 4444.9 4449.3 4457.4 4457.8 4051.5 4223.9 4357.8 5224.2 5534.2 5302.5 5389.3 5403.1 5403.6 5405.9 17275.5 18049.7 19251.0 19251.9 19259.9 1989.6 2008.1 2027.8 2075.7 2171.6 8957.1 9560.7 9593.2 11699.8 12799.2 1783.4 1857.5 1862.6 1879.7 1883.7 57974.0 60567.0 61754.7 62187.4 63141.4 10180.2 10269.3 10499.8 10514.2 10578.7 13225.5 13292.5 13306.8 13314.2 13318.8 7016.3 7020.9 7111.1 7114.0 7143.1 6387.9 6499.8 6573.6 6685.6 6757.2 4382.5 4399.8 4460.1 4489.7 4497.2 1737.6 1793.2 1812.6 1819.6 1831.0 827.8 869.6 877.2 913.9 930.9 14641.9 15448.0 15687.0 15985.7 16287.0 880.4 909.9 912.6 922.6 928.9 8883.2 9226.9 9264.7 9288.5 9384.3 299459.0 305079.0 306576.0 374534.0 385185.0 62746.7 66492.0 71489.6 73846.3 75415.6 965.3 967.6 984.4 999.9 1002.4 11745.4 13945.8 14625.3 14641.1 15082.8 21899.7 29254.4 33408.0 34523.8 35035.5 43573.0 44207.6 44621.8 45576.0 46180.8 7059.8 7287.8 7416.1 7508.4 7567.7 8314.5 10357.0 10855.6 10983.0 11233.4 5598.9 6140.1 9872.0 9889.6 10216.5 9659.8 9894.4 10189.3 10212.3 10244.9 10078.5 10328.0 10559.7 10586.4 10607.6 7480.0 7525.8 7639.0 7650.5 7653.6 8037.0 9413.7 9580.9 10171.1 10348.2 16:10:46 INFO - PROCESS | 3995 | 16:10:46 INFO - PROCESS | 3995 | [#3] mootools.html Cycles:180 Average:5372.02 Median:6311.98 stddev:2823.43 (44.7%) stddev-sans-first:2814.60 16:10:46 INFO - PROCESS | 3995 | Values: 1280.5 1428.6 1431.4 1598.5 1789.8 7381.2 7528.3 7531.8 7540.1 7550.3 7471.2 7575.1 7629.6 7632.1 7643.4 1990.8 2217.8 2243.7 2247.7 2302.7 2276.6 2278.7 2290.5 2294.3 2294.5 2194.2 2271.4 2273.5 2274.3 2275.5 2192.9 2199.3 2211.5 2256.6 2261.9 2211.0 2240.1 2244.5 2255.5 2256.4 7505.8 7558.9 7559.4 7568.4 7578.5 4631.7 4775.6 4782.5 4783.5 4783.9 3173.2 3177.2 3183.7 3237.6 3267.4 950.3 963.5 970.7 985.9 1006.1 10653.1 10660.8 10673.4 10708.5 10714.5 4273.6 4328.8 4439.9 4458.8 4460.5 9104.4 9172.0 9173.4 9189.3 9194.4 4178.1 4818.8 4845.2 4845.9 4855.3 4111.3 4125.5 4131.8 4162.6 4187.4 3672.8 3738.5 3741.6 3757.6 3782.1 1167.0 1168.4 1178.0 1184.4 1191.6 1200.9 1201.0 1221.0 1245.9 1260.7 7196.4 7259.0 7272.7 7283.8 7303.3 448.6 458.8 460.2 462.3 462.4 5526.3 5545.2 5549.7 5557.0 5590.0 9160.7 9382.9 9570.9 9695.6 9706.1 9435.0 9449.6 9510.2 9542.6 9589.4 6838.5 6896.0 7366.9 7391.3 7439.5 6966.8 6994.9 6996.4 7029.4 7041.5 8318.3 8324.9 8392.5 8441.5 8555.0 8662.7 8665.4 8693.3 8791.9 8801.7 5972.4 6439.4 6595.5 6835.9 6940.3 7140.3 7141.1 7162.0 7189.0 7193.9 6402.2 6563.7 6593.9 6652.1 6662.9 6433.0 6477.0 6489.3 6504.9 6526.4 6728.2 6735.8 6776.3 6778.8 6788.5 6375.3 6404.5 6420.2 6449.5 6451.1 6230.6 6267.1 6300.3 6301.8 6322.2 16:10:46 INFO - PROCESS | 3995 | 16:10:46 INFO - PROCESS | 3995 | [#4] prototype.html Cycles:180 Average:4798.85 Median:5480.68 stddev:1421.19 (25.9%) stddev-sans-first:1384.87 16:10:46 INFO - PROCESS | 3995 | Values: 321.3 322.1 322.5 327.6 331.8 5479.0 5493.9 5528.3 5531.5 5577.9 5453.5 5471.6 5477.4 5482.4 5486.4 4027.0 4177.0 4283.7 4295.8 4304.4 4298.4 4299.4 4302.8 4305.8 4312.5 4253.7 4266.1 4268.7 4274.3 4277.4 3988.9 4122.0 4204.2 4210.1 4223.7 3699.7 3704.1 3706.9 3709.8 3709.9 5254.8 5281.5 5281.9 5284.8 5287.3 4892.1 4896.4 4900.9 4901.2 4906.3 5777.5 5791.1 5798.4 5801.9 5807.6 3846.5 4092.6 4094.4 4095.1 4095.3 6023.5 6027.2 6048.2 6075.0 6107.7 4107.7 4107.8 4108.2 4108.3 4113.1 4161.4 4172.9 4180.1 4183.6 4192.6 4810.5 4828.0 4832.7 4835.4 4840.9 5798.3 5808.7 5814.0 5817.4 5825.7 1417.1 1458.3 1479.3 1484.6 1486.7 895.1 916.5 960.4 962.5 962.9 4938.1 4965.0 4975.5 5071.9 5091.2 6041.4 6042.2 6079.4 6084.6 6085.5 5109.2 5109.6 5111.5 5111.7 5116.2 3224.2 3232.5 3250.3 3252.8 3256.7 5475.7 5580.1 5625.7 5627.2 5628.0 6097.2 6172.9 6181.0 6184.4 6190.1 5593.1 5617.7 5622.3 5626.5 5626.9 6021.4 6030.3 6033.8 6035.1 6036.4 5898.9 5900.3 5902.8 5909.1 5918.6 5452.6 5602.5 5622.6 5641.5 5645.2 4091.8 4126.4 4127.3 4130.7 4161.6 6001.8 6008.2 6017.8 6052.7 6084.5 5834.8 5835.1 5835.2 5836.8 5838.2 5794.2 5813.9 5820.8 5821.6 5824.3 5575.7 5677.1 5717.7 5726.4 5739.5 5822.3 5848.2 5857.4 5861.2 5866.4 5701.5 5701.9 5702.1 5708.0 5708.1 16:10:46 INFO - PROCESS | 3995 | 16:10:46 INFO - PROCESS | 3995 | [#5] yui.html Cycles:180 Average:13075.18 Median:46788.45 stddev:15017.64 (32.1%) stddev-sans-first:15031.02 16:10:46 INFO - PROCESS | 3995 | Values: 702.4 702.6 765.6 786.9 796.6 11983.9 12178.2 14118.6 14241.6 14267.0 13849.9 13922.2 13922.5 13923.9 13930.2 650.8 792.9 804.7 819.9 820.9 815.3 821.8 824.3 826.0 826.1 861.6 869.6 870.2 871.1 871.2 686.8 832.6 854.0 855.3 860.0 616.0 620.6 620.6 620.9 621.3 13035.6 13091.7 13099.7 13106.5 13110.5 12182.8 12423.3 12444.7 12599.6 12659.8 9890.8 9995.2 10033.6 10080.1 10270.3 3342.5 3363.5 3405.9 3441.9 3493.4 46387.3 46455.1 46587.3 46753.5 46823.4 9903.9 10198.3 10229.3 10279.5 10372.5 18154.2 18187.0 18253.5 18277.7 18289.0 6859.0 7014.2 7043.0 7081.2 7234.7 3823.5 3873.2 3887.4 3934.9 3964.1 3030.1 3050.9 3076.2 3083.9 3084.0 544.5 553.8 554.7 561.0 574.1 481.7 555.7 572.3 624.7 627.8 8232.6 8237.9 8330.7 8352.7 8636.7 449.5 476.3 515.0 547.0 551.5 3817.5 3868.7 3875.4 3882.6 3929.1 52744.0 53936.2 55376.7 55461.4 55518.4 47007.1 47095.8 47249.3 47631.8 47834.8 42369.8 42398.2 42739.9 43050.8 43106.4 7385.0 7387.6 7410.5 7439.9 7529.8 32765.8 32869.3 33353.0 33543.0 33783.8 38173.8 42030.4 42133.0 42476.0 42499.0 9203.3 9394.9 9417.9 9488.8 9498.8 10556.9 10660.9 10707.7 11630.5 11769.4 8679.2 10007.9 10225.1 11272.2 11523.9 10523.9 10721.8 10792.9 10909.8 11144.6 10632.5 10844.5 10964.4 10972.8 11216.6 8297.0 8473.0 8618.5 8677.2 8913.9 8717.7 8755.6 8855.9 8926.9 8991.0 16:10:46 INFO - PROCESS | 3995 | -------- Summary: end -------- 16:10:46 INFO - PROCESS | 3995 | 16:10:46 INFO - TEST-INFO | 3995: exit 0 16:10:46 INFO - TEST-OK | dromaeo_css | took 1121931ms 16:10:46 INFO - TEST-START | kraken 16:10:46 INFO - operating with platform_type : linux_ 16:10:46 INFO - Initialising browser for kraken test... 16:10:46 INFO - TEST-INFO | started process 4174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpstcfn3/profile http://localhost:44195/getInfo.html) 16:10:52 INFO - PROCESS | 4174 | __metrics Screen width/height:1600/1200 16:10:52 INFO - PROCESS | 4174 | colorDepth:24 16:10:52 INFO - PROCESS | 4174 | Browser inner width/height: 1024/697 16:10:52 INFO - PROCESS | 4174 | __metrics 16:10:53 ERROR - PROCESS | 4174 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:10:54 INFO - TEST-INFO | 4174: exit 0 16:10:54 INFO - Browser initialized. 16:10:54 INFO - Running cycle 1/1 for kraken test... 16:10:54 INFO - TEST-INFO | started process 4256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpstcfn3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:06 INFO - PROCESS | 4256 | RSS: Main: 154214400 16:11:06 INFO - PROCESS | 4256 | 16:11:08 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:44195/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44195/tests/kraken/driver.html?testName=audio-beat-detection) 16:11:09 INFO - PROCESS | 4256 | RSS: Main: 199573504 16:11:09 INFO - PROCESS | 4256 | 16:11:12 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:44195/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44195/tests/kraken/driver.html?testName=audio-dft) 16:11:12 INFO - PROCESS | 4256 | RSS: Main: 188637184 16:11:12 INFO - PROCESS | 4256 | 16:11:15 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:44195/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44195/tests/kraken/driver.html?testName=audio-fft) 16:11:16 INFO - PROCESS | 4256 | RSS: Main: 173637632 16:11:16 INFO - PROCESS | 4256 | 16:11:18 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:44195/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44195/tests/kraken/driver.html?testName=audio-oscillator) 16:11:19 INFO - PROCESS | 4256 | RSS: Main: 175366144 16:11:19 INFO - PROCESS | 4256 | 16:11:21 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:44195/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44195/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:11:21 INFO - PROCESS | 4256 | RSS: Main: 176570368 16:11:21 INFO - PROCESS | 4256 | 16:11:25 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:44195/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44195/tests/kraken/driver.html?testName=imaging-darkroom) 16:11:25 INFO - PROCESS | 4256 | RSS: Main: 176951296 16:11:25 INFO - PROCESS | 4256 | 16:11:29 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:44195/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44195/tests/kraken/driver.html?testName=imaging-desaturate) 16:11:29 INFO - PROCESS | 4256 | RSS: Main: 177164288 16:11:29 INFO - PROCESS | 4256 | 16:11:32 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:44195/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44195/tests/kraken/driver.html?testName=json-parse-financial) 16:11:33 INFO - PROCESS | 4256 | RSS: Main: 175906816 16:11:33 INFO - PROCESS | 4256 | 16:11:34 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:44195/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44195/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:11:35 INFO - PROCESS | 4256 | RSS: Main: 188698624 16:11:35 INFO - PROCESS | 4256 | 16:11:37 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:44195/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44195/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:11:37 INFO - PROCESS | 4256 | RSS: Main: 184262656 16:11:37 INFO - PROCESS | 4256 | 16:11:39 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:44195/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44195/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:11:40 INFO - PROCESS | 4256 | RSS: Main: 192954368 16:11:40 INFO - PROCESS | 4256 | 16:11:43 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:44195/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:11:43 INFO - PROCESS | 4256 | RSS: Main: 200904704 16:11:43 INFO - PROCESS | 4256 | 16:11:46 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:44195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:11:46 INFO - PROCESS | 4256 | RSS: Main: 201158656 16:11:46 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | Cycle 1(1): loaded http://localhost:44195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44195/tests/kraken/driver.html?testName=ai-astar) 16:11:48 INFO - PROCESS | 4256 | RSS: Main: 260489216 16:11:48 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | __start_tp_report 16:11:48 INFO - PROCESS | 4256 | _x_x_mozilla_page_load 16:11:48 INFO - PROCESS | 4256 | _x_x_mozilla_page_load_details 16:11:48 INFO - PROCESS | 4256 | |i|pagename|runs| 16:11:48 INFO - PROCESS | 4256 | |0;ai-astar;110;121;110;110;114;111;100;111;111;113 16:11:48 INFO - PROCESS | 4256 | |1;audio-beat-detection;152;128;156;177;130;154;159;131;184;130 16:11:48 INFO - PROCESS | 4256 | |2;audio-dft;163;164;160;159;160;161;162;162;162;160 16:11:48 INFO - PROCESS | 4256 | |3;audio-fft;72;72;102;93;72;76;75;118;107;76 16:11:48 INFO - PROCESS | 4256 | |4;audio-oscillator;94;95;131;94;94;94;145;93;93;132 16:11:48 INFO - PROCESS | 4256 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;116;118 16:11:48 INFO - PROCESS | 4256 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;146;146 16:11:48 INFO - PROCESS | 4256 | |7;imaging-desaturate;96;96;101;96;95;96;96;96;96;96 16:11:48 INFO - PROCESS | 4256 | |8;json-parse-financial;65;65;65;67;65;65;65;79;63;64 16:11:48 INFO - PROCESS | 4256 | |9;json-stringify-tinderbox;64;65;63;64;64;65;64;64;64;64 16:11:48 INFO - PROCESS | 4256 | |10;stanford-crypto-aes;89;82;82;81;88;83;83;84;84;80 16:11:48 INFO - PROCESS | 4256 | |11;stanford-crypto-ccm;122;117;131;123;122;116;118;117;115;114 16:11:48 INFO - PROCESS | 4256 | |12;stanford-crypto-pbkdf2;138;138;139;137;139;129;139;137;138;138 16:11:48 INFO - PROCESS | 4256 | |13;stanford-crypto-sha256-iterative;66;66;67;67;66;65;65;67;74;65 16:11:48 INFO - PROCESS | 4256 | __end_tp_report 16:11:48 INFO - PROCESS | 4256 | __start_cc_report 16:11:48 INFO - PROCESS | 4256 | _x_x_mozilla_cycle_collect,1120 16:11:48 INFO - PROCESS | 4256 | __end_cc_report 16:11:48 INFO - PROCESS | 4256 | __startTimestamp1458342708733__endTimestamp 16:11:48 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | ------- Summary: start ------- 16:11:48 INFO - PROCESS | 4256 | Number of tests: 14 16:11:48 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:5.13 (4.6%) stddev-sans-first:5.43 16:11:48 INFO - PROCESS | 4256 | Values: 110.0 121.0 110.0 110.0 114.0 111.0 100.0 111.0 111.0 113.0 16:11:48 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:155.00 stddev:20.18 (13.0%) stddev-sans-first:21.40 16:11:48 INFO - PROCESS | 4256 | Values: 152.0 128.0 156.0 177.0 130.0 154.0 159.0 131.0 184.0 130.0 16:11:48 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.57 (1.0%) stddev-sans-first:1.54 16:11:48 INFO - PROCESS | 4256 | Values: 163.0 164.0 160.0 159.0 160.0 161.0 162.0 162.0 162.0 160.0 16:11:48 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | [#3] audio-fft Cycles:10 Average:86.30 Median:73.50 stddev:17.25 (23.5%) stddev-sans-first:17.50 16:11:48 INFO - PROCESS | 4256 | Values: 72.0 72.0 102.0 93.0 72.0 76.0 75.0 118.0 107.0 76.0 16:11:48 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | [#4] audio-oscillator Cycles:10 Average:106.50 Median:94.00 stddev:20.69 (22.0%) stddev-sans-first:21.45 16:11:48 INFO - PROCESS | 4256 | Values: 94.0 95.0 131.0 94.0 94.0 94.0 145.0 93.0 93.0 132.0 16:11:48 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 16:11:48 INFO - PROCESS | 4256 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 118.0 16:11:48 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 16:11:48 INFO - PROCESS | 4256 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 16:11:48 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.65 (1.7%) stddev-sans-first:1.74 16:11:48 INFO - PROCESS | 4256 | Values: 96.0 96.0 101.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 16:11:48 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:65.00 stddev:4.57 (7.0%) stddev-sans-first:4.82 16:11:48 INFO - PROCESS | 4256 | Values: 65.0 65.0 65.0 67.0 65.0 65.0 65.0 79.0 63.0 64.0 16:11:48 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 16:11:48 INFO - PROCESS | 4256 | Values: 64.0 65.0 63.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 16:11:48 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.50 stddev:2.88 (3.4%) stddev-sans-first:2.29 16:11:48 INFO - PROCESS | 4256 | Values: 89.0 82.0 82.0 81.0 88.0 83.0 83.0 84.0 84.0 80.0 16:11:48 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:120.00 stddev:5.10 (4.3%) stddev-sans-first:5.33 16:11:48 INFO - PROCESS | 4256 | Values: 122.0 117.0 131.0 123.0 122.0 116.0 118.0 117.0 115.0 114.0 16:11:48 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.20 Median:138.00 stddev:2.97 (2.2%) stddev-sans-first:3.14 16:11:48 INFO - PROCESS | 4256 | Values: 138.0 138.0 139.0 137.0 139.0 129.0 139.0 137.0 138.0 138.0 16:11:48 INFO - PROCESS | 4256 | 16:11:48 INFO - PROCESS | 4256 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:2.66 (4.0%) stddev-sans-first:2.80 16:11:48 INFO - PROCESS | 4256 | Values: 66.0 66.0 67.0 67.0 66.0 65.0 65.0 67.0 74.0 65.0 16:11:48 INFO - PROCESS | 4256 | -------- Summary: end -------- 16:11:48 INFO - PROCESS | 4256 | 16:11:49 INFO - TEST-INFO | 4256: exit 0 16:11:49 INFO - TEST-OK | kraken | took 62783ms 16:11:49 INFO - SUITE-END | took 1184s 16:11:49 INFO - Completed test suite (00:19:44) 16:11:49 INFO - javascript benchmark 16:11:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2591.2355855022774, 2633.4996350693377, 2635.3938594123338, 2638.8416694998314, 2684.5436275833117, 4528.796204170812, 4688.179568575499, 4699.953000469995, 4721.055788842236, 4723.0317784854105, 4782.713037217761, 4783.234682450809, 4785.18651829189, 4810.4708482067035, 4811.5910147637405, 4356.716813407118, 4366.4978527469275, 4396.406485124515, 4415.161119387322, 4473.7986790594505, 4190.161967606476, 4309.806058727365, 4366.8908277293, 4370.147821174872, 4395.142947125312, 4368.868933931987, 4375.12497500498, 4388.166248412791, 4414.05097903949, 4422.292433210703, 4360.520342762294, 4366.19225443294, 4388.092172889041, 4400.889977750549, 4443.555644435531, 4261.041265715189, 4294.914101717979, 4319.460067491564, 4357.019670574127, 4375.912481750347, 4643.16165801559, 4646.86059418218, 4648.209804333272, 4656.278276867091, 4703.7883295251795, 5122.103631864409, 5128.102582048126, 5132.538071573539, 5133.897322053575, 5136.0, 4994.750262486861, 5164.6384753067305, 5219.791208351661, 5249.842504724865, 5255.842324730264, 4781.2111001685025, 4786.210275304536, 4797.064572408347, 4797.5682188602495, 4801.4718380978065, 5163.457836927144, 5259.263703081571, 5262.92105618416, 5268.552173065255, 5310.336207974004, 5003.099442100384, 5020.49795020495, 5039.0, 5064.82273120439, 5091.08360495107, 5103.515166059218, 5132.0, 5132.666376685504, 5133.974330128325, 5184.0927837629015, 5011.699298042129, 5047.545720885065, 5066.4680208577565, 5092.872678183075, 5097.0315640028275, 5056.292119103328, 5078.492150784892, 5096.413912400121, 5115.1559992600805, 5151.356080489939, 4388.034632380871, 4399.912001759947, 4421.469423669116, 4442.044960333479, 4461.353103799931, 3734.2158146788934, 3778.3576791944884, 3820.560635526894, 3823.4073718573663, 3842.9615703843165, 4364.738115713004, 4365.170617582713, 4379.277419225856, 4389.604935555815, 4406.691531592758, 5112.923306150411, 5114.105031619451, 5114.718690471986, 5120.1039818031695, 5126.743662816844, 4275.700700950903, 4371.147626212922, 4377.868663940087, 4409.272470042407, 4431.357453169337, 4653.744044077608, 4676.625869930397, 4678.95321046792, 4699.600533954652, 4725.3384526166365, 4838.903221935612, 4842.22524396102, 4846.854594362175, 4848.442429120555, 4895.265710143507, 5035.320231768665, 5121.359830021247, 5128.692278463304, 5170.922436163385, 5209.973950130377, 4739.289106634033, 4740.549647783455, 4760.857394225431, 4787.736674482798, 4793.32893394918, 4959.9008019838675, 4964.25536169563, 4970.0, 4989.775460104376, 5015.548600625962, 4993.925091123563, 5008.874778130576, 5033.546980771748, 5041.117804384291, 5067.239914012927, 4985.825496107619, 4992.051510213048, 4996.200607902718, 5003.099442100457, 5042.84871453857, 4974.751262436791, 4974.776135073858, 4977.0, 4979.078870408841, 4981.726005069756, 4829.420469543677, 4859.927101093415, 4880.365552478155, 4929.112759703145, 4987.127252730685, 4981.850544483671, 4999.500049994971, 5001.599872010303, 5004.524570165829, 5031.899362012812, 4896.1921282987905, 4900.926486102782, 4901.5588597026435, 4902.142125128017, 4946.777395017161], "unit": "score", "name": "dojo.html", "value": 4683.512236250371}, {"lowerIsBetter": false, "replicates": [516.0556182186599, 543.9836804895855, 546.8851541176352, 567.1124689860369, 579.2007030298188, 26793.732062679366, 27273.863630681844, 34547.13632159197, 35043.12392190196, 35107.29785404297, 38116.0, 38573.80713096438, 38576.80711596438, 38636.420453693216, 38667.0, 7358.6688599012905, 7768.300852923236, 7958.641861116234, 7960.800979975518, 9786.412815231073, 9796.853047204298, 9995.70012899614, 9998.750031249205, 10003.449810260432, 10004.449755263495, 9968.750781230454, 10076.94961525195, 10080.899191008106, 10089.747756306115, 10090.646827361044, 9948.701538953843, 10045.849312260321, 10050.246231532592, 10055.446950417723, 10056.849147262797, 9997.950010249975, 10190.286679932407, 10256.128229100535, 10266.281360304782, 10271.640492582725, 36394.0, 36731.26537469262, 36758.816205918796, 36776.0, 36800.44799328012, 3167.160702413862, 3178.936421271562, 3211.389835931189, 3302.7192688621494, 3629.491871138043, 28276.29309267264, 29717.257068573243, 30306.84846575775, 30369.392612147632, 30417.391652167054, 3542.4221536248315, 3547.396942519778, 3552.4316109422625, 3576.5714143351906, 3680.2823449427374, 270919.0, 274813.0, 275149.0, 275275.0, 275717.0, 53818.192727109126, 54269.72865135649, 54503.45496545063, 54566.72716636471, 54699.0, 58110.709446453344, 58391.70804146037, 58439.70780146157, 62425.37574624286, 64682.17860392587, 13167.53913613019, 13248.337583120805, 13261.336933153303, 13296.0, 13303.600891973256, 8987.41581797181, 10448.582056717647, 10747.247692661595, 10809.67570972872, 10824.458777061116, 19472.877811659167, 20637.58724825495, 20685.276015339692, 20728.445366597567, 20738.274160404315, 7655.387568994467, 7805.180456052033, 7851.528908265523, 7943.24539168778, 7977.242161994601, 886.3706768194526, 902.566767951387, 926.7173512078881, 935.4854829843558, 977.5503268496429, 26615.600765988525, 27514.587281190798, 28088.0, 28096.43807123846, 28121.156365309074, 963.5615794813343, 975.4439969217478, 1013.4729940430934, 1046.5499835070993, 1054.5676272728144, 14096.859031409555, 14529.927350363392, 14545.599976003841, 14781.187034713193, 14842.628934276514, 296437.0, 301290.0, 301454.0, 302144.0, 302201.0, 46870.53129468662, 47094.76452617715, 47497.762511187226, 47576.524234757904, 47590.76204619024, 1009.2783659683362, 1114.5263263113145, 1185.3302883870758, 1213.3811756004502, 1213.696575856036, 23987.87637881375, 27246.72753272442, 27584.0, 27816.0, 27852.442951141267, 36541.634583654886, 36593.81703091467, 36737.26525469422, 36889.26221475609, 37459.81270093632, 165855.0, 169715.1514242421, 170178.0, 170682.0, 177135.0, 28996.27509312284, 30559.0, 31306.373872522876, 31911.68088319087, 32059.839700801345, 35548.0, 35774.8211258942, 36036.4594531077, 36413.27173456463, 36505.63494365022, 32719.672803271664, 32773.836130819196, 33893.491597625565, 34353.0, 34615.653843461245, 32950.67049329572, 33323.500147497325, 33428.49857252095, 33484.49773253452, 33806.32387352288, 29893.0, 30169.245768855955, 30359.848200758854, 30366.0, 30374.54438183385, 28328.85835570809, 30424.84787576048, 30722.846385767927, 30771.384572308878, 30883.84558077195, 23623.64564531568, 23989.880050599637, 24159.75840241575, 24240.272791816275, 24362.390940226636], "unit": "score", "name": "ext.html", "value": 17357.393060700793}, {"lowerIsBetter": false, "replicates": [352.47129306040955, 364.6663303077684, 365.8884040367687, 366.9101070237791, 369.58790948092866, 15576.45482408116, 15590.688186236268, 16129.677406451878, 16170.514884553453, 16179.271932763024, 15190.392384304614, 15348.386064557431, 16329.428470003551, 16353.509394718178, 16354.427595034176, 5040.042391945528, 5175.922361164586, 5181.896362072756, 5239.21411788231, 5468.0, 4403.933940990888, 4424.623906967911, 4430.955690443103, 4434.423524941769, 4440.955590444087, 4413.4262545869, 4444.866654000385, 4449.26587113126, 4457.420535330402, 4457.84397546086, 4051.493563304572, 4223.880671622007, 4357.760323182224, 5224.190250511177, 5534.169874518814, 5302.469753024705, 5389.272448219479, 5403.108487099624, 5403.621746477748, 5405.891882162335, 17275.481735547954, 18049.7292540612, 19251.0, 19251.90374048135, 19259.903700481547, 1989.631918095157, 2008.126464987735, 2027.7769445360998, 2075.7094006839056, 2171.576542574199, 8957.104289571056, 9560.713178604654, 9593.184579310768, 11699.824502632468, 12799.168054076456, 1783.4471313892734, 1857.535616095976, 1862.6181632765386, 1879.7274395212617, 1883.7268596053632, 57974.0, 60567.0, 61754.691226544026, 62187.37812621861, 63141.36858631447, 10180.185585153169, 10269.332493387907, 10499.790004199873, 10514.158867290598, 10578.735531611772, 13225.537106201236, 13292.534761283308, 13306.800397994039, 13314.201147931155, 13318.800217996737, 7016.2632923543315, 7020.859582808417, 7111.146662400545, 7114.039604653305, 7143.107111611049, 6387.904181437282, 6499.837504062341, 6573.638449885302, 6685.598864068172, 6757.189137303555, 4382.53983331752, 4399.846005389796, 4460.0633866887665, 4489.708168969007, 4497.235469970113, 1737.574294297905, 1793.237873903612, 1812.6012277298973, 1819.5905921167896, 1830.9908450457663, 827.7765003449035, 869.5956380283072, 877.2192748453881, 913.8766266554063, 930.8510638297976, 14641.853581464049, 15448.0, 15687.0, 15985.680286394207, 16287.0, 880.3529405886668, 909.8544232922833, 912.5938957164132, 922.6217250927087, 928.8885333759857, 8883.156100170474, 9226.90773092274, 9264.67573634933, 9288.535573221312, 9384.343095983215, 299459.0, 305079.0, 306576.0, 374534.0, 385185.0, 62746.68626656837, 66492.0, 71489.6425517869, 73846.26153738501, 75415.62292188503, 965.2953344058876, 967.56943160293, 984.4241118945497, 999.93000489965, 1002.3985608634761, 11745.354005529436, 13945.790813138014, 14625.268736563343, 14641.121532708072, 15082.849171508584, 21899.67150492712, 29254.41491170122, 33408.0, 34523.82738086294, 35035.47446788249, 43573.0, 44207.55792442035, 44621.77689111534, 45576.0, 46180.769096154305, 7059.82350441243, 7287.781366559012, 7416.0729908761405, 7508.43686723487, 7567.697292108254, 8314.542700151549, 10357.0, 10855.565777368816, 10983.0, 11233.382163980732, 5598.936202121584, 6140.140380346666, 9872.01279872007, 9889.604415823287, 10216.540255688364, 9659.758506037406, 9894.406335619886, 10189.286749927434, 10212.336198147097, 10244.948775256076, 10078.546465409221, 10328.0, 10559.683209503728, 10586.364818110938, 10607.628732994308, 7480.0, 7525.849483010418, 7638.961805190938, 7650.5027173235785, 7653.57905315213, 8037.0, 9413.670521531714, 9580.856287155559, 10171.13545348624, 10348.22388320894], "unit": "score", "name": "jquery.html", "value": 7815.246996765287}, {"lowerIsBetter": false, "replicates": [1280.5198050730976, 1428.6428392901776, 1431.4059665238926, 1598.46451438768, 1789.7673302470678, 7381.1880693123785, 7528.322450979411, 7531.849363012737, 7540.095188577365, 7550.282723141299, 7471.178170401252, 7575.128860181081, 7629.618519074052, 7632.084149902005, 7643.388528917687, 1990.7710613279442, 2217.833662475317, 2243.741969673484, 2247.6628505724107, 2302.654601809734, 2276.64711969645, 2278.7265528136563, 2290.5075408787106, 2294.3461113582634, 2294.4952110535655, 2194.2320187934256, 2271.4434963433982, 2273.533925545259, 2274.3404412720374, 2275.5335156293004, 2192.9451763705874, 2199.2742395009686, 2211.5355775287208, 2256.6163752162006, 2261.8642881427168, 2211.0381983837083, 2240.0815665577034, 2244.472548950995, 2255.548890221962, 2256.413332533553, 7505.812354691122, 7558.886616700699, 7559.395248380117, 7568.356689681384, 7578.507397019176, 4631.652626053059, 4775.594074503671, 4782.545658162469, 4783.473817880031, 4783.928241076386, 3173.1908363367193, 3177.205698575356, 3183.71346578809, 3237.5791147150953, 3267.39553182662, 950.3062764182185, 963.5134257200069, 970.6505657963128, 985.8866230383526, 1006.109593010184, 10653.094486968539, 10660.786784264348, 10673.412962287071, 10708.46457677113, 10714.464276786208, 4273.594008569181, 4328.761918094472, 4439.889002774957, 4458.8439404620685, 4460.487043989918, 9104.362694611315, 9171.954140229256, 9173.35786494939, 9189.264858811279, 9194.356395052417, 4178.101708132705, 4818.831340903052, 4845.200541910545, 4845.927311090337, 4855.344528488679, 4111.321631930758, 4125.463689720377, 4131.793410329532, 4162.646175075092, 4187.350960601112, 3672.8347224374966, 3738.532683414573, 3741.6071312511795, 3757.643023912724, 3782.0544863784053, 1167.0313639679046, 1168.4216312925157, 1177.9705507362385, 1184.390039129849, 1191.5650787462514, 1200.9459574319176, 1200.9699757506132, 1221.0292817210338, 1245.8940990015951, 1260.7226410189744, 7196.364610515278, 7258.963705181441, 7272.672729727175, 7283.781486555412, 7303.269673032761, 448.61195066268095, 458.7981288233167, 460.2130357089348, 462.26730631948067, 462.36194052207736, 5526.253955715927, 5545.223668686387, 5549.694766787866, 5557.0, 5590.0, 9160.725178244664, 9382.85925711115, 9570.90429095714, 9695.6121755129, 9706.126448619658, 9435.0, 9449.574769135406, 9510.239180865514, 9542.61829526825, 9589.42463452181, 6838.452923766087, 6895.965520172367, 7366.926330736731, 7391.334779869838, 7439.479236453504, 6966.79099627012, 6994.930050699428, 6996.405305549085, 7029.3673569379, 7041.5422997505, 8318.292945099734, 8324.916750832414, 8392.4544904581, 8441.451305665112, 8554.957225213833, 8662.696805611773, 8665.350098742745, 8693.34799889998, 8791.912080879109, 8801.735947921572, 5972.372900845348, 6439.388258115471, 6595.538312318092, 6835.863282734417, 6940.305969403019, 7140.321669441395, 7141.107361579802, 7162.033125528195, 7189.0, 7193.892091618525, 6402.231732191981, 6563.683416432705, 6593.901091483535, 6652.068710380648, 6662.933370666231, 6433.0, 6476.967615161894, 6489.286178520453, 6504.869902602016, 6526.412622863965, 6728.226253980855, 6735.831604209934, 6776.322367763381, 6778.762743303961, 6788.524803263724, 6375.298717141203, 6404.4876409886165, 6420.1974753155855, 6449.451796597342, 6451.096846441408, 6230.626162430269, 6267.091271765659, 6300.306966233619, 6301.779437719658, 6322.178116844781], "unit": "score", "name": "mootools.html", "value": 4332.459267598045}, {"lowerIsBetter": false, "replicates": [321.26430474214044, 322.07564290486306, 322.52266645364864, 327.62486952439474, 331.842374871936, 5479.0, 5493.862653433666, 5528.308961379827, 5531.474509921561, 5577.8605534861645, 5453.481919217678, 5471.644343117695, 5477.397486276506, 5482.369527504338, 5486.3690675572325, 4026.9798651006704, 4176.958230417687, 4283.700140990132, 4295.806688699008, 4304.354346847982, 4298.398224248608, 4299.398084268189, 4302.849400270991, 4305.849295274666, 4312.460942382202, 4253.702240843142, 4266.06146647737, 4268.6798490113215, 4274.252005898971, 4277.443932288798, 3988.8603898863544, 4121.9587804121875, 4204.2432362174795, 4210.136921930997, 4223.746575205498, 3699.722520810923, 3704.0554658561896, 3706.944395834065, 3709.77741335518, 3709.8516059357594, 5254.7635356409055, 5281.52466278033, 5281.894362112775, 5284.841454756363, 5287.259783630295, 4892.094962431962, 4896.363472748555, 4900.926486102676, 4901.240307752304, 4906.31311616374, 5777.508911742507, 5791.059994901713, 5798.3911689272445, 5801.941980580183, 5807.593468457209, 3846.499955005859, 4092.6112019358116, 4094.3653733671326, 4095.0786073133604, 4095.262852686515, 6023.457888789986, 6027.186329845458, 6048.153258543852, 6075.0, 6107.694615269219, 4107.732997355162, 4107.774072425986, 4108.1783643271465, 4108.322126849096, 4113.136241389282, 4161.417401563784, 4172.853950111731, 4180.080382315886, 4183.581641835792, 4192.616436575922, 4810.494898035656, 4827.951720482821, 4832.685875418087, 4835.443923948791, 4840.903181936412, 5798.275215598051, 5808.709564521757, 5813.970930145322, 5817.360090390053, 5825.679587622637, 1417.1497101738873, 1458.3437453146128, 1479.3342995652, 1484.64368551549, 1486.717523670499, 895.0735988252258, 916.5371487398821, 960.370957023137, 962.499500259861, 962.9229661627053, 4938.111139994836, 4964.975175124101, 4975.502449754996, 5071.923921141186, 5091.159958606789, 6041.426064523863, 6042.184305118841, 6079.422454866781, 6084.574079814459, 6085.513158947274, 5109.20807274873, 5109.616778741609, 5111.539961403491, 5111.744412779346, 5116.232565115262, 3224.161717953349, 3232.5474433579316, 3250.333681595267, 3252.7885687430717, 3256.6743325667717, 5475.7262136893, 5580.079286917694, 5625.746841392065, 5627.212190293362, 5627.971860140673, 6097.207363042776, 6172.938270617326, 6181.0, 6184.350643182491, 6190.133381326618, 5593.133064375028, 5617.662940223599, 5622.297212848394, 5626.465485778845, 5626.943730562642, 6021.42796434338, 6030.276366836008, 6033.849153771191, 6035.064564992434, 6036.426539478743, 5898.882022359443, 5900.262467191601, 5902.848944455962, 5909.143174239625, 5918.615290006136, 5452.563794896319, 5602.467765562265, 5622.550195984393, 5641.492265696107, 5645.209670646195, 4091.8363265469047, 4126.381042843597, 4127.318992366226, 4130.690198235085, 4161.583841615814, 6001.789937352171, 6008.218931538872, 6017.819465416044, 6052.6973651316375, 6084.452399284086, 5834.824955251349, 5835.095560188178, 5835.212246346859, 5836.795712150054, 5838.211841401357, 5794.159846822272, 5813.912791308218, 5820.796272130455, 5821.592488525763, 5824.271966004249, 5575.677752167755, 5677.148427735708, 5717.656940583578, 5726.370099289158, 5739.512141468022, 5822.301323841166, 5848.239728835224, 5857.384974577608, 5861.208736820475, 5866.413358664099, 5701.486866182064, 5701.8859622806485, 5702.059160238514, 5707.971460142673, 5708.143778433102], "unit": "score", "name": "prototype.html", "value": 4340.066828306274}, {"lowerIsBetter": false, "replicates": [702.3678689179741, 702.5573888450275, 765.6363227466952, 786.9134395216525, 796.6375299238845, 11983.880161198385, 12178.208416452935, 14118.576442706722, 14241.643958901033, 14267.0, 13849.861501384983, 13922.234277114754, 13922.512712055055, 13923.860761392383, 13930.233837138954, 650.8145178624093, 792.8652129138061, 804.6982381606912, 819.9098099209082, 820.8932838730957, 815.3355015662246, 821.7699044267615, 824.2581676491146, 825.9628316725762, 826.0624191542582, 861.5950503263456, 869.613022205119, 870.1602953150209, 871.0505548951642, 871.1810897756121, 686.7870960002415, 832.5629044751494, 854.0264098927228, 855.2559273432123, 859.9785005374885, 615.9507239420835, 620.602814198913, 620.633826042637, 620.9037599172091, 621.3444815719414, 13035.60893173197, 13091.672708182276, 13099.738005239937, 13106.541271055563, 13110.47558097675, 12182.81725774114, 12423.254604723745, 12444.688882777913, 12599.559015434508, 12659.810102848465, 9890.80218395628, 9995.200383969264, 10033.59865605375, 10080.092791648787, 10270.332428392205, 3342.4819153031317, 3363.5110613106945, 3405.9318813623836, 3441.913952151191, 3493.406120959443, 46387.30419043684, 46455.07089858218, 46587.30119048217, 46753.532464675256, 46823.36118235879, 9903.851442228372, 10198.286119971679, 10229.283950123569, 10279.537420816081, 10372.481375931324, 18154.18306176225, 18187.0, 18253.45239642813, 18277.725834112498, 18288.994105324335, 6859.0, 7014.22843487216, 7043.0, 7081.221065682771, 7234.74678386254, 3823.541175058955, 3873.2447172801035, 3887.4168874669026, 3934.9213015740097, 3964.147708242684, 3030.1364111228195, 3050.8779648813797, 3076.1694342527394, 3083.922901927425, 3083.953740693891, 544.5235419008368, 553.8338498450448, 554.7115499940008, 560.9887802243933, 574.0814696485589, 481.71578768526035, 555.7388027627009, 572.3446653581626, 624.6501958903029, 627.8242092214188, 8232.62953167109, 8237.917620823835, 8330.666773329, 8352.749417517483, 8636.740897773077, 449.4606472233333, 476.345025589814, 514.9948500515022, 546.9972650136724, 551.4650788734921, 3817.5037245158505, 3868.7291889568023, 3875.418687196943, 3882.6311500407414, 3929.115948911472, 52744.0, 53936.190957135674, 55376.723116384965, 55461.44538554563, 55518.44481555133, 47007.05985880263, 47095.76452117786, 47249.291260631115, 47631.76184119057, 47834.76082619565, 42369.788151059045, 42398.15203695909, 42739.93150171208, 43050.78474607669, 43106.35340469895, 7385.03994480714, 7387.630618469163, 7410.5183163094225, 7439.851202975802, 7529.8494030118, 32765.836170818995, 32869.34261314713, 33353.0, 33543.0, 33783.83108084542, 38173.80913095417, 42030.36954445747, 42133.0, 42476.0, 42499.0, 9203.263738900738, 9394.859077113986, 9417.905820941703, 9488.810223795623, 9498.810023799348, 10556.947215263874, 10660.89339106599, 10707.678769636923, 11630.53477860876, 11769.411529423665, 8679.218870301704, 10007.949960250153, 10225.079742823182, 11272.154588405738, 11523.884761152616, 10523.94738026305, 10721.785564288826, 10792.892071079503, 10909.83635245456, 11144.554217831195, 10632.468376580986, 10844.511996960313, 10964.396958167377, 10972.780544389227, 11216.607418740305, 8297.0, 8473.0, 8618.525981071101, 8677.219050285505, 8913.910860891567, 8717.738467845975, 8755.562221888753, 8855.867161992446, 8926.910730892609, 8991.0], "unit": "score", "name": "yui.html", "value": 5982.99791320789}], "name": "dromaeo_css", "value": 6442.1632091364845}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 121.0, 110.0, 110.0, 114.0, 111.0, 100.0, 111.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [152.0, 128.0, 156.0, 177.0, 130.0, 154.0, 159.0, 131.0, 184.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 160.0, 159.0, 160.0, 161.0, 162.0, 162.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 102.0, 93.0, 72.0, 76.0, 75.0, 118.0, 107.0, 76.0], "unit": "score", "name": "audio-fft", "value": 86.3}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 131.0, 94.0, 94.0, 94.0, 145.0, 93.0, 93.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 101.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 67.0, 65.0, 65.0, 65.0, 79.0, 63.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.3}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 63.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [89.0, 82.0, 82.0, 81.0, 88.0, 83.0, 83.0, 84.0, 84.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [122.0, 117.0, 131.0, 123.0, 122.0, 116.0, 118.0, 117.0, 115.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.5}, {"lowerIsBetter": true, "replicates": [138.0, 138.0, 139.0, 137.0, 139.0, 129.0, 139.0, 137.0, 138.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.2}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 67.0, 66.0, 65.0, 65.0, 67.0, 74.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1512.1999999999998}]} 16:11:49 INFO - Return code: 0 16:11:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:11:50 ERROR - # TBPL SUCCESS # 16:11:50 INFO - Running post-action listener: _resource_record_post_action 16:11:50 INFO - Running post-run listener: _resource_record_post_run 16:11:51 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 430080; Write bytes: 353714176; Read time: 60; Write time: 1230024 16:11:51 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 68255744; Read time: 0; Write time: 530136 16:11:51 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 430080; Write bytes: 285413376; Read time: 60; Write time: 699848 16:11:51 INFO - Running post-run listener: _upload_blobber_files 16:11:51 INFO - Blob upload gear active. 16:11:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:11:51 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:11:51 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:11:51 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:11:51 INFO - (blobuploader) - INFO - Open directory for files ... 16:11:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:11:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:11:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:52 INFO - (blobuploader) - INFO - Done attempting. 16:11:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:11:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:11:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:53 INFO - (blobuploader) - INFO - Done attempting. 16:11:53 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:53 INFO - Return code: 0 16:11:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/498faa36bc5d12b6af244a32f0152f92d9a6d7c4ec10906463d98408f35f8fac5f9f8a6463b459bd5c63dc4061769d974aea7b494fcb88de0c91c875f1e2391b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b85633e956254ab6d7c47f111312c45b59e8d22f44bbd3b0a778754392735e20e06772a5b65faadcf7c285e2cb24fd9440a3b44ab4c22305dba5f5fe9b6f41c"} 16:11:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:53 INFO - Contents: 16:11:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/498faa36bc5d12b6af244a32f0152f92d9a6d7c4ec10906463d98408f35f8fac5f9f8a6463b459bd5c63dc4061769d974aea7b494fcb88de0c91c875f1e2391b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b85633e956254ab6d7c47f111312c45b59e8d22f44bbd3b0a778754392735e20e06772a5b65faadcf7c285e2cb24fd9440a3b44ab4c22305dba5f5fe9b6f41c"} 16:11:53 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:53 INFO - Copying logs to upload dir... 16:11:53 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.780892 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-03-18 16:11:53.290848) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 16:11:53.294580) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423 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/498faa36bc5d12b6af244a32f0152f92d9a6d7c4ec10906463d98408f35f8fac5f9f8a6463b459bd5c63dc4061769d974aea7b494fcb88de0c91c875f1e2391b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b85633e956254ab6d7c47f111312c45b59e8d22f44bbd3b0a778754392735e20e06772a5b65faadcf7c285e2cb24fd9440a3b44ab4c22305dba5f5fe9b6f41c"} build_url:https://queue.taskcluster.net/v1/task/NHPa8PvqQf-gDE37jmcYvg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/NHPa8PvqQf-gDE37jmcYvg/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/498faa36bc5d12b6af244a32f0152f92d9a6d7c4ec10906463d98408f35f8fac5f9f8a6463b459bd5c63dc4061769d974aea7b494fcb88de0c91c875f1e2391b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b85633e956254ab6d7c47f111312c45b59e8d22f44bbd3b0a778754392735e20e06772a5b65faadcf7c285e2cb24fd9440a3b44ab4c22305dba5f5fe9b6f41c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 16:11:53.318747) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 16:11:53.319044) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458340743.727600-1275060423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004614 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 16:11:53.400930) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 16:11:53.404511) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 16:11:53.404824) ========= ========= Total master_lag: 0.54 =========