builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1449501724.99 results: success (0) buildid: 20151207055630 builduid: 9d501bfb0bb9450fb420e549b872e6bf revision: 59bc3c7a83de7ffb611203912a7da6ad84535a5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:04.986589) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:04.987093) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:04.987390) ========= 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=7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006205 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:05.065786) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:05.066185) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:05.235086) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:05.235351) ========= 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=7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.008287 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:05.312830) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:05.313110) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:05.313479) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:05.313761) ========= 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=7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-07 07:22:06-- 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% 73.2M=0s 2015-12-07 07:22:06 (73.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116963 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:05.459803) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:05.463135) ========= 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=7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.145297 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:05.621343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:05.621720) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 59bc3c7a83de7ffb611203912a7da6ad84535a5a --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 59bc3c7a83de7ffb611203912a7da6ad84535a5a --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=7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-07 07:22:06,856 truncating revision to first 12 chars 2015-12-07 07:22:06,856 Setting DEBUG logging. 2015-12-07 07:22:06,856 attempt 1/10 2015-12-07 07:22:06,856 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/59bc3c7a83de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-07 07:22:07,415 unpacking tar archive at: fx-team-59bc3c7a83de/testing/mozharness/ program finished with exit code 0 elapsedTime=0.854521 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:06.492498) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:06.492802) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:06.506662) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:06.506914) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-07 07:22:06.507296) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-07 07:22:06.507594) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --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', '--system-bits', '64', '--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=7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:22:07 INFO - MultiFileLogger online at 20151207 07:22:07 in /builds/slave/test 07:22:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:22:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:22:07 INFO - {'append_to_log': False, 07:22:07 INFO - 'base_work_dir': '/builds/slave/test', 07:22:07 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:22:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:22:07 INFO - 'branch': 'Fx-Team-Non-PGO', 07:22:07 INFO - 'buildbot_json_path': 'buildprops.json', 07:22:07 INFO - 'config_files': ('talos/linux_config.py',), 07:22:07 INFO - 'default_actions': ('clobber', 07:22:07 INFO - 'read-buildbot-config', 07:22:07 INFO - 'download-and-extract', 07:22:07 INFO - 'populate-webroot', 07:22:07 INFO - 'create-virtualenv', 07:22:07 INFO - 'install', 07:22:07 INFO - 'run-tests'), 07:22:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:22:07 INFO - 'download_minidump_stackwalk': True, 07:22:07 INFO - 'download_symbols': 'ondemand', 07:22:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:22:07 INFO - 'tooltool.py': '/tools/tooltool.py', 07:22:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:22:07 INFO - '/tools/misc-python/virtualenv.py')}, 07:22:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:22:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:22:07 INFO - 'installer_path': 'installer.exe', 07:22:07 INFO - 'log_level': 'info', 07:22:07 INFO - 'log_name': 'talos', 07:22:07 INFO - 'log_to_console': True, 07:22:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:22:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:22:07 INFO - 'opt_config_files': (), 07:22:07 INFO - 'pip_index': False, 07:22:07 INFO - 'sps_profile': False, 07:22:07 INFO - 'sps_profile_interval': 0, 07:22:07 INFO - 'suite': 'dromaeojs', 07:22:07 INFO - 'system_bits': '64', 07:22:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:22:07 INFO - 'title': 'talos-linux64-ix-008', 07:22:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:22:07 INFO - 'use_talos_json': True, 07:22:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:22:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:22:07 INFO - 'work_dir': 'build'} 07:22:07 INFO - ##### 07:22:07 INFO - ##### Running clobber step. 07:22:07 INFO - ##### 07:22:07 INFO - Running pre-action listener: _resource_record_pre_action 07:22:07 INFO - Running main action method: clobber 07:22:07 INFO - rmtree: /builds/slave/test/build 07:22:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:22:12 INFO - Running post-action listener: _resource_record_post_action 07:22:12 INFO - ##### 07:22:12 INFO - ##### Running read-buildbot-config step. 07:22:12 INFO - ##### 07:22:12 INFO - Running pre-action listener: _resource_record_pre_action 07:22:12 INFO - Running main action method: read_buildbot_config 07:22:12 INFO - Using buildbot properties: 07:22:12 INFO - { 07:22:12 INFO - "properties": { 07:22:12 INFO - "buildnumber": 2196, 07:22:12 INFO - "product": "firefox", 07:22:12 INFO - "script_repo_revision": "production", 07:22:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:22:12 INFO - "repository": "", 07:22:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:22:12 INFO - "buildid": "20151207055630", 07:22:12 INFO - "slavename": "talos-linux64-ix-008", 07:22:12 INFO - "pgo_build": "False", 07:22:12 INFO - "basedir": "/builds/slave/test", 07:22:12 INFO - "project": "", 07:22:12 INFO - "platform": "ubuntu64_hw", 07:22:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:22:12 INFO - "slavebuilddir": "test", 07:22:12 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:22:12 INFO - "branch": "fx-team", 07:22:12 INFO - "repo_path": "integration/fx-team", 07:22:12 INFO - "stage_platform": "linux64", 07:22:12 INFO - "builduid": "9d501bfb0bb9450fb420e549b872e6bf", 07:22:12 INFO - "revision": "59bc3c7a83de7ffb611203912a7da6ad84535a5a" 07:22:12 INFO - }, 07:22:12 INFO - "sourcestamp": { 07:22:12 INFO - "repository": "", 07:22:12 INFO - "hasPatch": false, 07:22:12 INFO - "project": "", 07:22:12 INFO - "branch": "fx-team-linux64-talos", 07:22:12 INFO - "changes": [ 07:22:12 INFO - { 07:22:12 INFO - "category": null, 07:22:12 INFO - "files": [ 07:22:12 INFO - { 07:22:12 INFO - "url": null, 07:22:12 INFO - "name": "https://queue.taskcluster.net/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:22:12 INFO - } 07:22:12 INFO - ], 07:22:12 INFO - "repository": "", 07:22:12 INFO - "rev": "59bc3c7a83de7ffb611203912a7da6ad84535a5a", 07:22:12 INFO - "who": "cbook@mozilla.com", 07:22:12 INFO - "when": 1449501654, 07:22:12 INFO - "number": 6966436, 07:22:12 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 07:22:12 INFO - "project": "", 07:22:12 INFO - "at": "Mon 07 Dec 2015 07:20:54", 07:22:12 INFO - "branch": "fx-team-linux64-talos", 07:22:12 INFO - "revlink": "", 07:22:12 INFO - "properties": [ 07:22:12 INFO - [ 07:22:12 INFO - "buildid", 07:22:12 INFO - "20151207055630", 07:22:12 INFO - "Change" 07:22:12 INFO - ], 07:22:12 INFO - [ 07:22:12 INFO - "builduid", 07:22:12 INFO - "9d501bfb0bb9450fb420e549b872e6bf", 07:22:12 INFO - "Change" 07:22:12 INFO - ], 07:22:12 INFO - [ 07:22:12 INFO - "pgo_build", 07:22:12 INFO - "False", 07:22:12 INFO - "Change" 07:22:12 INFO - ] 07:22:12 INFO - ], 07:22:12 INFO - "revision": "59bc3c7a83de7ffb611203912a7da6ad84535a5a" 07:22:12 INFO - } 07:22:12 INFO - ], 07:22:12 INFO - "revision": "59bc3c7a83de7ffb611203912a7da6ad84535a5a" 07:22:12 INFO - } 07:22:12 INFO - } 07:22:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:22:12 INFO - Running post-action listener: _resource_record_post_action 07:22:12 INFO - ##### 07:22:12 INFO - ##### Running download-and-extract step. 07:22:12 INFO - ##### 07:22:12 INFO - Running pre-action listener: _resource_record_pre_action 07:22:12 INFO - Running main action method: download_and_extract 07:22:12 INFO - mkdir: /builds/slave/test/build/tests 07:22: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')]} 07:22:12 INFO - https://queue.taskcluster.net/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:22:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/test_packages.json 07:22:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/test_packages.json 07:22:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:22:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:22:16 INFO - Downloaded 1302 bytes. 07:22:16 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:22:16 INFO - Using the following test package requirements: 07:22:16 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:22:16 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:22:16 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:16 INFO - u'jsshell-linux-x86_64.zip'], 07:22:16 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:22:16 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:22:16 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:22:16 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:22:16 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:22:16 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:22:16 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:22:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:22:16 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:22:16 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')]} 07:22:16 INFO - https://queue.taskcluster.net/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:22:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:22:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:22:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:22:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:22:19 INFO - Downloaded 21860053 bytes. 07:22:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 07:22:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:22:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:22:20 INFO - Return code: 0 07:22:20 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:20 INFO - https://queue.taskcluster.net/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:22:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:22:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:22:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:22:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:22:31 INFO - Downloaded 21860053 bytes. 07:22:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 07:22:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:22:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:22:32 INFO - Return code: 0 07:22:32 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')]} 07:22:32 INFO - https://queue.taskcluster.net/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:22:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:22:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:22:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:22:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:22:34 INFO - Downloaded 11132074 bytes. 07:22:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 07:22:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:22:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:22:34 INFO - Return code: 0 07:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:34 INFO - https://queue.taskcluster.net/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:22:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:22:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:22:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:22:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:22:35 INFO - Downloaded 57729411 bytes. 07:22:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:22:35 INFO - mkdir: /builds/slave/test/properties 07:22:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:22:35 INFO - Writing to file /builds/slave/test/properties/build_url 07:22:35 INFO - Contents: 07:22:35 INFO - build_url:https://queue.taskcluster.net/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:22:35 INFO - Running post-action listener: _resource_record_post_action 07:22:35 INFO - Running post-action listener: set_extra_try_arguments 07:22:35 INFO - ##### 07:22:35 INFO - ##### Running populate-webroot step. 07:22:35 INFO - ##### 07:22:35 INFO - Running pre-action listener: _resource_record_pre_action 07:22:35 INFO - Running main action method: populate_webroot 07:22:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:22:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:22:35 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:22:35 INFO - '../fennec_ids.txt'], 07:22:35 INFO - 'tests': ['tcheck2']}, 07:22:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:22:35 INFO - '--tppagecycles', 07:22:35 INFO - '7'], 07:22:36 INFO - 'tests': ['tsvgm']}}, 07:22:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:22:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:22:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:22:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:22:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:22:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:22:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:22:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:36 INFO - 'talos_options': ['--e10s'], 07:22:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:22:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:36 INFO - 'tests': ['damp', 'tps']}, 07:22:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:36 INFO - 'talos_options': ['--e10s'], 07:22:36 INFO - 'tests': ['damp', 'tps']}, 07:22:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:22:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:22:36 INFO - 'other': {'tests': ['a11yr', 07:22:36 INFO - 'ts_paint', 07:22:36 INFO - 'tpaint', 07:22:36 INFO - 'sessionrestore', 07:22:36 INFO - 'sessionrestore_no_auto_restore']}, 07:22:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:22:36 INFO - 'tests': ['a11yr', 07:22:36 INFO - 'ts_paint', 07:22:36 INFO - 'tpaint', 07:22:36 INFO - 'sessionrestore', 07:22:36 INFO - 'sessionrestore_no_auto_restore']}, 07:22:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:22:36 INFO - 'tests': ['a11yr', 07:22:36 INFO - 'ts_paint', 07:22:36 INFO - 'tpaint', 07:22:36 INFO - 'sessionrestore', 07:22:36 INFO - 'sessionrestore_no_auto_restore']}, 07:22:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:22:36 INFO - 'tests': ['a11yr', 07:22:36 INFO - 'ts_paint', 07:22:36 INFO - 'tpaint', 07:22:36 INFO - 'sessionrestore', 07:22:36 INFO - 'sessionrestore_no_auto_restore']}, 07:22:36 INFO - 'other_l64': {'tests': ['a11yr', 07:22:36 INFO - 'ts_paint', 07:22:36 INFO - 'tpaint', 07:22:36 INFO - 'sessionrestore', 07:22:36 INFO - 'sessionrestore_no_auto_restore']}, 07:22:36 INFO - 'other_nol64': {'tests': ['a11yr', 07:22:36 INFO - 'ts_paint', 07:22:36 INFO - 'tpaint', 07:22:36 INFO - 'sessionrestore', 07:22:36 INFO - 'sessionrestore_no_auto_restore']}, 07:22:36 INFO - 'svgr': {'tests': ['tsvgx', 07:22:36 INFO - 'tsvgr_opacity', 07:22:36 INFO - 'tart', 07:22:36 INFO - 'tscrollx', 07:22:36 INFO - 'cart']}, 07:22:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:22:36 INFO - 'tests': ['tsvgx', 07:22:36 INFO - 'tsvgr_opacity', 07:22:36 INFO - 'tart', 07:22:36 INFO - 'tscrollx', 07:22:36 INFO - 'cart']}, 07:22:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:36 INFO - 'tests': ['tp5o']}, 07:22:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:36 INFO - 'talos_options': ['--e10s'], 07:22:36 INFO - 'tests': ['tp5o']}, 07:22:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:36 INFO - 'talos_options': ['--xperf_path', 07:22:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:22:36 INFO - 'tests': ['tp5n']}, 07:22:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:22:36 INFO - 'talos_options': ['--e10s', 07:22:36 INFO - '--xperf_path', 07:22:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:22:36 INFO - 'tests': ['tp5n']}}, 07:22:36 INFO - 'talos.zip': {'path': '', 07:22:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:22:36 INFO - Running post-action listener: _resource_record_post_action 07:22:36 INFO - ##### 07:22:36 INFO - ##### Running create-virtualenv step. 07:22:36 INFO - ##### 07:22:36 INFO - Running pre-action listener: _resource_record_pre_action 07:22:36 INFO - Running main action method: create_virtualenv 07:22:36 INFO - Creating virtualenv /builds/slave/test/build/venv 07:22:36 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 07:22:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:22:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:22:36 INFO - Using real prefix '/usr' 07:22:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:22:36 INFO - Installing distribute.............................................................................................................................................................................................done. 07:22:38 INFO - Installing pip.................done. 07:22:38 INFO - Return code: 0 07:22:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:22: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')]} 07:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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')]} 07:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f957bfbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14140b0>, '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 0x1414fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415440>, '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': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', '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 07:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 07:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 07:22:38 INFO - Using env: {'DISPLAY': ':0', 07:22:38 INFO - 'HOME': '/home/cltbld', 07:22:38 INFO - 'LANG': 'en_US.UTF-8', 07:22:38 INFO - 'LANGUAGE': 'en_US:en', 07:22:38 INFO - 'LOGNAME': 'cltbld', 07:22:38 INFO - 'MAIL': '/var/mail/cltbld', 07:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:38 INFO - 'MOZ_NO_REMOTE': '1', 07:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:38 INFO - 'NO_EM_RESTART': '1', 07:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:38 INFO - 'PWD': '/builds/slave/test', 07:22:38 INFO - 'SHELL': '/bin/bash', 07:22:38 INFO - 'SHLVL': '1', 07:22:38 INFO - 'TERM': 'linux', 07:22:38 INFO - 'TMOUT': '86400', 07:22:38 INFO - 'USER': 'cltbld', 07:22:38 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', 07:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:38 INFO - '_': '/tools/buildbot/bin/python'} 07:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:38 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 07:22:38 INFO - Cleaning up... 07:22:38 INFO - Return code: 0 07:22:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:22: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')]} 07:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22: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')]} 07:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f957bfbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14140b0>, '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 0x1414fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415440>, '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': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', '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 07:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 07:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 07:22:38 INFO - Using env: {'DISPLAY': ':0', 07:22:38 INFO - 'HOME': '/home/cltbld', 07:22:38 INFO - 'LANG': 'en_US.UTF-8', 07:22:38 INFO - 'LANGUAGE': 'en_US:en', 07:22:38 INFO - 'LOGNAME': 'cltbld', 07:22:38 INFO - 'MAIL': '/var/mail/cltbld', 07:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:38 INFO - 'MOZ_NO_REMOTE': '1', 07:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:38 INFO - 'NO_EM_RESTART': '1', 07:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:38 INFO - 'PWD': '/builds/slave/test', 07:22:38 INFO - 'SHELL': '/bin/bash', 07:22:38 INFO - 'SHLVL': '1', 07:22:38 INFO - 'TERM': 'linux', 07:22:38 INFO - 'TMOUT': '86400', 07:22:38 INFO - 'USER': 'cltbld', 07:22:38 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', 07:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:38 INFO - '_': '/tools/buildbot/bin/python'} 07:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:39 INFO - Downloading/unpacking psutil>=0.7.1 07:22: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 07:22: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 07:22: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 07:22: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 07:22: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 07:22: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 07:22:40 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:22:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:22:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:22:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:22:40 INFO - Installing collected packages: psutil 07:22:40 INFO - Running setup.py install for psutil 07:22:40 INFO - building 'psutil._psutil_linux' extension 07:22:40 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 07:22:41 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 07:22:41 INFO - building 'psutil._psutil_posix' extension 07:22:41 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 07:22:41 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 07:22:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:22:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:22:41 INFO - Successfully installed psutil 07:22:41 INFO - Cleaning up... 07:22:41 INFO - Return code: 0 07:22:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:22:41 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')]} 07:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:41 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')]} 07:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f957bfbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14140b0>, '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 0x1414fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415440>, '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': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', '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 07:22:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 07:22:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 07:22:41 INFO - Using env: {'DISPLAY': ':0', 07:22:41 INFO - 'HOME': '/home/cltbld', 07:22:41 INFO - 'LANG': 'en_US.UTF-8', 07:22:41 INFO - 'LANGUAGE': 'en_US:en', 07:22:41 INFO - 'LOGNAME': 'cltbld', 07:22:41 INFO - 'MAIL': '/var/mail/cltbld', 07:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:41 INFO - 'MOZ_NO_REMOTE': '1', 07:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:41 INFO - 'NO_EM_RESTART': '1', 07:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:41 INFO - 'PWD': '/builds/slave/test', 07:22:41 INFO - 'SHELL': '/bin/bash', 07:22:41 INFO - 'SHLVL': '1', 07:22:41 INFO - 'TERM': 'linux', 07:22:41 INFO - 'TMOUT': '86400', 07:22:41 INFO - 'USER': 'cltbld', 07:22:41 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', 07:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:41 INFO - '_': '/tools/buildbot/bin/python'} 07:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:22:41 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 07:22:41 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 07:22:41 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 07:22:41 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 07:22:41 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 07:22:41 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 07:22:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:22:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:22:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:22:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:22:43 INFO - Installing collected packages: mozsystemmonitor 07:22:43 INFO - Running setup.py install for mozsystemmonitor 07:22:43 INFO - Successfully installed mozsystemmonitor 07:22:43 INFO - Cleaning up... 07:22:43 INFO - Return code: 0 07:22:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f957bfbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14140b0>, '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 0x1414fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415440>, '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': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', '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 07:22:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 07:22:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 07:22:43 INFO - Using env: {'DISPLAY': ':0', 07:22:43 INFO - 'HOME': '/home/cltbld', 07:22:43 INFO - 'LANG': 'en_US.UTF-8', 07:22:43 INFO - 'LANGUAGE': 'en_US:en', 07:22:43 INFO - 'LOGNAME': 'cltbld', 07:22:43 INFO - 'MAIL': '/var/mail/cltbld', 07:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:43 INFO - 'MOZ_NO_REMOTE': '1', 07:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:43 INFO - 'NO_EM_RESTART': '1', 07:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:43 INFO - 'PWD': '/builds/slave/test', 07:22:43 INFO - 'SHELL': '/bin/bash', 07:22:43 INFO - 'SHLVL': '1', 07:22:43 INFO - 'TERM': 'linux', 07:22:43 INFO - 'TMOUT': '86400', 07:22:43 INFO - 'USER': 'cltbld', 07:22:43 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', 07:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:43 INFO - '_': '/tools/buildbot/bin/python'} 07:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:43 INFO - Downloading/unpacking blobuploader==1.2.4 07:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:45 INFO - Downloading blobuploader-1.2.4.tar.gz 07:22:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:22:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:22: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 07:22: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 07:22: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 07:22: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 07:22: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 07:22: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 07:22:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:22:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:22: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 07:22: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 07:22: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 07:22: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 07:22: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 07:22: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 07:22:46 INFO - Downloading docopt-0.6.1.tar.gz 07:22:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:22:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:22:46 INFO - Installing collected packages: blobuploader, requests, docopt 07:22:46 INFO - Running setup.py install for blobuploader 07:22:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:22:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:22:46 INFO - Running setup.py install for requests 07:22:46 INFO - Running setup.py install for docopt 07:22:46 INFO - Successfully installed blobuploader requests docopt 07:22:46 INFO - Cleaning up... 07:22:46 INFO - Return code: 0 07:22:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f957bfbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14140b0>, '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 0x1414fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415440>, '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': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', '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 07:22:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 07:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 07:22:46 INFO - Using env: {'DISPLAY': ':0', 07:22:46 INFO - 'HOME': '/home/cltbld', 07:22:46 INFO - 'LANG': 'en_US.UTF-8', 07:22:46 INFO - 'LANGUAGE': 'en_US:en', 07:22:46 INFO - 'LOGNAME': 'cltbld', 07:22:46 INFO - 'MAIL': '/var/mail/cltbld', 07:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:46 INFO - 'MOZ_NO_REMOTE': '1', 07:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:46 INFO - 'NO_EM_RESTART': '1', 07:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:46 INFO - 'PWD': '/builds/slave/test', 07:22:46 INFO - 'SHELL': '/bin/bash', 07:22:46 INFO - 'SHLVL': '1', 07:22:46 INFO - 'TERM': 'linux', 07:22:46 INFO - 'TMOUT': '86400', 07:22:46 INFO - 'USER': 'cltbld', 07:22:46 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', 07:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:46 INFO - '_': '/tools/buildbot/bin/python'} 07:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:22:47 INFO - Running setup.py (path:/tmp/pip-2jIShO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:22:47 INFO - Running setup.py (path:/tmp/pip-aY1Ax9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:22:47 INFO - Running setup.py (path:/tmp/pip-hp710V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:22:47 INFO - Running setup.py (path:/tmp/pip-Hada4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:22:47 INFO - Running setup.py (path:/tmp/pip-3sd54e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:22:47 INFO - Running setup.py (path:/tmp/pip-qZv1g5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:22:47 INFO - Running setup.py (path:/tmp/pip-PIWUxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:22:47 INFO - Running setup.py (path:/tmp/pip-SuEEVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:22:47 INFO - Running setup.py (path:/tmp/pip-_K8vvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:22:47 INFO - Running setup.py (path:/tmp/pip-HDLlYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:22:47 INFO - Running setup.py (path:/tmp/pip-tKLLh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:22:47 INFO - Running setup.py (path:/tmp/pip-pgoBX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:22:47 INFO - Running setup.py (path:/tmp/pip-MCoGg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:22:48 INFO - Running setup.py (path:/tmp/pip-OUQ4me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:48 INFO - Running setup.py (path:/tmp/pip-BCh7_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:22:48 INFO - Running setup.py (path:/tmp/pip-Yd11iX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:22:48 INFO - Running setup.py (path:/tmp/pip-u0RWpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:22:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:22:48 INFO - Running setup.py install for manifestparser 07:22:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:22:48 INFO - Running setup.py install for mozcrash 07:22:48 INFO - Running setup.py install for mozdebug 07:22:48 INFO - Running setup.py install for mozdevice 07:22:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:22:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:22:48 INFO - Running setup.py install for mozfile 07:22:48 INFO - Running setup.py install for mozhttpd 07:22:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:22:48 INFO - Running setup.py install for mozinfo 07:22:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:22:49 INFO - Running setup.py install for mozInstall 07:22:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:22:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:22:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:22:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:22:49 INFO - Running setup.py install for mozleak 07:22:49 INFO - Running setup.py install for mozlog 07:22:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:22:49 INFO - Running setup.py install for moznetwork 07:22:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:22:49 INFO - Running setup.py install for mozprocess 07:22:49 INFO - Running setup.py install for mozprofile 07:22:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:22:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:22:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:22:49 INFO - Running setup.py install for mozrunner 07:22:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:22:49 INFO - Running setup.py install for mozscreenshot 07:22:49 INFO - Running setup.py install for moztest 07:22:49 INFO - Running setup.py install for mozversion 07:22:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:22:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:22:50 INFO - Cleaning up... 07:22:50 INFO - Return code: 0 07:22:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22:50 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')]} 07:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:50 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')]} 07:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f957bfbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14140b0>, '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 0x1414fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415440>, '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': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', '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 07:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 07:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 07:22:50 INFO - Using env: {'DISPLAY': ':0', 07:22:50 INFO - 'HOME': '/home/cltbld', 07:22:50 INFO - 'LANG': 'en_US.UTF-8', 07:22:50 INFO - 'LANGUAGE': 'en_US:en', 07:22:50 INFO - 'LOGNAME': 'cltbld', 07:22:50 INFO - 'MAIL': '/var/mail/cltbld', 07:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:50 INFO - 'MOZ_NO_REMOTE': '1', 07:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:50 INFO - 'NO_EM_RESTART': '1', 07:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:50 INFO - 'PWD': '/builds/slave/test', 07:22:50 INFO - 'SHELL': '/bin/bash', 07:22:50 INFO - 'SHLVL': '1', 07:22:50 INFO - 'TERM': 'linux', 07:22:50 INFO - 'TMOUT': '86400', 07:22:50 INFO - 'USER': 'cltbld', 07:22:50 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', 07:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:50 INFO - '_': '/tools/buildbot/bin/python'} 07:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:22:50 INFO - Running setup.py (path:/tmp/pip-CnMvg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:22:50 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)) 07:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:22:50 INFO - Running setup.py (path:/tmp/pip-iPP8IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 07:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:22:50 INFO - Running setup.py (path:/tmp/pip-CctGvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:22:50 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)) 07:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:22:50 INFO - Running setup.py (path:/tmp/pip-j8D959-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 07:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:22:50 INFO - Running setup.py (path:/tmp/pip-Z2CLCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:22:50 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)) 07:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:22:50 INFO - Running setup.py (path:/tmp/pip-RkB944-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:22:50 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)) 07:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:22:50 INFO - Running setup.py (path:/tmp/pip-SmVUfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:22:50 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)) 07:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:22:50 INFO - Running setup.py (path:/tmp/pip-QFtJ48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:22:50 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)) 07:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:22:50 INFO - Running setup.py (path:/tmp/pip-EOEwuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:22:50 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)) 07:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:22:50 INFO - Running setup.py (path:/tmp/pip-uP34k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:22:51 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)) 07:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:22:51 INFO - Running setup.py (path:/tmp/pip-8Kh_Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:22:51 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)) 07:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:22:51 INFO - Running setup.py (path:/tmp/pip-tU8bKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:22:51 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)) 07:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:22:51 INFO - Running setup.py (path:/tmp/pip-QBPsPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 07:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:22:51 INFO - Running setup.py (path:/tmp/pip-wYlGU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:22:51 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)) 07:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:51 INFO - Running setup.py (path:/tmp/pip-fC7aOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:22:51 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)) 07:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:22:51 INFO - Running setup.py (path:/tmp/pip-nZusn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:22:51 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)) 07:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:22:51 INFO - Running setup.py (path:/tmp/pip-wgk29h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:22:51 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)) 07:22:51 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:22:51 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:22:51 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)) 07:22:51 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:22:51 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:22:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:22:51 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 07:22:51 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 07:22:51 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 07:22:51 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 07:22:51 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 07:22:51 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 07:22:53 INFO - Downloading blessings-1.5.1.tar.gz 07:22:53 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 07:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:22:53 INFO - Installing collected packages: blessings 07:22:53 INFO - Running setup.py install for blessings 07:22:53 INFO - Successfully installed blessings 07:22:53 INFO - Cleaning up... 07:22:53 INFO - Return code: 0 07:22:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:22:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:22:53 INFO - Reading from file tmpfile_stdout 07:22:53 INFO - Current package versions: 07:22:53 INFO - argparse == 1.2.1 07:22:53 INFO - blessings == 1.5.1 07:22:53 INFO - blobuploader == 1.2.4 07:22:53 INFO - docopt == 0.6.1 07:22:53 INFO - manifestparser == 1.1 07:22:53 INFO - mozInstall == 1.12 07:22:53 INFO - mozcrash == 0.16 07:22:53 INFO - mozdebug == 0.1 07:22:53 INFO - mozdevice == 0.47 07:22:53 INFO - mozfile == 1.2 07:22:53 INFO - mozhttpd == 0.7 07:22:53 INFO - mozinfo == 0.9 07:22:53 INFO - mozleak == 0.1 07:22:53 INFO - mozlog == 3.1 07:22:53 INFO - moznetwork == 0.27 07:22:53 INFO - mozprocess == 0.22 07:22:53 INFO - mozprofile == 0.27 07:22:53 INFO - mozrunner == 6.11 07:22:53 INFO - mozscreenshot == 0.1 07:22:53 INFO - mozsystemmonitor == 0.0 07:22:53 INFO - moztest == 0.7 07:22:53 INFO - mozversion == 1.4 07:22:53 INFO - psutil == 3.1.1 07:22:53 INFO - requests == 1.2.3 07:22:53 INFO - wsgiref == 0.1.2 07:22:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f957bfbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14140b0>, '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 0x1414fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415440>, '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': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', '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 07:22:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 07:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 07:22:53 INFO - Using env: {'DISPLAY': ':0', 07:22:53 INFO - 'HOME': '/home/cltbld', 07:22:53 INFO - 'LANG': 'en_US.UTF-8', 07:22:53 INFO - 'LANGUAGE': 'en_US:en', 07:22:53 INFO - 'LOGNAME': 'cltbld', 07:22:53 INFO - 'MAIL': '/var/mail/cltbld', 07:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:53 INFO - 'MOZ_NO_REMOTE': '1', 07:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:53 INFO - 'NO_EM_RESTART': '1', 07:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:53 INFO - 'PWD': '/builds/slave/test', 07:22:53 INFO - 'SHELL': '/bin/bash', 07:22:53 INFO - 'SHLVL': '1', 07:22:53 INFO - 'TERM': 'linux', 07:22:53 INFO - 'TMOUT': '86400', 07:22:53 INFO - 'USER': 'cltbld', 07:22:53 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', 07:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:53 INFO - '_': '/tools/buildbot/bin/python'} 07:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:53 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 1)) 07:22:53 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 2)) 07:22:53 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 3)) 07:22:53 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 4)) 07:22:53 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 5)) 07:22:53 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 6)) 07:22:53 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 7)) 07:22:53 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 8)) 07:22:53 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:22:53 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 3)) 07:22:53 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:22:53 INFO - Cleaning up... 07:22:53 INFO - Return code: 0 07:22:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f957bfbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14140b0>, '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 0x1414fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415440>, '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': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', '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 07:22:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 07:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 07:22:53 INFO - Using env: {'DISPLAY': ':0', 07:22:53 INFO - 'HOME': '/home/cltbld', 07:22:53 INFO - 'LANG': 'en_US.UTF-8', 07:22:53 INFO - 'LANGUAGE': 'en_US:en', 07:22:53 INFO - 'LOGNAME': 'cltbld', 07:22:53 INFO - 'MAIL': '/var/mail/cltbld', 07:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:53 INFO - 'MOZ_NO_REMOTE': '1', 07:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:53 INFO - 'NO_EM_RESTART': '1', 07:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:53 INFO - 'PWD': '/builds/slave/test', 07:22:53 INFO - 'SHELL': '/bin/bash', 07:22:53 INFO - 'SHLVL': '1', 07:22:53 INFO - 'TERM': 'linux', 07:22:53 INFO - 'TMOUT': '86400', 07:22:53 INFO - 'USER': 'cltbld', 07:22:53 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', 07:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:53 INFO - '_': '/tools/buildbot/bin/python'} 07:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:54 INFO - Downloading/unpacking jsonschema 07:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:22:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:22:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 07:22:55 INFO - Downloading/unpacking functools32 (from jsonschema) 07:22:55 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 07:22:55 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 07:22:55 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 07:22:55 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 07:22:55 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 07:22:55 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 07:22:55 INFO - Downloading functools32-3.2.3-2.tar.gz 07:22:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:22:56 INFO - warning: no files found matching '*.txt' 07:22:56 INFO - no previously-included directories found matching 'build' 07:22:56 INFO - no previously-included directories found matching 'dist' 07:22:56 INFO - no previously-included directories found matching '.git*' 07:22:56 INFO - Installing collected packages: jsonschema, functools32 07:22:56 INFO - Running setup.py install for functools32 07:22:56 INFO - warning: no files found matching '*.txt' 07:22:56 INFO - no previously-included directories found matching 'build' 07:22:56 INFO - no previously-included directories found matching 'dist' 07:22:56 INFO - no previously-included directories found matching '.git*' 07:22:56 INFO - Successfully installed jsonschema functools32 07:22:56 INFO - Cleaning up... 07:22:56 INFO - Return code: 0 07:22:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:22:56 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')]} 07:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:56 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')]} 07:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:22:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f957bfbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1385240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14140b0>, '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 0x1414fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415440>, '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': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', '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 07:22:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 07:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 07:22:56 INFO - Using env: {'DISPLAY': ':0', 07:22:56 INFO - 'HOME': '/home/cltbld', 07:22:56 INFO - 'LANG': 'en_US.UTF-8', 07:22:56 INFO - 'LANGUAGE': 'en_US:en', 07:22:56 INFO - 'LOGNAME': 'cltbld', 07:22:56 INFO - 'MAIL': '/var/mail/cltbld', 07:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:22:56 INFO - 'MOZ_NO_REMOTE': '1', 07:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:22:56 INFO - 'NO_EM_RESTART': '1', 07:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:22:56 INFO - 'PWD': '/builds/slave/test', 07:22:56 INFO - 'SHELL': '/bin/bash', 07:22:56 INFO - 'SHLVL': '1', 07:22:56 INFO - 'TERM': 'linux', 07:22:56 INFO - 'TMOUT': '86400', 07:22:56 INFO - 'USER': 'cltbld', 07:22:56 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', 07:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:22:56 INFO - '_': '/tools/buildbot/bin/python'} 07:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:22:56 INFO - Downloading/unpacking flake8 07:22:56 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 07:22:56 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 07:22:56 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 07:22:56 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 07:22:56 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 07:22:56 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 07:22:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:22:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 07:22:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:22:58 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 07:22:58 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 07:22:58 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 07:22:58 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 07:22:58 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 07:22:58 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 07:22:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:22:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 07:22:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:22:58 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 07:22:58 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 07:22:58 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 07:22:58 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 07:22:58 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 07:22:58 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 07:22:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 07:22:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:22:58 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 07:22:58 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 07:22:58 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 07:22:58 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 07:22:58 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 07:22:58 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 07:22:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:22:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:22:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:22:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:22:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:22:58 INFO - no previously-included directories found matching 'docs/_build' 07:22:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:22:58 INFO - Running setup.py install for pep8 07:22:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:22:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:22:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:22:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:22:58 INFO - no previously-included directories found matching 'docs/_build' 07:22:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:22:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:22:58 INFO - Cleaning up... 07:22:58 INFO - Return code: 0 07:22:58 INFO - Running post-action listener: _resource_record_post_action 07:22:58 INFO - Running post-action listener: _start_resource_monitoring 07:22:59 INFO - Starting resource monitoring. 07:22:59 INFO - ##### 07:22:59 INFO - ##### Running install step. 07:22:59 INFO - ##### 07:22:59 INFO - Running pre-action listener: _resource_record_pre_action 07:22:59 INFO - Running main action method: install 07:22:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:22:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:22:59 INFO - Reading from file tmpfile_stdout 07:22:59 INFO - Detecting whether we're running mozinstall >=1.0... 07:22:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:22:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:22:59 INFO - Reading from file tmpfile_stdout 07:22:59 INFO - Output received: 07:22:59 INFO - Usage: mozinstall [options] installer 07:22:59 INFO - Options: 07:22:59 INFO - -h, --help show this help message and exit 07:22:59 INFO - -d DEST, --destination=DEST 07:22:59 INFO - Directory to install application into. [default: 07:22:59 INFO - "/builds/slave/test"] 07:22:59 INFO - --app=APP Application being installed. [default: firefox] 07:22:59 INFO - mkdir: /builds/slave/test/build/application 07:22:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:22:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:23:13 INFO - Reading from file tmpfile_stdout 07:23:13 INFO - Output received: 07:23:13 INFO - /builds/slave/test/build/application/firefox/firefox 07:23:13 INFO - Running post-action listener: _resource_record_post_action 07:23:13 INFO - ##### 07:23:13 INFO - ##### Running run-tests step. 07:23:13 INFO - ##### 07:23:13 INFO - Running pre-action listener: _resource_record_pre_action 07:23:13 INFO - Running main action method: run_tests 07:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:23:13 INFO - Python 2.7.3 07:23:13 INFO - Return code: 0 07:23:13 INFO - grabbing minidump binary from tooltool 07:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:23:13 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 0x14140b0>, '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 0x1414fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1415440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:23:13 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 07:23:13 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 07:23:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:23:13 INFO - Return code: 0 07:23:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:23:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:23:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:23:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:23:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:23:14 INFO - Return code: 0 07:23:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] in /builds/slave/test/build 07:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost 07:23:14 INFO - Using env: {'DISPLAY': ':0', 07:23:14 INFO - 'HOME': '/home/cltbld', 07:23:14 INFO - 'LANG': 'en_US.UTF-8', 07:23:14 INFO - 'LANGUAGE': 'en_US:en', 07:23:14 INFO - 'LOGNAME': 'cltbld', 07:23:14 INFO - 'MAIL': '/var/mail/cltbld', 07:23:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:23:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:14 INFO - 'MOZ_NO_REMOTE': '1', 07:23:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:14 INFO - 'NO_EM_RESTART': '1', 07:23:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:14 INFO - 'PWD': '/builds/slave/test', 07:23:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:23:14 INFO - 'SHELL': '/bin/bash', 07:23:14 INFO - 'SHLVL': '1', 07:23:14 INFO - 'TERM': 'linux', 07:23:14 INFO - 'TMOUT': '86400', 07:23:14 INFO - 'USER': 'cltbld', 07:23:14 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758', 07:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:14 INFO - '_': '/tools/buildbot/bin/python'} 07:23:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] with output_timeout 3600 07:23:15 INFO - mozversion INFO | application_buildid: 20151207055630 07:23:15 INFO - mozversion INFO | application_changeset: 59bc3c7a83de7ffb611203912a7da6ad84535a5a 07:23:15 INFO - mozversion INFO | application_display_name: Nightly 07:23:15 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:23:15 INFO - mozversion INFO | application_name: Firefox 07:23:15 INFO - mozversion INFO | application_remotingname: firefox 07:23:15 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:23:15 INFO - mozversion INFO | application_vendor: Mozilla 07:23:15 INFO - mozversion INFO | application_version: 45.0a1 07:23:15 INFO - mozversion INFO | platform_buildid: 20151207055630 07:23:15 INFO - mozversion INFO | platform_changeset: 59bc3c7a83de7ffb611203912a7da6ad84535a5a 07:23:15 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:23:15 INFO - mozversion INFO | platform_version: 45.0a1 07:23:15 INFO - 2015-12-07 07:23:15,025 DEBUG : using testdate: 1449501795 07:23:15 INFO - 2015-12-07 07:23:15,025 DEBUG : actual date: 1449501795 07:23:15 INFO - 2015-12-07 07:23:15,075 INFO : starting webserver on 'localhost:59142' 07:23:15 INFO - 2015-12-07 07:23:15,076 INFO : Starting test suite talos-linux64-ix-008 07:23:15 INFO - 2015-12-07 07:23:15,077 INFO : Starting test dromaeo_css 07:23:15 INFO - 2015-12-07 07:23:15,077 DEBUG : operating with platform_type : linux_ 07:23:15 INFO - 2015-12-07 07:23:15,077 INFO : Initialising browser for dromaeo_css test... 07:23:15 INFO - 2015-12-07 07:23:15,091 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr9Hu1m/profile http://localhost:59142/getInfo.html 07:23:19 INFO - 2015-12-07 07:23:19,591 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:23:19 INFO - 2015-12-07 07:23:19,591 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:23:19 INFO - 2015-12-07 07:23:19,591 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:23:19 INFO - 2015-12-07 07:23:19,592 DEBUG : BROWSER_OUTPUT: __metrics 07:23:19 INFO - 2015-12-07 07:23:19,673 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:23:19 INFO - 2015-12-07 07:23:19,734 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:23:20 INFO - 2015-12-07 07:23:20,511 INFO : Browser initialized. 07:23:20 INFO - 2015-12-07 07:23:20,511 INFO : Running cycle 1/1 for dromaeo_css test... 07:23:20 INFO - 2015-12-07 07:23:20,511 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr9Hu1m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:23:32 INFO - 2015-12-07 07:23:32,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 142307328 07:23:32 INFO - 2015-12-07 07:23:32,449 DEBUG : BROWSER_OUTPUT: 07:24:23 INFO - 2015-12-07 07:24:23,588 DEBUG : BROWSER_OUTPUT: 1449501863581 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] 07:26:35 INFO - 2015-12-07 07:26:35,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59142/tests/dromaeo/cssquery-ext.html) 07:26:36 INFO - 2015-12-07 07:26:36,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 252698624 07:26:36 INFO - 2015-12-07 07:26:36,618 DEBUG : BROWSER_OUTPUT: 07:29:39 INFO - 2015-12-07 07:29:39,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/dromaeo/cssquery-ext.html (next: http://localhost:59142/tests/dromaeo/cssquery-jquery.html) 07:29:39 INFO - 2015-12-07 07:29:39,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 221921280 07:29:39 INFO - 2015-12-07 07:29:39,658 DEBUG : BROWSER_OUTPUT: 07:32:41 INFO - 2015-12-07 07:32:41,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59142/tests/dromaeo/cssquery-mootools.html) 07:32:42 INFO - 2015-12-07 07:32:42,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 226062336 07:32:42 INFO - 2015-12-07 07:32:42,242 DEBUG : BROWSER_OUTPUT: 07:35:44 INFO - 2015-12-07 07:35:44,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59142/tests/dromaeo/cssquery-prototype.html) 07:35:44 INFO - 2015-12-07 07:35:44,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 202027008 07:35:44 INFO - 2015-12-07 07:35:44,704 DEBUG : BROWSER_OUTPUT: 07:38:47 INFO - 2015-12-07 07:38:47,418 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59142/tests/dromaeo/cssquery-yui.html) 07:38:48 INFO - 2015-12-07 07:38:48,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 181792768 07:38:48 INFO - 2015-12-07 07:38:48,004 DEBUG : BROWSER_OUTPUT: 07:41:50 INFO - 2015-12-07 07:41:50,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/dromaeo/cssquery-yui.html (next: http://localhost:59142/tests/dromaeo/cssquery-dojo.html) 07:41:50 INFO - 2015-12-07 07:41:50,771 DEBUG : BROWSER_OUTPUT: RSS: Main: 223391744 07:41:50 INFO - 2015-12-07 07:41:50,771 DEBUG : BROWSER_OUTPUT: 07:41:50 INFO - 2015-12-07 07:41:50,771 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:41:50 INFO - 2015-12-07 07:41:50,771 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:41:50 INFO - 2015-12-07 07:41:50,772 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:41:50 INFO - 2015-12-07 07:41:50,772 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:41:50 INFO - 2015-12-07 07:41:50,773 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2619.4368210834673;2712.4303896181814;2715.171872578865;2717.21200851753;2727.2363738153326;4456.888577785557;4541.841035563752;4589.770511474429;4595.264757638774;4617.284320930257;4527.320901864714;4532.2974938884445;4593.88515287118;4598.195315819735;4646.442426908776;4220.092680073783;4237.4491316129015;4282.807273672693;4328.199283132631;4343.1747967886;4133.214689209056;4299.914001719963;4314.223439780838;4359.69482136249;4392.253316936129;4160.812763425653;4253.44705188325;4255.744655320691;4256.957430425687;4260.850870219559;4245.915081698379;4280.486341638992;4282.743035417854;4299.1831552005015;4330.133973205371;4255.723377980421;4258.127083947814;4266.1254442839145;4274.038341373197;4319.438472998521;4399.098184872126;4456.64346852251;4509.864704058883;4519.977400113011;4574.679772415932;4960;4993.1262029144755;4997.800087996476;4998.425181104183;5035.471275516054;4996.375453068366;5002.899942001176;5013.573846223076;5013.949860501385;5015.673981191211;4423.51341352451;4493.640508759291;4517.887052823673;4519.864404067883;4650.139724151043;5103.362079740033;5105;5107.923381149286;5114.693118412907;5114.795408183631;4882.609391248691;4892.926606100911;4903.803847846046;4907.1903135982875;4946.060248552763;4738.1708201064675;4798.760061996886;4843.491433399513;4850.75746212688;4980.975095124573;4930.7288099154175;4933.950660493421;4942.258661200849;4945.9752701236985;4948.703077815343;4929.876753081202;4931.802727890916;4936.407631084221;4938.456769755324;4974.403071631427;3999.7200195986;4004.6796256299426;4070.2673518766906;4107.835686572564;4162.500499939966;3624.220792529619;3634.1823089804584;3649.6897763689853;3660.8352624131976;3665.596784353719;4317.719348242417;4322.0707547877355;4322.416473776;4325.97837010813;4358.36803663467;4810.6151507879285;4845.248986407112;4946.3817022872145;4947.233178857283;4970.502949705073;4293.205756934977;4301.354796780508;4317.481902171759;4318.136372725405;4351.477822661301;4413.051193993307;4413.558644135625;4414.3157810539415;4420.646348292194;4455.331700244924;4471.754053527022;4572.81708731647;4573.862784116482;4640.582347588733;4762.119007983465;4973.129702302155;4988.12707776145;4991.450940396626;4993.925091123709;5029.84910452687;4726.574608285271;4727.290906364073;4730.503297153887;4763.714177149243;4767.73777442244;4612.515685852937;4736.810527578996;4737.620990320835;4773.212419950669;4904.607631389552;4992.375953005874;5009.123403404463;5009.849704508871;5018.172001619838;5020.849374518771;4840.927386089282;4846.103470857903;4849.199882019569;4852.296417019442;4887.90224195507;4548.522405147544;4657;4659.58063774262;4669.696469729457;4877.512248775094;4676.836310729108;4686.906261874675;4689.812407503661;4690.765461726968;4690.953090469188;4738;4770.475247722818;4772.761361931959;4813.03739252144;4815.95184048155;4513.097380523974;4641.164590373765;4693.272542755878;4711.693739906895;4753.619710423227 07:41:50 INFO - 2015-12-07 07:41:50,774 DEBUG : BROWSER_OUTPUT: |1;ext.html;537.8359600321902;538.1980848535683;544.7957016118955;550.69161269689;552.4917076289813;24978.25065248043;35778;36515.634843651555;36522;36542.45186322207;39632;40024.39963400552;40076.19847603046;40101;40116.19767604646;6953.965230173842;7049.4712896532965;7675.385969122457;7832.412569057315;7834.255745704178;9898.703038908809;10150.390976541394;10152.492375381238;10157.898421015807;10165.440900750456;9884.654037108703;9962.900370996305;10007.749806254866;10010.349327293703;10016.799664006716;7187.604681742529;7367.410607151415;7378.114626244885;7381.224971378036;9890.258230632695;10002;10252.23108266883;10296.176305895511;10296.485175741258;10308.845367319496;36408.817955910316;36783.63216367829;36846.63153368459;36866;36870.44694329587;2657.4286528396296;2700.5004074246326;2758.1311886755807;3028.5457181422744;3083.9691603083907;27530.724692753018;27620.30949226265;27805.165845024683;27871;27978.580321294994;3369.6847826628036;3400.9149771255916;3401.540791993074;3459.4983727359645;3510.9297814043575;220669;221760;221945;222240;222316;54496.45503544914;55164;55302;55359;55361;54481.45518544843;56026.43973560294;65128.67435662791;66891.33108668949;67018.66490667613;13259.867401325862;13453.596392108253;13492.865071349357;13538.255395953318;13575.728485430236;9563.139317461322;9617.951910240545;9620;9633.614655413845;9644.18024467928;18795.718064229048;18820.623587528175;18993.43019709411;19035.61928761445;19068.523286917938;6881.89677154833;7155.248698886542;7177.461690373243;7184.892226616605;7209.0988626421695;808.458332916947;857.2028013947089;896.8074252867947;923.4505469245788;992.533509250651;25968.8701556491;26087.869560652074;26136.267372271413;26353.20940371792;26375.34061648474;923.9445633262026;956.0773853231526;975.1077763846143;975.8341082016075;1055.8521806947033;12361.752764944651;12559.93720031394;12664.430100645493;12667.429965651569;12670.619881403572;248427;250120;250899;251151;251167;44833;44981.32528012082;45049;45095.32357014647;45193.32210016852;1204.3496511883484;1210.878912108782;1221.3404761428728;1225.7609766095525;1231.9137660363688;23738.762612373655;25484.49031019406;27040.1887943362;27097.051603193795;27112.72887271102;35976;36410.63589364073;36658.63341366552;36728.449073263386;36749.26501470009;146984;247649;249965;252687;252864;25482;26186.607200892384;26227.213183604523;26247.21258362252;26274.4745105093;35968.64031359758;36023.63976360203;36928.44607330946;37754.8112259437;39982;32727;32798.34403311968;33496.497552536246;33866;34099.82950085333;31883.36233275275;32768.344633106724;33317.666823331456;33321.166970824954;33631.159221018694;30398.78337276114;30516.84741576278;32188.678113218568;32328.191795205308;32440;27814.86092569605;28169.859150704116;29013.129606111852;29481.262968425104;30007.399852003273;21396.465088372915;22720.886395567915;22953.655695164252;23017.424564385354;23064.654030189224 07:41:50 INFO - 2015-12-07 07:41:50,774 DEBUG : BROWSER_OUTPUT: |2;jquery.html;278.5278952176061;283.19290023433217;283.393537829046;285.7399766212748;288.8483546138277;11617.593384231554;15209.239538023096;15729.370825166994;15756.290966906488;17142.82857171431;9117.544122793866;9425.76435589109;9464.1482266596;15382.615434614112;15753.369865205377;4392.648588112959;4517.119161763458;4524.298733696282;4530.637548996073;4532.252178390561;4485.1254005468945;4490.730556166641;4495.460544734637;4499.347594598781;4504.1667291551;3454.481827725836;3532.5407696999355;4472.262076757331;4474.955250447487;4944.159492886218;5036.521530454601;5067.062593420211;5074.923876141861;5084.288199652052;5089.134847076006;4849.418069831608;4887.902241955177;4900.705957642553;5103.209002604565;5114.59083273341;17779.644407111915;17951.640967180585;18009.54976125594;18556;18570.90714546432;1814.8820326678724;1818.0909545227387;1842.3643842874187;1846.8799528030636;1879.0229080877866;8228.753137405827;8302.626381812834;8444.197801208875;8533.445326053787;8656.22094011542;1741.651669666072;1768.4429404737466;1815.9253375695048;1837.880537765041;1870.3453791173117;54268.18597721037;54851.72574137144;55079;56013.43986560123;56091.71954140244;9265.305102117234;9359.719208423758;9587.952060239653;9606.462965925419;9654.27592930533;12072.456739446747;12126.27242365461;12134.089943254292;12142.271463712206;12143.453544590338;6245.687715614201;6258.15514905491;6266.373362663697;6289.276733175652;6311.2426508819235;5830.650160990269;5983.401659834069;6046.2139921809885;6086.695665216722;6107.328193898667;3801.4487899254455;3858.2862170498547;3944.2308749793515;3964.1675248198203;4065.1869626074313;1503.8496150384874;1604.9679006419806;1607.1562429724254;1636.116497091581;1650.4058538925976;837.7193640130624;859.8151397449578;888.7244954064261;924.117467818232;963.3978763272954;13244.404001819941;15190.392384304725;15715.21423928799;15929.920350398173;16208.189590520427;836.8368168207263;843.2832092721138;851.4976164063108;870.656090844113;888.7689200807707;8943;9285.907140928504;9290.224829421688;9302;9364.204042656314;468731;470131;472568;483983;490306;66870;69542.65228673824;69594.65202674056;70371.88884333477;71250;998.1415982255255;1007.0986467111894;1009.9596016159271;1015.6394479959508;1020.1787561013307;13755.862441375459;14173.716525669635;14367.928160359132;14456;14482.34829432657;33881.25662407314;34295.48556771601;34726.65273347234;34936.825315874274;35546.46680299849;39948.80025599853;40876.386854196615;41452.58547414487;42002.369964451165;42693.78653106715;8306.70926517569;8480.575971201539;8700;8716.128387161232;8729;10201.897981020094;10294.279400441897;12330.321832299309;15998.68002639964;16300.42948496797;13693;13786.862131378557;13795.172289662652;13838.723225535232;13929.791053134413;12969.157004795035;13121.475140994253;13627.931860341032;13650.249236291702;13808.309584520533;10301.227407944285;10584.576616935236;13291.534796282083;13436.93281533586;13581.932090339486;8695.217430431292;8825;8829.38194326391;8891.422057566237;8914.687985920462;13445.327733613085;13718.108322958975;13830.515931942333;14029.579112626638;14030.158190508193 07:41:50 INFO - 2015-12-07 07:41:50,776 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1389.6595334143124;1606.4377467886238;1647.34106357457;1657.1217254854923;1675.82403847596;5814.738336774844;6816.55692379995;7041.894371584431;7083.610401427919;7087.433005359571;6833.65831708415;7072.540284881492;7123.715051397938;7123.750668726596;7126.608036557987;2051.4871282179456;2080.854340196187;2084.2809230815346;2084.301758910759;2086.175960495611;2058.3824852544253;2086.5096702274955;2096.7903209678984;2100.9264675736354;2104.7895210478982;2001.8398528117789;2018.8384929205702;2029.8782073075663;2030.7461567304088;2039.6226698060907;2026.493376655836;2047.0276618606192;2049.1700861151257;2050.4873781554684;2054.168061934904;2021.3228568429595;2049.7950204979384;2050.98974505128;2052.097077286004;2072.4404410809148;7012.964935175291;7089.7873063808165;7090.610016449094;7099.254578269259;7105;4044.9393259100843;4087.2847251731127;4100.077482566428;4114.691398145121;4127.711060225785;2634.2624065261757;2636.6440530528325;2666.533356662596;2698.2040298112106;2712.199901029201;842.7598134531629;847.5507980770202;851.6252848746532;863.6890719341033;867.4665080975218;9550.092741189575;9551.044895510462;9565.186959108414;9565.37825041377;9576.952115239448;3643.763155394891;3655.360311945452;3689.2805902848686;3729.4592284119194;3732.496113024707;8239.711610093618;8242.505449673039;8244.793880153044;8246.422750407533;8249.340052795762;4101.384792281122;4113.424120623115;4113.547509773923;4126.484189476316;4136.069384388548;3098.148009297461;3173.254285242966;3520.2607452434763;3768.8304026318333;3779.5842457329672;3307.851146698404;3351;3373.4265174920324;3385.4752513360468;3394.3890099782275;1065.1159537583787;1074.4949873559415;1076.0692001418715;1081.6322450366913;1083.5178345636116;941.5762906691879;972.2027937091517;1165.9591914283128;1182.4442512019336;1183.4260383714063;6612.107365505692;6684.632345220963;6687.598744075371;6708.2956289589865;6712.798616041527;1020.78563501664;1024.5082360466868;1024.6618615856748;1027.2963020331097;1063.0910571461443;5032.446430892599;5068.746562671851;5072.442031376546;5078.873028174326;5097.158968770112;8285.50286982771;8321.08468068512;8461.11158328379;8493.702720404755;8522.403431759718;8343.290820280345;8356.28971537414;8419.452735572168;8465.788355291166;8473.788155296166;6631.9388897776125;6747.696353664097;6830.146231721035;6833.760818371333;6845.383915447634;6426.839329016812;6456.741730330734;6460.580062295936;6460.612363258219;6461.418472337512;7606.581638009741;7665.195154508696;7711.691532338644;7733;7820;7699.615019248903;7854.1360450349275;8063.153368896416;8104.5137291762685;8124.187581241828;5090.592752579859;5104.795808167781;5941.31674857397;6017.819465416044;6025.337212906665;6333.271673757393;6512.251091124392;6513.8697226056165;6523.021546768023;6578.835529111619;6324.778632747832;6473.514486413444;6477;6513.576617519846;6554.115194448688;6170.81487555374;6236.189295391751;6263.530235232467;6299.685015749286;6336.239651241881;6097.695115244309;6130.233720784902;6130.816075517741;6139.662318572521;6148.262208535004;5750.741216645345;5794.1308803679785;5814.273215848019;5815.621984570989;5816.47651711348;5787.508061814625;5796.536277097738;5800.738966746591;5805.129230615442;5818.0981947798155 07:41:50 INFO - 2015-12-07 07:41:50,777 DEBUG : BROWSER_OUTPUT: |4;prototype.html;256.9447568772714;260.36211282358215;261.70950245227806;263.12510901253324;264.59120658582486;5246.449122842099;5280.445553216905;5304.867378315544;5308.23030660554;5316.2291467737205;5107.642465027449;5190.922136167951;5271.130263506527;5285.6300058995885;5286.894262114755;3767.1147280389223;3872.5546562145432;3892.5912779158207;3906.3749800032;4005.799710014495;3978.9602103978877;3995;4011.438398624195;4013.6387725104737;4016.5581786003518;3952.6837852971835;3956.703247256453;3967.7024223183375;3972.9404058938994;3978.622030907059;3752.230792687506;3813.0848596336955;3830.731848770587;3919.2945269851416;3967.5834037425943;3381;3384.3908096542614;3402.8808991685173;3406.897793066187;3407.6251612322626;5142.717150556718;5145.022445735298;5150.459201783834;5152.252923326134;5159.071367153911;4547.886302842456;4553.521880202564;4559.4072770539615;4561.498235194126;4563.087382523476;5437.728113594305;5551.528120109796;5560.193771903092;5567.47109024642;5574.358948720908;3691.7231207659265;3696.5564132304025;3697.1681371691425;3698.5746639136573;3701.648343407372;5793.4785869271545;5882.176495290662;5884.941150588482;5891.351951285355;5891.734871930774;3786.753860999026;3788.431735239681;3790.090378309186;3795.449659799314;3800.7149463790324;3741.1738856874326;3846.74996125251;3848.9615103848605;3852.114013776791;3852.4221366794645;4516.164509565675;4522.34426008227;4524.140413321458;4527.524609915978;4531.071130418256;5589;5599.592175364633;5602.243697100921;5605.495505404533;5607.214989901417;1333.4732780551628;1355.4645914863574;1355.735631551838;1355.9661008474868;1359.1097830920762;865.1737590601086;866.8786369908217;874.5452364770284;887.2901678657048;890.6615486115235;4957.256411538226;4968.577670898014;4972.129877271463;4972.825951091694;4974.452810190876;5827.388124246978;5834.183214349994;5837.678927658934;5842.707864606753;5846.970765146147;4966.528179822911;4967.05625931072;4970.304157417964;4973.626977976666;4974.8756281093265;3061.678523755018;3109.657937626859;3124.078396872928;3126.531020346966;3139.01121146838;5561.582881283839;5566.944330556643;5567.248421463131;5576.0241957657245;5577.05190117681;6040.577159598874;6057.151998720183;6060.090986352083;6061.605995610271;6062.9090563641585;5519.806806761824;5561.165825126182;5564.888702226014;5565.888682226414;5567;5647.040003199384;5809.186713859978;5861.648301101947;5871.089981052944;5871.383504732113;5730.570207234391;5740.167675687086;5744.597878148489;5747.252857128714;5755.136729490442;5532.612717109763;5541.5289700375915;5545.694986775766;5548.69482178484;5550.58370622213;3659.1949771050326;3750.868719594801;3777.905552361103;3826.9043273918373;3828.1003964068977;5675.971620141873;5729.427057294237;5743;5817.825465236049;5821.185034095145;5601.80393686219;5610.438956104357;5610.859728506657;5612.831615051555;5615.775368985195;5597.160425936142;5603.243562119062;5606;5607.467290607386;5612.466815652507;5381.650192737459;5552.583556233218;5552.666839989613;5555.250041244381;5558.221848941071;5421.2681288025615;5594.944050559442;5677.971610141923;5689.743961521659;5694.886102277848;5422.376426710979;5546.140348246028;5575.080111781511;5576.358718747396;5579.525740312119 07:41:50 INFO - 2015-12-07 07:41:50,777 DEBUG : BROWSER_OUTPUT: |5;yui.html;618.879318532886;650.2944305428609;735.7829440315109;744.7281742164112;751.9135299440566;10948.124150067995;11013.559457621686;11169.329840209593;11192.832107518394;11197.720056998569;10960.725981850457;11059.391733454657;11065.391403472806;11075.778484430306;11076.058535024513;580.306533692238;605.7637521366671;766.5822126940831;767.5931756169225;795.7851380127362;785.4855069929177;786.3984052200071;790.6125998260868;792.43341011177;792.7066985215479;630.5743623054443;821.6220538552243;822.3955392786297;828.3414685325181;828.7265202483167;640.5836206465788;805.7985503624094;811.8335741173046;820.2084987986561;821.6097353756977;609.9359567245419;610.3347351386965;610.4658423879106;610.5207412181461;610.8595023144702;11945;12036.879631203663;12052.096092793076;12074.335911524862;12085;10930.56277748889;11076.556937722562;11705.239159454693;11724.765504689944;11821;8721.127887211229;8735.1701588349;8744.825103497958;8838.558072096434;9059.864102038475;3282.0646115856866;3317.10438181692;3318.386098571772;3321.2029113012704;3321.8671253149846;38856.41715374272;38896;39126.80436597799;39133.804330978164;39200.803995980124;9389.154976052188;9464.1009104135;9517.666881659108;9610.231181505464;9687.467189304514;16787.076710781024;16811.579710507336;16874.831251687327;16935.830641693425;16977.151142442828;6196.907046394308;6441.355864413615;6464.903026454607;6466.321036291216;6621.86756264872;3454.9827250863586;3472.0278322069357;3565.928681426357;3612.548431446069;3618.2763447310117;2498.4753201827457;2538.1243471002476;2540.872956352175;2542.5931850904135;2545.8090643201836;459.7816037382217;467.04489319342025;467.14512442230637;468.2437862851538;472.7519348918857;553.9639923405047;561.4469747298907;562.1174755633616;566.0712874417105;593.5394371779645;7010.474214433938;7173.533720308267;7299.635018249066;7412.332890039922;8699.869501957475;522.6054328981595;524.3765579843265;576.2336092996305;588.2352941176539;597.2325561653255;3403.3193361327835;3509.5437593112733;3918.8824335269987;3926.1166237596312;3935.5670876203594;43921.560784392386;46446.767766160956;47110.76444617755;47131.29303060457;47973.76013119982;39262.4110638335;39324;39336;39576.40635390471;39689;37478.25043499115;38485;38915.2216955665;38939.41590876139;39000.6099938997;7830.725924592612;7838.372930165459;7952.880706789287;8142.145074767301;8594.78513037179;32842.83578582092;32884.177895552806;33125;33401.83299083489;33551;37263.62736372602;37299.254014920094;37595.49618015358;37753.433698493995;38479.23041539098;9724.805503889742;9747.951260243937;10004.899951000689;10015.39907605546;10050.49747512636;10683.465826708789;11054.557817687524;11055.668329950115;11161.665150045512;11380.886191138314;10138.6451474201;10528.894711053097;10545.630902918361;10819.729506762395;11317.547298107984;10146.594136234764;10519.211059170746;10601.416922069051;10613.681589552325;10697.14422846155;7853.060252441212;9575.856362154713;10050;10055.74860628461;10117.79764404693;8712.303015758851;8750.343724220582;8806.181520037713;9328.580213890256;9600.807983840145;8714.259287960595;8868.246199073152;9005.414648047856;9121.498317592595;9227.492487913229 07:41:50 INFO - 2015-12-07 07:41:50,777 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:41:50 INFO - 2015-12-07 07:41:50,777 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:41:50 INFO - 2015-12-07 07:41:50,777 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1011 07:41:50 INFO - 2015-12-07 07:41:50,778 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:41:50 INFO - 2015-12-07 07:41:50,778 DEBUG : BROWSER_OUTPUT: __startTimestamp1449502910771__endTimestamp 07:41:50 INFO - 2015-12-07 07:41:50,778 DEBUG : BROWSER_OUTPUT: 07:41:50 INFO - 2015-12-07 07:41:50,778 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:41:50 INFO - 2015-12-07 07:41:50,778 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:41:50 INFO - 2015-12-07 07:41:50,778 DEBUG : BROWSER_OUTPUT: 07:41:50 INFO - 2015-12-07 07:41:50,778 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4558.89 Median:4650.14 stddev:465.66 (10.0%) stddev-sans-first:441.53 07:41:50 INFO - 2015-12-07 07:41:50,780 DEBUG : BROWSER_OUTPUT: Values: 2619.4 2712.4 2715.2 2717.2 2727.2 4456.9 4541.8 4589.8 4595.3 4617.3 4527.3 4532.3 4593.9 4598.2 4646.4 4220.1 4237.4 4282.8 4328.2 4343.2 4133.2 4299.9 4314.2 4359.7 4392.3 4160.8 4253.4 4255.7 4257.0 4260.9 4245.9 4280.5 4282.7 4299.2 4330.1 4255.7 4258.1 4266.1 4274.0 4319.4 4399.1 4456.6 4509.9 4520.0 4574.7 4960.0 4993.1 4997.8 4998.4 5035.5 4996.4 5002.9 5013.6 5013.9 5015.7 4423.5 4493.6 4517.9 4519.9 4650.1 5103.4 5105.0 5107.9 5114.7 5114.8 4882.6 4892.9 4903.8 4907.2 4946.1 4738.2 4798.8 4843.5 4850.8 4981.0 4930.7 4934.0 4942.3 4946.0 4948.7 4929.9 4931.8 4936.4 4938.5 4974.4 3999.7 4004.7 4070.3 4107.8 4162.5 3624.2 3634.2 3649.7 3660.8 3665.6 4317.7 4322.1 4322.4 4326.0 4358.4 4810.6 4845.2 4946.4 4947.2 4970.5 4293.2 4301.4 4317.5 4318.1 4351.5 4413.1 4413.6 4414.3 4420.6 4455.3 4471.8 4572.8 4573.9 4640.6 4762.1 4973.1 4988.1 4991.5 4993.9 5029.8 4726.6 4727.3 4730.5 4763.7 4767.7 4612.5 4736.8 4737.6 4773.2 4904.6 4992.4 5009.1 5009.8 5018.2 5020.8 4840.9 4846.1 4849.2 4852.3 4887.9 4548.5 4657.0 4659.6 4669.7 4877.5 4676.8 4686.9 4689.8 4690.8 4691.0 4738.0 4770.5 4772.8 4813.0 4816.0 4513.1 4641.2 4693.3 4711.7 4753.6 07:41:50 INFO - 2015-12-07 07:41:50,780 DEBUG : BROWSER_OUTPUT: 07:41:50 INFO - 2015-12-07 07:41:50,780 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39493.44 Median:32747.67 stddev:61364.52 (187.4%) stddev-sans-first:61466.95 07:41:50 INFO - 2015-12-07 07:41:50,780 DEBUG : BROWSER_OUTPUT: Values: 537.8 538.2 544.8 550.7 552.5 24978.3 35778.0 36515.6 36522.0 36542.5 39632.0 40024.4 40076.2 40101.0 40116.2 6954.0 7049.5 7675.4 7832.4 7834.3 9898.7 10150.4 10152.5 10157.9 10165.4 9884.7 9962.9 10007.7 10010.3 10016.8 7187.6 7367.4 7378.1 7381.2 9890.3 10002.0 10252.2 10296.2 10296.5 10308.8 36408.8 36783.6 36846.6 36866.0 36870.4 2657.4 2700.5 2758.1 3028.5 3084.0 27530.7 27620.3 27805.2 27871.0 27978.6 3369.7 3400.9 3401.5 3459.5 3510.9 220669.0 221760.0 221945.0 222240.0 222316.0 54496.5 55164.0 55302.0 55359.0 55361.0 54481.5 56026.4 65128.7 66891.3 67018.7 13259.9 13453.6 13492.9 13538.3 13575.7 9563.1 9618.0 9620.0 9633.6 9644.2 18795.7 18820.6 18993.4 19035.6 19068.5 6881.9 7155.2 7177.5 7184.9 7209.1 808.5 857.2 896.8 923.5 992.5 25968.9 26087.9 26136.3 26353.2 26375.3 923.9 956.1 975.1 975.8 1055.9 12361.8 12559.9 12664.4 12667.4 12670.6 248427.0 250120.0 250899.0 251151.0 251167.0 44833.0 44981.3 45049.0 45095.3 45193.3 1204.3 1210.9 1221.3 1225.8 1231.9 23738.8 25484.5 27040.2 27097.1 27112.7 35976.0 36410.6 36658.6 36728.4 36749.3 146984.0 247649.0 249965.0 252687.0 252864.0 25482.0 26186.6 26227.2 26247.2 26274.5 35968.6 36023.6 36928.4 37754.8 39982.0 32727.0 32798.3 33496.5 33866.0 34099.8 31883.4 32768.3 33317.7 33321.2 33631.2 30398.8 30516.8 32188.7 32328.2 32440.0 27814.9 28169.9 29013.1 29481.3 30007.4 21396.5 22720.9 22953.7 23017.4 23064.7 07:41:50 INFO - 2015-12-07 07:41:50,780 DEBUG : BROWSER_OUTPUT: 07:41:50 INFO - 2015-12-07 07:41:50,780 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25648.45 Median:41727.48 stddev:77973.46 (186.9%) stddev-sans-first:78168.92 07:41:50 INFO - 2015-12-07 07:41:50,780 DEBUG : BROWSER_OUTPUT: Values: 278.5 283.2 283.4 285.7 288.8 11617.6 15209.2 15729.4 15756.3 17142.8 9117.5 9425.8 9464.1 15382.6 15753.4 4392.6 4517.1 4524.3 4530.6 4532.3 4485.1 4490.7 4495.5 4499.3 4504.2 3454.5 3532.5 4472.3 4475.0 4944.2 5036.5 5067.1 5074.9 5084.3 5089.1 4849.4 4887.9 4900.7 5103.2 5114.6 17779.6 17951.6 18009.5 18556.0 18570.9 1814.9 1818.1 1842.4 1846.9 1879.0 8228.8 8302.6 8444.2 8533.4 8656.2 1741.7 1768.4 1815.9 1837.9 1870.3 54268.2 54851.7 55079.0 56013.4 56091.7 9265.3 9359.7 9588.0 9606.5 9654.3 12072.5 12126.3 12134.1 12142.3 12143.5 6245.7 6258.2 6266.4 6289.3 6311.2 5830.7 5983.4 6046.2 6086.7 6107.3 3801.4 3858.3 3944.2 3964.2 4065.2 1503.8 1605.0 1607.2 1636.1 1650.4 837.7 859.8 888.7 924.1 963.4 13244.4 15190.4 15715.2 15929.9 16208.2 836.8 843.3 851.5 870.7 888.8 8943.0 9285.9 9290.2 9302.0 9364.2 468731.0 470131.0 472568.0 483983.0 490306.0 66870.0 69542.7 69594.7 70371.9 71250.0 998.1 1007.1 1010.0 1015.6 1020.2 13755.9 14173.7 14367.9 14456.0 14482.3 33881.3 34295.5 34726.7 34936.8 35546.5 39948.8 40876.4 41452.6 42002.4 42693.8 8306.7 8480.6 8700.0 8716.1 8729.0 10201.9 10294.3 12330.3 15998.7 16300.4 13693.0 13786.9 13795.2 13838.7 13929.8 12969.2 13121.5 13627.9 13650.2 13808.3 10301.2 10584.6 13291.5 13436.9 13581.9 8695.2 8825.0 8829.4 8891.4 8914.7 13445.3 13718.1 13830.5 14029.6 14030.2 07:41:50 INFO - 2015-12-07 07:41:50,781 DEBUG : BROWSER_OUTPUT: 07:41:50 INFO - 2015-12-07 07:41:50,781 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4892.26 Median:5879.71 stddev:2545.73 (43.3%) stddev-sans-first:2539.26 07:41:50 INFO - 2015-12-07 07:41:50,782 DEBUG : BROWSER_OUTPUT: Values: 1389.7 1606.4 1647.3 1657.1 1675.8 5814.7 6816.6 7041.9 7083.6 7087.4 6833.7 7072.5 7123.7 7123.8 7126.6 2051.5 2080.9 2084.3 2084.3 2086.2 2058.4 2086.5 2096.8 2100.9 2104.8 2001.8 2018.8 2029.9 2030.7 2039.6 2026.5 2047.0 2049.2 2050.5 2054.2 2021.3 2049.8 2051.0 2052.1 2072.4 7013.0 7089.8 7090.6 7099.3 7105.0 4044.9 4087.3 4100.1 4114.7 4127.7 2634.3 2636.6 2666.5 2698.2 2712.2 842.8 847.6 851.6 863.7 867.5 9550.1 9551.0 9565.2 9565.4 9577.0 3643.8 3655.4 3689.3 3729.5 3732.5 8239.7 8242.5 8244.8 8246.4 8249.3 4101.4 4113.4 4113.5 4126.5 4136.1 3098.1 3173.3 3520.3 3768.8 3779.6 3307.9 3351.0 3373.4 3385.5 3394.4 1065.1 1074.5 1076.1 1081.6 1083.5 941.6 972.2 1166.0 1182.4 1183.4 6612.1 6684.6 6687.6 6708.3 6712.8 1020.8 1024.5 1024.7 1027.3 1063.1 5032.4 5068.7 5072.4 5078.9 5097.2 8285.5 8321.1 8461.1 8493.7 8522.4 8343.3 8356.3 8419.5 8465.8 8473.8 6631.9 6747.7 6830.1 6833.8 6845.4 6426.8 6456.7 6460.6 6460.6 6461.4 7606.6 7665.2 7711.7 7733.0 7820.0 7699.6 7854.1 8063.2 8104.5 8124.2 5090.6 5104.8 5941.3 6017.8 6025.3 6333.3 6512.3 6513.9 6523.0 6578.8 6324.8 6473.5 6477.0 6513.6 6554.1 6170.8 6236.2 6263.5 6299.7 6336.2 6097.7 6130.2 6130.8 6139.7 6148.3 5750.7 5794.1 5814.3 5815.6 5816.5 5787.5 5796.5 5800.7 5805.1 5818.1 07:41:50 INFO - 2015-12-07 07:41:50,782 DEBUG : BROWSER_OUTPUT: 07:41:50 INFO - 2015-12-07 07:41:50,782 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4590.72 Median:5286.26 stddev:1415.98 (26.8%) stddev-sans-first:1382.09 07:41:50 INFO - 2015-12-07 07:41:50,782 DEBUG : BROWSER_OUTPUT: Values: 256.9 260.4 261.7 263.1 264.6 5246.4 5280.4 5304.9 5308.2 5316.2 5107.6 5190.9 5271.1 5285.6 5286.9 3767.1 3872.6 3892.6 3906.4 4005.8 3979.0 3995.0 4011.4 4013.6 4016.6 3952.7 3956.7 3967.7 3972.9 3978.6 3752.2 3813.1 3830.7 3919.3 3967.6 3381.0 3384.4 3402.9 3406.9 3407.6 5142.7 5145.0 5150.5 5152.3 5159.1 4547.9 4553.5 4559.4 4561.5 4563.1 5437.7 5551.5 5560.2 5567.5 5574.4 3691.7 3696.6 3697.2 3698.6 3701.6 5793.5 5882.2 5884.9 5891.4 5891.7 3786.8 3788.4 3790.1 3795.4 3800.7 3741.2 3846.7 3849.0 3852.1 3852.4 4516.2 4522.3 4524.1 4527.5 4531.1 5589.0 5599.6 5602.2 5605.5 5607.2 1333.5 1355.5 1355.7 1356.0 1359.1 865.2 866.9 874.5 887.3 890.7 4957.3 4968.6 4972.1 4972.8 4974.5 5827.4 5834.2 5837.7 5842.7 5847.0 4966.5 4967.1 4970.3 4973.6 4974.9 3061.7 3109.7 3124.1 3126.5 3139.0 5561.6 5566.9 5567.2 5576.0 5577.1 6040.6 6057.2 6060.1 6061.6 6062.9 5519.8 5561.2 5564.9 5565.9 5567.0 5647.0 5809.2 5861.6 5871.1 5871.4 5730.6 5740.2 5744.6 5747.3 5755.1 5532.6 5541.5 5545.7 5548.7 5550.6 3659.2 3750.9 3777.9 3826.9 3828.1 5676.0 5729.4 5743.0 5817.8 5821.2 5601.8 5610.4 5610.9 5612.8 5615.8 5597.2 5603.2 5606.0 5607.5 5612.5 5381.7 5552.6 5552.7 5555.3 5558.2 5421.3 5594.9 5678.0 5689.7 5694.9 5422.4 5546.1 5575.1 5576.4 5579.5 07:41:50 INFO - 2015-12-07 07:41:50,782 DEBUG : BROWSER_OUTPUT: 07:41:50 INFO - 2015-12-07 07:41:50,783 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11836.56 Median:41805.28 stddev:13048.19 (31.2%) stddev-sans-first:13057.60 07:41:50 INFO - 2015-12-07 07:41:50,783 DEBUG : BROWSER_OUTPUT: Values: 618.9 650.3 735.8 744.7 751.9 10948.1 11013.6 11169.3 11192.8 11197.7 10960.7 11059.4 11065.4 11075.8 11076.1 580.3 605.8 766.6 767.6 795.8 785.5 786.4 790.6 792.4 792.7 630.6 821.6 822.4 828.3 828.7 640.6 805.8 811.8 820.2 821.6 609.9 610.3 610.5 610.5 610.9 11945.0 12036.9 12052.1 12074.3 12085.0 10930.6 11076.6 11705.2 11724.8 11821.0 8721.1 8735.2 8744.8 8838.6 9059.9 3282.1 3317.1 3318.4 3321.2 3321.9 38856.4 38896.0 39126.8 39133.8 39200.8 9389.2 9464.1 9517.7 9610.2 9687.5 16787.1 16811.6 16874.8 16935.8 16977.2 6196.9 6441.4 6464.9 6466.3 6621.9 3455.0 3472.0 3565.9 3612.5 3618.3 2498.5 2538.1 2540.9 2542.6 2545.8 459.8 467.0 467.1 468.2 472.8 554.0 561.4 562.1 566.1 593.5 7010.5 7173.5 7299.6 7412.3 8699.9 522.6 524.4 576.2 588.2 597.2 3403.3 3509.5 3918.9 3926.1 3935.6 43921.6 46446.8 47110.8 47131.3 47973.8 39262.4 39324.0 39336.0 39576.4 39689.0 37478.3 38485.0 38915.2 38939.4 39000.6 7830.7 7838.4 7952.9 8142.1 8594.8 32842.8 32884.2 33125.0 33401.8 33551.0 37263.6 37299.3 37595.5 37753.4 38479.2 9724.8 9748.0 10004.9 10015.4 10050.5 10683.5 11054.6 11055.7 11161.7 11380.9 10138.6 10528.9 10545.6 10819.7 11317.5 10146.6 10519.2 10601.4 10613.7 10697.1 7853.1 9575.9 10050.0 10055.7 10117.8 8712.3 8750.3 8806.2 9328.6 9600.8 8714.3 8868.2 9005.4 9121.5 9227.5 07:41:50 INFO - 2015-12-07 07:41:50,783 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:41:50 INFO - 2015-12-07 07:41:50,783 DEBUG : BROWSER_OUTPUT: 07:41:51 INFO - 2015-12-07 07:41:51,446 INFO : Browser exited with error code: 0 07:41:51 INFO - 2015-12-07 07:41:51,466 INFO : Completed test dromaeo_css (00:18:36) 07:41:51 INFO - 2015-12-07 07:41:51,466 INFO : Starting test kraken 07:41:51 INFO - 2015-12-07 07:41:51,467 DEBUG : operating with platform_type : linux_ 07:41:51 INFO - 2015-12-07 07:41:51,467 INFO : Initialising browser for kraken test... 07:41:51 INFO - 2015-12-07 07:41:51,473 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpioHJ5n/profile http://localhost:59142/getInfo.html 07:41:55 INFO - 2015-12-07 07:41:55,390 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:41:55 INFO - 2015-12-07 07:41:55,390 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:41:55 INFO - 2015-12-07 07:41:55,390 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:41:55 INFO - 2015-12-07 07:41:55,390 DEBUG : BROWSER_OUTPUT: __metrics 07:41:55 INFO - 2015-12-07 07:41:55,547 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:41:55 INFO - 2015-12-07 07:41:55,628 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:41:56 INFO - 2015-12-07 07:41:56,692 INFO : Browser initialized. 07:41:56 INFO - 2015-12-07 07:41:56,692 INFO : Running cycle 1/1 for kraken test... 07:41:56 INFO - 2015-12-07 07:41:56,693 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpioHJ5n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:42:08 INFO - 2015-12-07 07:42:08,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 142807040 07:42:08 INFO - 2015-12-07 07:42:08,683 DEBUG : BROWSER_OUTPUT: 07:42:11 INFO - 2015-12-07 07:42:11,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59142/tests/kraken/driver.html?testName=audio-beat-detection) 07:42:11 INFO - 2015-12-07 07:42:11,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 180273152 07:42:11 INFO - 2015-12-07 07:42:11,890 DEBUG : BROWSER_OUTPUT: 07:42:14 INFO - 2015-12-07 07:42:14,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59142/tests/kraken/driver.html?testName=audio-dft) 07:42:15 INFO - 2015-12-07 07:42:15,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 168812544 07:42:15 INFO - 2015-12-07 07:42:15,166 DEBUG : BROWSER_OUTPUT: 07:42:18 INFO - 2015-12-07 07:42:18,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59142/tests/kraken/driver.html?testName=audio-fft) 07:42:18 INFO - 2015-12-07 07:42:18,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 153997312 07:42:18 INFO - 2015-12-07 07:42:18,758 DEBUG : BROWSER_OUTPUT: 07:42:20 INFO - 2015-12-07 07:42:20,795 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59142/tests/kraken/driver.html?testName=audio-oscillator) 07:42:21 INFO - 2015-12-07 07:42:21,368 DEBUG : BROWSER_OUTPUT: RSS: Main: 155516928 07:42:21 INFO - 2015-12-07 07:42:21,368 DEBUG : BROWSER_OUTPUT: 07:42:23 INFO - 2015-12-07 07:42:23,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59142/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:42:24 INFO - 2015-12-07 07:42:24,181 DEBUG : BROWSER_OUTPUT: RSS: Main: 157057024 07:42:24 INFO - 2015-12-07 07:42:24,181 DEBUG : BROWSER_OUTPUT: 07:42:27 INFO - 2015-12-07 07:42:27,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59142/tests/kraken/driver.html?testName=imaging-darkroom) 07:42:27 INFO - 2015-12-07 07:42:27,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 156258304 07:42:27 INFO - 2015-12-07 07:42:27,767 DEBUG : BROWSER_OUTPUT: 07:42:31 INFO - 2015-12-07 07:42:31,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59142/tests/kraken/driver.html?testName=imaging-desaturate) 07:42:31 INFO - 2015-12-07 07:42:31,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 158433280 07:42:31 INFO - 2015-12-07 07:42:31,769 DEBUG : BROWSER_OUTPUT: 07:42:34 INFO - 2015-12-07 07:42:34,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59142/tests/kraken/driver.html?testName=json-parse-financial) 07:42:35 INFO - 2015-12-07 07:42:35,245 DEBUG : BROWSER_OUTPUT: RSS: Main: 157863936 07:42:35 INFO - 2015-12-07 07:42:35,246 DEBUG : BROWSER_OUTPUT: 07:42:37 INFO - 2015-12-07 07:42:37,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59142/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:42:37 INFO - 2015-12-07 07:42:37,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 166404096 07:42:37 INFO - 2015-12-07 07:42:37,633 DEBUG : BROWSER_OUTPUT: 07:42:39 INFO - 2015-12-07 07:42:39,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59142/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:42:40 INFO - 2015-12-07 07:42:40,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 167768064 07:42:40 INFO - 2015-12-07 07:42:40,127 DEBUG : BROWSER_OUTPUT: 07:42:42 INFO - 2015-12-07 07:42:42,339 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59142/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:42:42 INFO - 2015-12-07 07:42:42,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 177762304 07:42:42 INFO - 2015-12-07 07:42:42,913 DEBUG : BROWSER_OUTPUT: 07:42:45 INFO - 2015-12-07 07:42:45,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:42:46 INFO - 2015-12-07 07:42:46,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 182087680 07:42:46 INFO - 2015-12-07 07:42:46,022 DEBUG : BROWSER_OUTPUT: 07:42:48 INFO - 2015-12-07 07:42:48,636 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:42:49 INFO - 2015-12-07 07:42:49,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 179245056 07:42:49 INFO - 2015-12-07 07:42:49,218 DEBUG : BROWSER_OUTPUT: 07:42:50 INFO - 2015-12-07 07:42:50,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59142/tests/kraken/driver.html?testName=ai-astar) 07:42:51 INFO - 2015-12-07 07:42:51,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 237293568 07:42:51 INFO - 2015-12-07 07:42:51,246 DEBUG : BROWSER_OUTPUT: 07:42:51 INFO - 2015-12-07 07:42:51,249 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:42:51 INFO - 2015-12-07 07:42:51,250 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:42:51 INFO - 2015-12-07 07:42:51,250 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:42:51 INFO - 2015-12-07 07:42:51,250 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:42:51 INFO - 2015-12-07 07:42:51,250 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;108;112;113;113;103;116;113;117 07:42:51 INFO - 2015-12-07 07:42:51,250 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;129;157;165;128;147;150;131;167;131 07:42:51 INFO - 2015-12-07 07:42:51,250 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;162;161;162;159;162;161;161;161 07:42:51 INFO - 2015-12-07 07:42:51,250 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;75;82;93;71;71;72;94;90;73 07:42:51 INFO - 2015-12-07 07:42:51,250 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;128;94;95;94;136;94;94;123 07:42:51 INFO - 2015-12-07 07:42:51,251 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;110;110;110;109;109;109 07:42:51 INFO - 2015-12-07 07:42:51,251 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;147;146;147;147;147;147 07:42:51 INFO - 2015-12-07 07:42:51,251 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;96;95;95;95 07:42:51 INFO - 2015-12-07 07:42:51,251 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;75;75;73;74;73;73;82;73;72 07:42:51 INFO - 2015-12-07 07:42:51,251 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;69;68;69;69;68;68;68 07:42:51 INFO - 2015-12-07 07:42:51,251 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;95;85;86;86;84;86;94;85 07:42:51 INFO - 2015-12-07 07:42:51,251 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;121;118;117;124;136;133;130;121;126 07:42:51 INFO - 2015-12-07 07:42:51,252 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;139;142;161;150;140;148;147;146;137 07:42:51 INFO - 2015-12-07 07:42:51,252 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;71;72;69;70;69;68;69;68 07:42:51 INFO - 2015-12-07 07:42:51,252 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:42:51 INFO - 2015-12-07 07:42:51,252 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:42:51 INFO - 2015-12-07 07:42:51,252 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,966 07:42:51 INFO - 2015-12-07 07:42:51,252 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:42:51 INFO - 2015-12-07 07:42:51,252 DEBUG : BROWSER_OUTPUT: __startTimestamp1449502971248__endTimestamp 07:42:51 INFO - 2015-12-07 07:42:51,252 DEBUG : BROWSER_OUTPUT: 07:42:51 INFO - 2015-12-07 07:42:51,260 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:42:51 INFO - 2015-12-07 07:42:51,260 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:42:51 INFO - 2015-12-07 07:42:51,260 DEBUG : BROWSER_OUTPUT: 07:42:51 INFO - 2015-12-07 07:42:51,260 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.98 (3.5%) stddev-sans-first:4.21 07:42:51 INFO - 2015-12-07 07:42:51,260 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 108.0 112.0 113.0 113.0 103.0 116.0 113.0 117.0 07:42:51 INFO - 2015-12-07 07:42:51,260 DEBUG : BROWSER_OUTPUT: 07:42:51 INFO - 2015-12-07 07:42:51,260 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.10 Median:153.00 stddev:15.29 (10.0%) stddev-sans-first:15.79 07:42:51 INFO - 2015-12-07 07:42:51,261 DEBUG : BROWSER_OUTPUT: Values: 156.0 129.0 157.0 165.0 128.0 147.0 150.0 131.0 167.0 131.0 07:42:51 INFO - 2015-12-07 07:42:51,261 DEBUG : BROWSER_OUTPUT: 07:42:51 INFO - 2015-12-07 07:42:51,261 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.99 (0.6%) stddev-sans-first:1.00 07:42:51 INFO - 2015-12-07 07:42:51,261 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 162.0 161.0 162.0 159.0 162.0 161.0 161.0 161.0 07:42:51 INFO - 2015-12-07 07:42:51,261 DEBUG : BROWSER_OUTPUT: 07:42:51 INFO - 2015-12-07 07:42:51,261 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.20 Median:78.50 stddev:9.68 (12.3%) stddev-sans-first:9.80 07:42:51 INFO - 2015-12-07 07:42:51,261 DEBUG : BROWSER_OUTPUT: Values: 71.0 75.0 82.0 93.0 71.0 71.0 72.0 94.0 90.0 73.0 07:42:51 INFO - 2015-12-07 07:42:51,261 DEBUG : BROWSER_OUTPUT: 07:42:51 INFO - 2015-12-07 07:42:51,261 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.90 Median:94.00 stddev:16.93 (18.0%) stddev-sans-first:17.65 07:42:51 INFO - 2015-12-07 07:42:51,261 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 128.0 94.0 95.0 94.0 136.0 94.0 94.0 123.0 07:42:51 INFO - 2015-12-07 07:42:51,261 DEBUG : BROWSER_OUTPUT: 07:42:51 INFO - 2015-12-07 07:42:51,261 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:42:51 INFO - 2015-12-07 07:42:51,261 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 110.0 110.0 110.0 109.0 109.0 109.0 07:42:51 INFO - 2015-12-07 07:42:51,261 DEBUG : BROWSER_OUTPUT: 07:42:51 INFO - 2015-12-07 07:42:51,261 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:42:51 INFO - 2015-12-07 07:42:51,262 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 07:42:51 INFO - 2015-12-07 07:42:51,262 DEBUG : BROWSER_OUTPUT: 07:42:51 INFO - 2015-12-07 07:42:51,262 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:42:51 INFO - 2015-12-07 07:42:51,262 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 07:42:51 INFO - 2015-12-07 07:42:51,262 DEBUG : BROWSER_OUTPUT: 07:42:51 INFO - 2015-12-07 07:42:51,262 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.30 Median:73.50 stddev:2.87 (3.9%) stddev-sans-first:3.00 07:42:51 INFO - 2015-12-07 07:42:51,262 DEBUG : BROWSER_OUTPUT: Values: 73.0 75.0 75.0 73.0 74.0 73.0 73.0 82.0 73.0 72.0 07:42:51 INFO - 2015-12-07 07:42:51,262 DEBUG : BROWSER_OUTPUT: 07:42:51 INFO - 2015-12-07 07:42:51,262 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 07:42:51 INFO - 2015-12-07 07:42:51,262 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 69.0 68.0 69.0 69.0 68.0 68.0 68.0 07:42:51 INFO - 2015-12-07 07:42:51,262 DEBUG : BROWSER_OUTPUT: 07:42:51 INFO - 2015-12-07 07:42:51,262 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:86.00 stddev:4.03 (4.7%) stddev-sans-first:4.12 07:42:51 INFO - 2015-12-07 07:42:51,262 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 95.0 85.0 86.0 86.0 84.0 86.0 94.0 85.0 07:42:51 INFO - 2015-12-07 07:42:51,262 DEBUG : BROWSER_OUTPUT: 07:42:51 INFO - 2015-12-07 07:42:51,262 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:126.50 stddev:6.33 (5.0%) stddev-sans-first:6.68 07:42:51 INFO - 2015-12-07 07:42:51,262 DEBUG : BROWSER_OUTPUT: Values: 127.0 121.0 118.0 117.0 124.0 136.0 133.0 130.0 121.0 126.0 07:42:51 INFO - 2015-12-07 07:42:51,263 DEBUG : BROWSER_OUTPUT: 07:42:51 INFO - 2015-12-07 07:42:51,263 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.70 Median:146.50 stddev:7.39 (5.0%) stddev-sans-first:7.30 07:42:51 INFO - 2015-12-07 07:42:51,263 DEBUG : BROWSER_OUTPUT: Values: 137.0 139.0 142.0 161.0 150.0 140.0 148.0 147.0 146.0 137.0 07:42:51 INFO - 2015-12-07 07:42:51,263 DEBUG : BROWSER_OUTPUT: 07:42:51 INFO - 2015-12-07 07:42:51,263 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.34 (1.9%) stddev-sans-first:1.41 07:42:51 INFO - 2015-12-07 07:42:51,263 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 71.0 72.0 69.0 70.0 69.0 68.0 69.0 68.0 07:42:51 INFO - 2015-12-07 07:42:51,263 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:42:51 INFO - 2015-12-07 07:42:51,263 DEBUG : BROWSER_OUTPUT: 07:42:52 INFO - 2015-12-07 07:42:52,197 INFO : Browser exited with error code: 0 07:42:52 INFO - 2015-12-07 07:42:52,246 INFO : Completed test kraken (00:01:00) 07:42:52 INFO - 2015-12-07 07:42:52,246 INFO : Starting test v8_7 07:42:52 INFO - 2015-12-07 07:42:52,246 DEBUG : operating with platform_type : linux_ 07:42:52 INFO - 2015-12-07 07:42:52,246 INFO : Initialising browser for v8_7 test... 07:42:52 INFO - 2015-12-07 07:42:52,252 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8Edpcy/profile http://localhost:59142/getInfo.html 07:42:56 INFO - 2015-12-07 07:42:56,235 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:42:56 INFO - 2015-12-07 07:42:56,235 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:42:56 INFO - 2015-12-07 07:42:56,235 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:42:56 INFO - 2015-12-07 07:42:56,235 DEBUG : BROWSER_OUTPUT: __metrics 07:42:56 INFO - 2015-12-07 07:42:56,303 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:42:56 INFO - 2015-12-07 07:42:56,371 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:42:57 INFO - 2015-12-07 07:42:57,471 INFO : Browser initialized. 07:42:57 INFO - 2015-12-07 07:42:57,471 INFO : Running cycle 1/1 for v8_7 test... 07:42:57 INFO - 2015-12-07 07:42:57,471 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8Edpcy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:43:09 INFO - 2015-12-07 07:43:09,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 142151680 07:43:09 INFO - 2015-12-07 07:43:09,463 DEBUG : BROWSER_OUTPUT: 07:43:30 INFO - 2015-12-07 07:43:30,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59142/tests/v8_7/run.html (next: http://localhost:59142/tests/v8_7/run.html) 07:43:31 INFO - 2015-12-07 07:43:31,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 451731456 07:43:31 INFO - 2015-12-07 07:43:31,147 DEBUG : BROWSER_OUTPUT: 07:43:31 INFO - 2015-12-07 07:43:31,148 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:43:31 INFO - 2015-12-07 07:43:31,148 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:43:31 INFO - 2015-12-07 07:43:31,148 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:43:31 INFO - 2015-12-07 07:43:31,148 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:43:31 INFO - 2015-12-07 07:43:31,148 DEBUG : BROWSER_OUTPUT: |0;Richards;166.27868307283006 07:43:31 INFO - 2015-12-07 07:43:31,148 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.84603886397608 07:43:31 INFO - 2015-12-07 07:43:31,148 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 07:43:31 INFO - 2015-12-07 07:43:31,149 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5143.589743589743 07:43:31 INFO - 2015-12-07 07:43:31,149 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2032.520325203252 07:43:31 INFO - 2015-12-07 07:43:31,149 DEBUG : BROWSER_OUTPUT: |5;Earley;786.7820613690008 07:43:31 INFO - 2015-12-07 07:43:31,149 DEBUG : BROWSER_OUTPUT: |6;Boyer;12192.77108433735 07:43:31 INFO - 2015-12-07 07:43:31,149 DEBUG : BROWSER_OUTPUT: |7;RegExp;27216.216216216217 07:43:31 INFO - 2015-12-07 07:43:31,149 DEBUG : BROWSER_OUTPUT: |8;Splay;607.90273556231 07:43:31 INFO - 2015-12-07 07:43:31,149 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 07:43:31 INFO - 2015-12-07 07:43:31,149 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:43:31 INFO - 2015-12-07 07:43:31,149 DEBUG : BROWSER_OUTPUT: __startTimestamp1449503011141__endTimestamp 07:43:31 INFO - 2015-12-07 07:43:31,149 DEBUG : BROWSER_OUTPUT: 07:43:31 INFO - 2015-12-07 07:43:31,149 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:43:31 INFO - 2015-12-07 07:43:31,149 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:43:31 INFO - 2015-12-07 07:43:31,149 DEBUG : BROWSER_OUTPUT: 07:43:31 INFO - 2015-12-07 07:43:31,150 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.28 Median:166.28 stddev:0.00 (0.0%) 07:43:31 INFO - 2015-12-07 07:43:31,150 DEBUG : BROWSER_OUTPUT: Values: 166.3 07:43:31 INFO - 2015-12-07 07:43:31,150 DEBUG : BROWSER_OUTPUT: 07:43:31 INFO - 2015-12-07 07:43:31,150 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.85 Median:186.85 stddev:0.00 (0.0%) 07:43:31 INFO - 2015-12-07 07:43:31,150 DEBUG : BROWSER_OUTPUT: Values: 186.8 07:43:31 INFO - 2015-12-07 07:43:31,150 DEBUG : BROWSER_OUTPUT: 07:43:31 INFO - 2015-12-07 07:43:31,150 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 07:43:31 INFO - 2015-12-07 07:43:31,150 DEBUG : BROWSER_OUTPUT: Values: 278.6 07:43:31 INFO - 2015-12-07 07:43:31,150 DEBUG : BROWSER_OUTPUT: 07:43:31 INFO - 2015-12-07 07:43:31,150 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5143.59 Median:5143.59 stddev:0.00 (0.0%) 07:43:31 INFO - 2015-12-07 07:43:31,150 DEBUG : BROWSER_OUTPUT: Values: 5143.6 07:43:31 INFO - 2015-12-07 07:43:31,150 DEBUG : BROWSER_OUTPUT: 07:43:31 INFO - 2015-12-07 07:43:31,150 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2032.52 Median:2032.52 stddev:0.00 (0.0%) 07:43:31 INFO - 2015-12-07 07:43:31,150 DEBUG : BROWSER_OUTPUT: Values: 2032.5 07:43:31 INFO - 2015-12-07 07:43:31,150 DEBUG : BROWSER_OUTPUT: 07:43:31 INFO - 2015-12-07 07:43:31,150 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 07:43:31 INFO - 2015-12-07 07:43:31,151 DEBUG : BROWSER_OUTPUT: Values: 786.8 07:43:31 INFO - 2015-12-07 07:43:31,151 DEBUG : BROWSER_OUTPUT: 07:43:31 INFO - 2015-12-07 07:43:31,151 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12192.77 Median:12192.77 stddev:0.00 (0.0%) 07:43:31 INFO - 2015-12-07 07:43:31,151 DEBUG : BROWSER_OUTPUT: Values: 12192.8 07:43:31 INFO - 2015-12-07 07:43:31,151 DEBUG : BROWSER_OUTPUT: 07:43:31 INFO - 2015-12-07 07:43:31,151 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27216.22 Median:27216.22 stddev:0.00 (0.0%) 07:43:31 INFO - 2015-12-07 07:43:31,151 DEBUG : BROWSER_OUTPUT: Values: 27216.2 07:43:31 INFO - 2015-12-07 07:43:31,151 DEBUG : BROWSER_OUTPUT: 07:43:31 INFO - 2015-12-07 07:43:31,151 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:607.90 Median:607.90 stddev:0.00 (0.0%) 07:43:31 INFO - 2015-12-07 07:43:31,151 DEBUG : BROWSER_OUTPUT: Values: 607.9 07:43:31 INFO - 2015-12-07 07:43:31,151 DEBUG : BROWSER_OUTPUT: 07:43:31 INFO - 2015-12-07 07:43:31,151 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 07:43:31 INFO - 2015-12-07 07:43:31,151 DEBUG : BROWSER_OUTPUT: Values: 4830.9 07:43:31 INFO - 2015-12-07 07:43:31,151 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:43:31 INFO - 2015-12-07 07:43:31,151 DEBUG : BROWSER_OUTPUT: 07:43:32 INFO - 2015-12-07 07:43:32,014 INFO : Browser exited with error code: 0 07:43:32 INFO - 2015-12-07 07:43:32,032 INFO : Completed test v8_7 (00:00:39) 07:43:32 INFO - 2015-12-07 07:43:32,140 INFO : Completed test suite (00:20:17) 07:43:32 INFO - 2015-12-07 07:43:32,140 DEBUG : Working with test: dromaeo_css 07:43:32 INFO - 2015-12-07 07:43:32,141 DEBUG : Generating results file: dromaeo_css 07:43:32 INFO - 2015-12-07 07:43:32,142 DEBUG : Working with test: kraken 07:43:32 INFO - 2015-12-07 07:43:32,142 DEBUG : Generating results file: kraken 07:43:32 INFO - 2015-12-07 07:43:32,142 INFO : javascript benchmark 07:43:32 INFO - 2015-12-07 07:43:32,142 DEBUG : Working with test: v8_7 07:43:32 INFO - 2015-12-07 07:43:32,142 DEBUG : Generating results file: v8_7 07:43:32 INFO - 2015-12-07 07:43:32,143 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:43:32 INFO - 2015-12-07 07:43:32,196 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 07:43:32 INFO - 2015-12-07 07:43:32,196 DEBUG : process_Request line: dromaeo_css 6173.25 graph.html#tests=[[72,132,35]] 07:43:32 INFO - 2015-12-07 07:43:32,196 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:43:32 INFO - 2015-12-07 07:43:32,226 DEBUG : process_Request line: kraken 1523.80 graph.html#tests=[[232,132,35]] 07:43:32 INFO - 2015-12-07 07:43:32,227 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:43:32 INFO - 2015-12-07 07:43:32,257 DEBUG : process_Request line: v8_7 19738.29 graph.html#tests=[[230,132,35]] 07:43:32 INFO - 2015-12-07 07:43:32,258 INFO : javascript benchmark 07:43:32 INFO - 2015-12-07 07:43:32,261 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2619.4368210834673, 2712.4303896181814, 2715.171872578865, 2717.21200851753, 2727.2363738153326, 4456.888577785557, 4541.841035563752, 4589.770511474429, 4595.264757638774, 4617.284320930257, 4527.320901864714, 4532.2974938884445, 4593.88515287118, 4598.195315819735, 4646.442426908776, 4220.092680073783, 4237.4491316129015, 4282.807273672693, 4328.199283132631, 4343.1747967886, 4133.214689209056, 4299.914001719963, 4314.223439780838, 4359.69482136249, 4392.253316936129, 4160.812763425653, 4253.44705188325, 4255.744655320691, 4256.957430425687, 4260.850870219559, 4245.915081698379, 4280.486341638992, 4282.743035417854, 4299.1831552005015, 4330.133973205371, 4255.723377980421, 4258.127083947814, 4266.1254442839145, 4274.038341373197, 4319.438472998521, 4399.098184872126, 4456.64346852251, 4509.864704058883, 4519.977400113011, 4574.679772415932, 4960.0, 4993.1262029144755, 4997.800087996476, 4998.425181104183, 5035.471275516054, 4996.375453068366, 5002.899942001176, 5013.573846223076, 5013.949860501385, 5015.673981191211, 4423.51341352451, 4493.640508759291, 4517.887052823673, 4519.864404067883, 4650.139724151043, 5103.362079740033, 5105.0, 5107.923381149286, 5114.693118412907, 5114.795408183631, 4882.609391248691, 4892.926606100911, 4903.803847846046, 4907.1903135982875, 4946.060248552763, 4738.1708201064675, 4798.760061996886, 4843.491433399513, 4850.75746212688, 4980.975095124573, 4930.7288099154175, 4933.950660493421, 4942.258661200849, 4945.9752701236985, 4948.703077815343, 4929.876753081202, 4931.802727890916, 4936.407631084221, 4938.456769755324, 4974.403071631427, 3999.7200195986, 4004.6796256299426, 4070.2673518766906, 4107.835686572564, 4162.500499939966, 3624.220792529619, 3634.1823089804584, 3649.6897763689853, 3660.8352624131976, 3665.596784353719, 4317.719348242417, 4322.0707547877355, 4322.416473776, 4325.97837010813, 4358.36803663467, 4810.6151507879285, 4845.248986407112, 4946.3817022872145, 4947.233178857283, 4970.502949705073, 4293.205756934977, 4301.354796780508, 4317.481902171759, 4318.136372725405, 4351.477822661301, 4413.051193993307, 4413.558644135625, 4414.3157810539415, 4420.646348292194, 4455.331700244924, 4471.754053527022, 4572.81708731647, 4573.862784116482, 4640.582347588733, 4762.119007983465, 4973.129702302155, 4988.12707776145, 4991.450940396626, 4993.925091123709, 5029.84910452687, 4726.574608285271, 4727.290906364073, 4730.503297153887, 4763.714177149243, 4767.73777442244, 4612.515685852937, 4736.810527578996, 4737.620990320835, 4773.212419950669, 4904.607631389552, 4992.375953005874, 5009.123403404463, 5009.849704508871, 5018.172001619838, 5020.849374518771, 4840.927386089282, 4846.103470857903, 4849.199882019569, 4852.296417019442, 4887.90224195507, 4548.522405147544, 4657.0, 4659.58063774262, 4669.696469729457, 4877.512248775094, 4676.836310729108, 4686.906261874675, 4689.812407503661, 4690.765461726968, 4690.953090469188, 4738.0, 4770.475247722818, 4772.761361931959, 4813.03739252144, 4815.95184048155, 4513.097380523974, 4641.164590373765, 4693.272542755878, 4711.693739906895, 4753.619710423227], "unit": "ms", "name": "dojo.html", "value": 4530.852015165823}, {"lowerIsBetter": false, "replicates": [537.8359600321902, 538.1980848535683, 544.7957016118955, 550.69161269689, 552.4917076289813, 24978.25065248043, 35778.0, 36515.634843651555, 36522.0, 36542.45186322207, 39632.0, 40024.39963400552, 40076.19847603046, 40101.0, 40116.19767604646, 6953.965230173842, 7049.4712896532965, 7675.385969122457, 7832.412569057315, 7834.255745704178, 9898.703038908809, 10150.390976541394, 10152.492375381238, 10157.898421015807, 10165.440900750456, 9884.654037108703, 9962.900370996305, 10007.749806254866, 10010.349327293703, 10016.799664006716, 7187.604681742529, 7367.410607151415, 7378.114626244885, 7381.224971378036, 9890.258230632695, 10002.0, 10252.23108266883, 10296.176305895511, 10296.485175741258, 10308.845367319496, 36408.817955910316, 36783.63216367829, 36846.63153368459, 36866.0, 36870.44694329587, 2657.4286528396296, 2700.5004074246326, 2758.1311886755807, 3028.5457181422744, 3083.9691603083907, 27530.724692753018, 27620.30949226265, 27805.165845024683, 27871.0, 27978.580321294994, 3369.6847826628036, 3400.9149771255916, 3401.540791993074, 3459.4983727359645, 3510.9297814043575, 220669.0, 221760.0, 221945.0, 222240.0, 222316.0, 54496.45503544914, 55164.0, 55302.0, 55359.0, 55361.0, 54481.45518544843, 56026.43973560294, 65128.67435662791, 66891.33108668949, 67018.66490667613, 13259.867401325862, 13453.596392108253, 13492.865071349357, 13538.255395953318, 13575.728485430236, 9563.139317461322, 9617.951910240545, 9620.0, 9633.614655413845, 9644.18024467928, 18795.718064229048, 18820.623587528175, 18993.43019709411, 19035.61928761445, 19068.523286917938, 6881.89677154833, 7155.248698886542, 7177.461690373243, 7184.892226616605, 7209.0988626421695, 808.458332916947, 857.2028013947089, 896.8074252867947, 923.4505469245788, 992.533509250651, 25968.8701556491, 26087.869560652074, 26136.267372271413, 26353.20940371792, 26375.34061648474, 923.9445633262026, 956.0773853231526, 975.1077763846143, 975.8341082016075, 1055.8521806947033, 12361.752764944651, 12559.93720031394, 12664.430100645493, 12667.429965651569, 12670.619881403572, 248427.0, 250120.0, 250899.0, 251151.0, 251167.0, 44833.0, 44981.32528012082, 45049.0, 45095.32357014647, 45193.32210016852, 1204.3496511883484, 1210.878912108782, 1221.3404761428728, 1225.7609766095525, 1231.9137660363688, 23738.762612373655, 25484.49031019406, 27040.1887943362, 27097.051603193795, 27112.72887271102, 35976.0, 36410.63589364073, 36658.63341366552, 36728.449073263386, 36749.26501470009, 146984.0, 247649.0, 249965.0, 252687.0, 252864.0, 25482.0, 26186.607200892384, 26227.213183604523, 26247.21258362252, 26274.4745105093, 35968.64031359758, 36023.63976360203, 36928.44607330946, 37754.8112259437, 39982.0, 32727.0, 32798.34403311968, 33496.497552536246, 33866.0, 34099.82950085333, 31883.36233275275, 32768.344633106724, 33317.666823331456, 33321.166970824954, 33631.159221018694, 30398.78337276114, 30516.84741576278, 32188.678113218568, 32328.191795205308, 32440.0, 27814.86092569605, 28169.859150704116, 29013.129606111852, 29481.262968425104, 30007.399852003273, 21396.465088372915, 22720.886395567915, 22953.655695164252, 23017.424564385354, 23064.654030189224], "unit": "ms", "name": "ext.html", "value": 16742.159180485312}, {"lowerIsBetter": false, "replicates": [278.5278952176061, 283.19290023433217, 283.393537829046, 285.7399766212748, 288.8483546138277, 11617.593384231554, 15209.239538023096, 15729.370825166994, 15756.290966906488, 17142.82857171431, 9117.544122793866, 9425.76435589109, 9464.1482266596, 15382.615434614112, 15753.369865205377, 4392.648588112959, 4517.119161763458, 4524.298733696282, 4530.637548996073, 4532.252178390561, 4485.1254005468945, 4490.730556166641, 4495.460544734637, 4499.347594598781, 4504.1667291551, 3454.481827725836, 3532.5407696999355, 4472.262076757331, 4474.955250447487, 4944.159492886218, 5036.521530454601, 5067.062593420211, 5074.923876141861, 5084.288199652052, 5089.134847076006, 4849.418069831608, 4887.902241955177, 4900.705957642553, 5103.209002604565, 5114.59083273341, 17779.644407111915, 17951.640967180585, 18009.54976125594, 18556.0, 18570.90714546432, 1814.8820326678724, 1818.0909545227387, 1842.3643842874187, 1846.8799528030636, 1879.0229080877866, 8228.753137405827, 8302.626381812834, 8444.197801208875, 8533.445326053787, 8656.22094011542, 1741.651669666072, 1768.4429404737466, 1815.9253375695048, 1837.880537765041, 1870.3453791173117, 54268.18597721037, 54851.72574137144, 55079.0, 56013.43986560123, 56091.71954140244, 9265.305102117234, 9359.719208423758, 9587.952060239653, 9606.462965925419, 9654.27592930533, 12072.456739446747, 12126.27242365461, 12134.089943254292, 12142.271463712206, 12143.453544590338, 6245.687715614201, 6258.15514905491, 6266.373362663697, 6289.276733175652, 6311.2426508819235, 5830.650160990269, 5983.401659834069, 6046.2139921809885, 6086.695665216722, 6107.328193898667, 3801.4487899254455, 3858.2862170498547, 3944.2308749793515, 3964.1675248198203, 4065.1869626074313, 1503.8496150384874, 1604.9679006419806, 1607.1562429724254, 1636.116497091581, 1650.4058538925976, 837.7193640130624, 859.8151397449578, 888.7244954064261, 924.117467818232, 963.3978763272954, 13244.404001819941, 15190.392384304725, 15715.21423928799, 15929.920350398173, 16208.189590520427, 836.8368168207263, 843.2832092721138, 851.4976164063108, 870.656090844113, 888.7689200807707, 8943.0, 9285.907140928504, 9290.224829421688, 9302.0, 9364.204042656314, 468731.0, 470131.0, 472568.0, 483983.0, 490306.0, 66870.0, 69542.65228673824, 69594.65202674056, 70371.88884333477, 71250.0, 998.1415982255255, 1007.0986467111894, 1009.9596016159271, 1015.6394479959508, 1020.1787561013307, 13755.862441375459, 14173.716525669635, 14367.928160359132, 14456.0, 14482.34829432657, 33881.25662407314, 34295.48556771601, 34726.65273347234, 34936.825315874274, 35546.46680299849, 39948.80025599853, 40876.386854196615, 41452.58547414487, 42002.369964451165, 42693.78653106715, 8306.70926517569, 8480.575971201539, 8700.0, 8716.128387161232, 8729.0, 10201.897981020094, 10294.279400441897, 12330.321832299309, 15998.68002639964, 16300.42948496797, 13693.0, 13786.862131378557, 13795.172289662652, 13838.723225535232, 13929.791053134413, 12969.157004795035, 13121.475140994253, 13627.931860341032, 13650.249236291702, 13808.309584520533, 10301.227407944285, 10584.576616935236, 13291.534796282083, 13436.93281533586, 13581.932090339486, 8695.217430431292, 8825.0, 8829.38194326391, 8891.422057566237, 8914.687985920462, 13445.327733613085, 13718.108322958975, 13830.515931942333, 14029.579112626638, 14030.158190508193], "unit": "ms", "name": "jquery.html", "value": 7883.96863150705}, {"lowerIsBetter": false, "replicates": [1389.6595334143124, 1606.4377467886238, 1647.34106357457, 1657.1217254854923, 1675.82403847596, 5814.738336774844, 6816.55692379995, 7041.894371584431, 7083.610401427919, 7087.433005359571, 6833.65831708415, 7072.540284881492, 7123.715051397938, 7123.750668726596, 7126.608036557987, 2051.4871282179456, 2080.854340196187, 2084.2809230815346, 2084.301758910759, 2086.175960495611, 2058.3824852544253, 2086.5096702274955, 2096.7903209678984, 2100.9264675736354, 2104.7895210478982, 2001.8398528117789, 2018.8384929205702, 2029.8782073075663, 2030.7461567304088, 2039.6226698060907, 2026.493376655836, 2047.0276618606192, 2049.1700861151257, 2050.4873781554684, 2054.168061934904, 2021.3228568429595, 2049.7950204979384, 2050.98974505128, 2052.097077286004, 2072.4404410809148, 7012.964935175291, 7089.7873063808165, 7090.610016449094, 7099.254578269259, 7105.0, 4044.9393259100843, 4087.2847251731127, 4100.077482566428, 4114.691398145121, 4127.711060225785, 2634.2624065261757, 2636.6440530528325, 2666.533356662596, 2698.2040298112106, 2712.199901029201, 842.7598134531629, 847.5507980770202, 851.6252848746532, 863.6890719341033, 867.4665080975218, 9550.092741189575, 9551.044895510462, 9565.186959108414, 9565.37825041377, 9576.952115239448, 3643.763155394891, 3655.360311945452, 3689.2805902848686, 3729.4592284119194, 3732.496113024707, 8239.711610093618, 8242.505449673039, 8244.793880153044, 8246.422750407533, 8249.340052795762, 4101.384792281122, 4113.424120623115, 4113.547509773923, 4126.484189476316, 4136.069384388548, 3098.148009297461, 3173.254285242966, 3520.2607452434763, 3768.8304026318333, 3779.5842457329672, 3307.851146698404, 3351.0, 3373.4265174920324, 3385.4752513360468, 3394.3890099782275, 1065.1159537583787, 1074.4949873559415, 1076.0692001418715, 1081.6322450366913, 1083.5178345636116, 941.5762906691879, 972.2027937091517, 1165.9591914283128, 1182.4442512019336, 1183.4260383714063, 6612.107365505692, 6684.632345220963, 6687.598744075371, 6708.2956289589865, 6712.798616041527, 1020.78563501664, 1024.5082360466868, 1024.6618615856748, 1027.2963020331097, 1063.0910571461443, 5032.446430892599, 5068.746562671851, 5072.442031376546, 5078.873028174326, 5097.158968770112, 8285.50286982771, 8321.08468068512, 8461.11158328379, 8493.702720404755, 8522.403431759718, 8343.290820280345, 8356.28971537414, 8419.452735572168, 8465.788355291166, 8473.788155296166, 6631.9388897776125, 6747.696353664097, 6830.146231721035, 6833.760818371333, 6845.383915447634, 6426.839329016812, 6456.741730330734, 6460.580062295936, 6460.612363258219, 6461.418472337512, 7606.581638009741, 7665.195154508696, 7711.691532338644, 7733.0, 7820.0, 7699.615019248903, 7854.1360450349275, 8063.153368896416, 8104.5137291762685, 8124.187581241828, 5090.592752579859, 5104.795808167781, 5941.31674857397, 6017.819465416044, 6025.337212906665, 6333.271673757393, 6512.251091124392, 6513.8697226056165, 6523.021546768023, 6578.835529111619, 6324.778632747832, 6473.514486413444, 6477.0, 6513.576617519846, 6554.115194448688, 6170.81487555374, 6236.189295391751, 6263.530235232467, 6299.685015749286, 6336.239651241881, 6097.695115244309, 6130.233720784902, 6130.816075517741, 6139.662318572521, 6148.262208535004, 5750.741216645345, 5794.1308803679785, 5814.273215848019, 5815.621984570989, 5816.47651711348, 5787.508061814625, 5796.536277097738, 5800.738966746591, 5805.129230615442, 5818.0981947798155], "unit": "ms", "name": "mootools.html", "value": 4030.210484634305}, {"lowerIsBetter": false, "replicates": [256.9447568772714, 260.36211282358215, 261.70950245227806, 263.12510901253324, 264.59120658582486, 5246.449122842099, 5280.445553216905, 5304.867378315544, 5308.23030660554, 5316.2291467737205, 5107.642465027449, 5190.922136167951, 5271.130263506527, 5285.6300058995885, 5286.894262114755, 3767.1147280389223, 3872.5546562145432, 3892.5912779158207, 3906.3749800032, 4005.799710014495, 3978.9602103978877, 3995.0, 4011.438398624195, 4013.6387725104737, 4016.5581786003518, 3952.6837852971835, 3956.703247256453, 3967.7024223183375, 3972.9404058938994, 3978.622030907059, 3752.230792687506, 3813.0848596336955, 3830.731848770587, 3919.2945269851416, 3967.5834037425943, 3381.0, 3384.3908096542614, 3402.8808991685173, 3406.897793066187, 3407.6251612322626, 5142.717150556718, 5145.022445735298, 5150.459201783834, 5152.252923326134, 5159.071367153911, 4547.886302842456, 4553.521880202564, 4559.4072770539615, 4561.498235194126, 4563.087382523476, 5437.728113594305, 5551.528120109796, 5560.193771903092, 5567.47109024642, 5574.358948720908, 3691.7231207659265, 3696.5564132304025, 3697.1681371691425, 3698.5746639136573, 3701.648343407372, 5793.4785869271545, 5882.176495290662, 5884.941150588482, 5891.351951285355, 5891.734871930774, 3786.753860999026, 3788.431735239681, 3790.090378309186, 3795.449659799314, 3800.7149463790324, 3741.1738856874326, 3846.74996125251, 3848.9615103848605, 3852.114013776791, 3852.4221366794645, 4516.164509565675, 4522.34426008227, 4524.140413321458, 4527.524609915978, 4531.071130418256, 5589.0, 5599.592175364633, 5602.243697100921, 5605.495505404533, 5607.214989901417, 1333.4732780551628, 1355.4645914863574, 1355.735631551838, 1355.9661008474868, 1359.1097830920762, 865.1737590601086, 866.8786369908217, 874.5452364770284, 887.2901678657048, 890.6615486115235, 4957.256411538226, 4968.577670898014, 4972.129877271463, 4972.825951091694, 4974.452810190876, 5827.388124246978, 5834.183214349994, 5837.678927658934, 5842.707864606753, 5846.970765146147, 4966.528179822911, 4967.05625931072, 4970.304157417964, 4973.626977976666, 4974.8756281093265, 3061.678523755018, 3109.657937626859, 3124.078396872928, 3126.531020346966, 3139.01121146838, 5561.582881283839, 5566.944330556643, 5567.248421463131, 5576.0241957657245, 5577.05190117681, 6040.577159598874, 6057.151998720183, 6060.090986352083, 6061.605995610271, 6062.9090563641585, 5519.806806761824, 5561.165825126182, 5564.888702226014, 5565.888682226414, 5567.0, 5647.040003199384, 5809.186713859978, 5861.648301101947, 5871.089981052944, 5871.383504732113, 5730.570207234391, 5740.167675687086, 5744.597878148489, 5747.252857128714, 5755.136729490442, 5532.612717109763, 5541.5289700375915, 5545.694986775766, 5548.69482178484, 5550.58370622213, 3659.1949771050326, 3750.868719594801, 3777.905552361103, 3826.9043273918373, 3828.1003964068977, 5675.971620141873, 5729.427057294237, 5743.0, 5817.825465236049, 5821.185034095145, 5601.80393686219, 5610.438956104357, 5610.859728506657, 5612.831615051555, 5615.775368985195, 5597.160425936142, 5603.243562119062, 5606.0, 5607.467290607386, 5612.466815652507, 5381.650192737459, 5552.583556233218, 5552.666839989613, 5555.250041244381, 5558.221848941071, 5421.2681288025615, 5594.944050559442, 5677.971610141923, 5689.743961521659, 5694.886102277848, 5422.376426710979, 5546.140348246028, 5575.080111781511, 5576.358718747396, 5579.525740312119], "unit": "ms", "name": "prototype.html", "value": 4115.565141638926}, {"lowerIsBetter": false, "replicates": [618.879318532886, 650.2944305428609, 735.7829440315109, 744.7281742164112, 751.9135299440566, 10948.124150067995, 11013.559457621686, 11169.329840209593, 11192.832107518394, 11197.720056998569, 10960.725981850457, 11059.391733454657, 11065.391403472806, 11075.778484430306, 11076.058535024513, 580.306533692238, 605.7637521366671, 766.5822126940831, 767.5931756169225, 795.7851380127362, 785.4855069929177, 786.3984052200071, 790.6125998260868, 792.43341011177, 792.7066985215479, 630.5743623054443, 821.6220538552243, 822.3955392786297, 828.3414685325181, 828.7265202483167, 640.5836206465788, 805.7985503624094, 811.8335741173046, 820.2084987986561, 821.6097353756977, 609.9359567245419, 610.3347351386965, 610.4658423879106, 610.5207412181461, 610.8595023144702, 11945.0, 12036.879631203663, 12052.096092793076, 12074.335911524862, 12085.0, 10930.56277748889, 11076.556937722562, 11705.239159454693, 11724.765504689944, 11821.0, 8721.127887211229, 8735.1701588349, 8744.825103497958, 8838.558072096434, 9059.864102038475, 3282.0646115856866, 3317.10438181692, 3318.386098571772, 3321.2029113012704, 3321.8671253149846, 38856.41715374272, 38896.0, 39126.80436597799, 39133.804330978164, 39200.803995980124, 9389.154976052188, 9464.1009104135, 9517.666881659108, 9610.231181505464, 9687.467189304514, 16787.076710781024, 16811.579710507336, 16874.831251687327, 16935.830641693425, 16977.151142442828, 6196.907046394308, 6441.355864413615, 6464.903026454607, 6466.321036291216, 6621.86756264872, 3454.9827250863586, 3472.0278322069357, 3565.928681426357, 3612.548431446069, 3618.2763447310117, 2498.4753201827457, 2538.1243471002476, 2540.872956352175, 2542.5931850904135, 2545.8090643201836, 459.7816037382217, 467.04489319342025, 467.14512442230637, 468.2437862851538, 472.7519348918857, 553.9639923405047, 561.4469747298907, 562.1174755633616, 566.0712874417105, 593.5394371779645, 7010.474214433938, 7173.533720308267, 7299.635018249066, 7412.332890039922, 8699.869501957475, 522.6054328981595, 524.3765579843265, 576.2336092996305, 588.2352941176539, 597.2325561653255, 3403.3193361327835, 3509.5437593112733, 3918.8824335269987, 3926.1166237596312, 3935.5670876203594, 43921.560784392386, 46446.767766160956, 47110.76444617755, 47131.29303060457, 47973.76013119982, 39262.4110638335, 39324.0, 39336.0, 39576.40635390471, 39689.0, 37478.25043499115, 38485.0, 38915.2216955665, 38939.41590876139, 39000.6099938997, 7830.725924592612, 7838.372930165459, 7952.880706789287, 8142.145074767301, 8594.78513037179, 32842.83578582092, 32884.177895552806, 33125.0, 33401.83299083489, 33551.0, 37263.62736372602, 37299.254014920094, 37595.49618015358, 37753.433698493995, 38479.23041539098, 9724.805503889742, 9747.951260243937, 10004.899951000689, 10015.39907605546, 10050.49747512636, 10683.465826708789, 11054.557817687524, 11055.668329950115, 11161.665150045512, 11380.886191138314, 10138.6451474201, 10528.894711053097, 10545.630902918361, 10819.729506762395, 11317.547298107984, 10146.594136234764, 10519.211059170746, 10601.416922069051, 10613.681589552325, 10697.14422846155, 7853.060252441212, 9575.856362154713, 10050.0, 10055.74860628461, 10117.79764404693, 8712.303015758851, 8750.343724220582, 8806.181520037713, 9328.580213890256, 9600.807983840145, 8714.259287960595, 8868.246199073152, 9005.414648047856, 9121.498317592595, 9227.492487913229], "unit": "ms", "name": "yui.html", "value": 5578.848287899213}], "name": "dromaeo_css", "value": 6173.251638422033}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 108.0, 112.0, 113.0, 113.0, 103.0, 116.0, 113.0, 117.0], "unit": "ms", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 157.0, 165.0, 128.0, 147.0, 150.0, 131.0, 167.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 162.0, 161.0, 162.0, 159.0, 162.0, 161.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [71.0, 75.0, 82.0, 93.0, 71.0, 71.0, 72.0, 94.0, 90.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 128.0, 94.0, 95.0, 94.0, 136.0, 94.0, 94.0, 123.0], "unit": "ms", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 75.0, 73.0, 74.0, 73.0, 73.0, 82.0, 73.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 74.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 95.0, 85.0, 86.0, 86.0, 84.0, 86.0, 94.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [127.0, 121.0, 118.0, 117.0, 124.0, 136.0, 133.0, 130.0, 121.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.3}, {"lowerIsBetter": true, "replicates": [137.0, 139.0, 142.0, 161.0, 150.0, 140.0, 148.0, 147.0, 146.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.7}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 72.0, 69.0, 70.0, 69.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1523.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.27868307283006], "unit": "score", "name": "Richards", "value": 212.306228}, {"lowerIsBetter": false, "replicates": [186.84603886397608], "unit": "score", "name": "DeltaBlue", "value": 353.8635360000001}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5143.589743589743], "unit": "score", "name": "Decrypt", "value": 51.75004486540379}, {"lowerIsBetter": false, "replicates": [2032.520325203252], "unit": "score", "name": "RayTrace", "value": 364.0745880000001}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [12192.77108433735], "unit": "score", "name": "Boyer", "value": 54.66050296442688}, {"lowerIsBetter": false, "replicates": [27216.216216216217], "unit": "score", "name": "RegExp", "value": 33.472140019860944}, {"lowerIsBetter": false, "replicates": [607.90273556231], "unit": "score", "name": "Splay", "value": 134.052695}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19738.291017142266}]} 07:43:32 INFO - RETURN: dromaeo_css: 6173.25 07:43:32 INFO - RETURN: kraken: 1523.80 07:43:32 INFO - RETURN: v8_7: 19738.29 07:43:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19738.29"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1523.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6173.25"}}} 07:43:32 INFO - Return code: 0 07:43:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:43:32 INFO - # TBPL SUCCESS # 07:43:32 INFO - Running post-action listener: _resource_record_post_action 07:43:32 INFO - Running post-run listener: _resource_record_post_run 07:43:33 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 2379776; Write bytes: 509906944; Read time: 536; Write time: 520000 07:43:33 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231358464; Read time: 0; Write time: 367020 07:43:33 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 2379776; Write bytes: 277495808; Read time: 536; Write time: 152908 07:43:33 INFO - Running post-run listener: _upload_blobber_files 07:43:33 INFO - Blob upload gear active. 07:43:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:43:33 INFO - Copying logs to upload dir... 07:43:33 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1285.798967 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-07 07:43:32.320679) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-07 07:43:32.324470) ========= 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=7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009978 build_url: 'https://queue.taskcluster.net/v1/task/6L12gytWQsy0DwZDUrlKnA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-07 07:43:32.375396) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 07:43:32.375773) ========= 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=7d909545e45784438f4e8e36000001b3-1449478699.671921-200856758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 07:43:32.426114) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-07 07:43:32.426452) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-07 07:43:32.426760) ========= ========= Total master_lag: 0.30 =========