builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1447927805.41 results: success (0) buildid: 20151119013236 builduid: 0c719cafb3004ad59ea02c022e3b7202 revision: 1ad891c3f905d6b40b88d16b3a37c54c0feb50e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:05.407417) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:05.407935) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:05.408246) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.002956 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:05.440783) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:05.441120) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:05.472823) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:05.473232) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.032531 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:05.522925) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:05.523453) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:05.524069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:05.524585) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 02:10:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 214M=0s 2015-11-19 02:10:05 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.272585 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:05.810551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:05.810909) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.250861 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:06.073898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 02:10:06.074271) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1ad891c3f905d6b40b88d16b3a37c54c0feb50e5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1ad891c3f905d6b40b88d16b3a37c54c0feb50e5 --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=6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 02:10:06,211 truncating revision to first 12 chars 2015-11-19 02:10:06,211 Setting DEBUG logging. 2015-11-19 02:10:06,211 attempt 1/10 2015-11-19 02:10:06,211 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1ad891c3f905?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 02:10:07,488 unpacking tar archive at: mozilla-inbound-1ad891c3f905/testing/mozharness/ program finished with exit code 0 elapsedTime=1.557172 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 02:10:07.641176) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:07.641489) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:07.650579) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:07.650944) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 02:10:07.651371) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2015-11-19 02:10:07.651722) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-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', 'Mozilla-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound-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=6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:10:08 INFO - MultiFileLogger online at 20151119 02:10:08 in /builds/slave/test 02:10:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO 02:10:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:10:08 INFO - {'append_to_log': False, 02:10:08 INFO - 'base_work_dir': '/builds/slave/test', 02:10:08 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 02:10:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:10:08 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 02:10:08 INFO - 'buildbot_json_path': 'buildprops.json', 02:10:08 INFO - 'config_files': ('talos/linux_config.py',), 02:10:08 INFO - 'default_actions': ('clobber', 02:10:08 INFO - 'read-buildbot-config', 02:10:08 INFO - 'download-and-extract', 02:10:08 INFO - 'populate-webroot', 02:10:08 INFO - 'create-virtualenv', 02:10:08 INFO - 'install', 02:10:08 INFO - 'run-tests'), 02:10:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:10:08 INFO - 'download_minidump_stackwalk': True, 02:10:08 INFO - 'download_symbols': 'ondemand', 02:10:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:10:08 INFO - 'tooltool.py': '/tools/tooltool.py', 02:10:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:10:08 INFO - '/tools/misc-python/virtualenv.py')}, 02:10:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:10:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:10:08 INFO - 'installer_path': 'installer.exe', 02:10:08 INFO - 'log_level': 'info', 02:10:08 INFO - 'log_name': 'talos', 02:10:08 INFO - 'log_to_console': True, 02:10:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:10:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:10:08 INFO - 'opt_config_files': (), 02:10:08 INFO - 'pip_index': False, 02:10:08 INFO - 'sps_profile': False, 02:10:08 INFO - 'sps_profile_interval': 0, 02:10:08 INFO - 'suite': 'dromaeojs', 02:10:08 INFO - 'system_bits': '64', 02:10:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:10:08 INFO - 'title': 'talos-linux64-ix-037', 02:10:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:10:08 INFO - 'use_talos_json': True, 02:10:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:10:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:10:08 INFO - 'work_dir': 'build'} 02:10:08 INFO - ##### 02:10:08 INFO - ##### Running clobber step. 02:10:08 INFO - ##### 02:10:08 INFO - Running pre-action listener: _resource_record_pre_action 02:10:08 INFO - Running main action method: clobber 02:10:08 INFO - rmtree: /builds/slave/test/build 02:10:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:10:14 INFO - Running post-action listener: _resource_record_post_action 02:10:14 INFO - ##### 02:10:14 INFO - ##### Running read-buildbot-config step. 02:10:14 INFO - ##### 02:10:14 INFO - Running pre-action listener: _resource_record_pre_action 02:10:14 INFO - Running main action method: read_buildbot_config 02:10:14 INFO - Using buildbot properties: 02:10:14 INFO - { 02:10:14 INFO - "properties": { 02:10:14 INFO - "buildnumber": 2598, 02:10:14 INFO - "product": "firefox", 02:10:14 INFO - "script_repo_revision": "production", 02:10:14 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 02:10:14 INFO - "repository": "", 02:10:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs", 02:10:14 INFO - "buildid": "20151119013236", 02:10:14 INFO - "slavename": "talos-linux64-ix-037", 02:10:14 INFO - "pgo_build": "False", 02:10:14 INFO - "basedir": "/builds/slave/test", 02:10:14 INFO - "project": "", 02:10:14 INFO - "platform": "ubuntu64_hw", 02:10:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:10:14 INFO - "slavebuilddir": "test", 02:10:14 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 02:10:14 INFO - "branch": "mozilla-inbound", 02:10:14 INFO - "repo_path": "integration/mozilla-inbound", 02:10:14 INFO - "stage_platform": "linux64", 02:10:14 INFO - "builduid": "0c719cafb3004ad59ea02c022e3b7202", 02:10:14 INFO - "revision": "1ad891c3f905d6b40b88d16b3a37c54c0feb50e5" 02:10:14 INFO - }, 02:10:14 INFO - "sourcestamp": { 02:10:14 INFO - "repository": "", 02:10:14 INFO - "hasPatch": false, 02:10:14 INFO - "project": "", 02:10:14 INFO - "branch": "mozilla-inbound-linux64-talos", 02:10:14 INFO - "changes": [ 02:10:14 INFO - { 02:10:14 INFO - "category": null, 02:10:14 INFO - "files": [ 02:10:14 INFO - { 02:10:14 INFO - "url": null, 02:10:14 INFO - "name": "https://queue.taskcluster.net/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 02:10:14 INFO - } 02:10:14 INFO - ], 02:10:14 INFO - "repository": "", 02:10:14 INFO - "rev": "1ad891c3f905d6b40b88d16b3a37c54c0feb50e5", 02:10:14 INFO - "who": "cbook@mozilla.com", 02:10:14 INFO - "when": 1447927754, 02:10:14 INFO - "number": 6681723, 02:10:14 INFO - "comments": "Bug 1175609 - Bring onnegotiationneeded in line with spec. r=mt", 02:10:14 INFO - "project": "", 02:10:14 INFO - "at": "Thu 19 Nov 2015 02:09:14", 02:10:14 INFO - "branch": "mozilla-inbound-linux64-talos", 02:10:14 INFO - "revlink": "", 02:10:14 INFO - "properties": [ 02:10:14 INFO - [ 02:10:14 INFO - "buildid", 02:10:14 INFO - "20151119013236", 02:10:14 INFO - "Change" 02:10:14 INFO - ], 02:10:14 INFO - [ 02:10:14 INFO - "builduid", 02:10:14 INFO - "0c719cafb3004ad59ea02c022e3b7202", 02:10:14 INFO - "Change" 02:10:14 INFO - ], 02:10:14 INFO - [ 02:10:14 INFO - "pgo_build", 02:10:14 INFO - "False", 02:10:14 INFO - "Change" 02:10:14 INFO - ] 02:10:14 INFO - ], 02:10:14 INFO - "revision": "1ad891c3f905d6b40b88d16b3a37c54c0feb50e5" 02:10:14 INFO - } 02:10:14 INFO - ], 02:10:14 INFO - "revision": "1ad891c3f905d6b40b88d16b3a37c54c0feb50e5" 02:10:14 INFO - } 02:10:14 INFO - } 02:10:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 02:10:14 INFO - Running post-action listener: _resource_record_post_action 02:10:14 INFO - ##### 02:10:14 INFO - ##### Running download-and-extract step. 02:10:14 INFO - ##### 02:10:14 INFO - Running pre-action listener: _resource_record_pre_action 02:10:14 INFO - Running main action method: download_and_extract 02:10:14 INFO - mkdir: /builds/slave/test/build/tests 02:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:14 INFO - https://queue.taskcluster.net/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:10:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/test_packages.json 02:10:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/test_packages.json 02:10:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:10:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:10:16 INFO - Downloaded 1302 bytes. 02:10:16 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:10:16 INFO - Using the following test package requirements: 02:10:16 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:10:16 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:10:16 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:16 INFO - u'jsshell-linux-x86_64.zip'], 02:10:16 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:10:16 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:10:16 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:10:16 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:10:16 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:10:16 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 02:10:16 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:16 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:10:16 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:10: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')]} 02:10:16 INFO - https://queue.taskcluster.net/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:10:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:10:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:10:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/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 02:10:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/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 02:10:19 INFO - Downloaded 21323184 bytes. 02:10: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 02:10:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:10: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 02:10:20 INFO - Return code: 0 02:10: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 02:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:20 INFO - https://queue.taskcluster.net/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:10:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:10:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:10:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/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 02:10:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/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 02:10:30 INFO - Downloaded 21323184 bytes. 02:10:30 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 02:10:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 02:10:30 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 02:10:31 INFO - Return code: 0 02:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:31 INFO - https://queue.taskcluster.net/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:10:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:10:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:10:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/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 02:10:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/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 02:10:33 INFO - Downloaded 11130997 bytes. 02:10:33 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 02:10:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 02:10:33 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 02:10:34 INFO - Return code: 0 02:10: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')]} 02:10:34 INFO - https://queue.taskcluster.net/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:10:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:10:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:10:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/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 02:10:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/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 02:10:39 INFO - Downloaded 55778537 bytes. 02:10:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:10:39 INFO - mkdir: /builds/slave/test/properties 02:10:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:10:39 INFO - Writing to file /builds/slave/test/properties/build_url 02:10:39 INFO - Contents: 02:10:39 INFO - build_url:https://queue.taskcluster.net/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 02:10:39 INFO - Running post-action listener: _resource_record_post_action 02:10:39 INFO - Running post-action listener: set_extra_try_arguments 02:10:39 INFO - ##### 02:10:39 INFO - ##### Running populate-webroot step. 02:10:39 INFO - ##### 02:10:39 INFO - Running pre-action listener: _resource_record_pre_action 02:10:39 INFO - Running main action method: populate_webroot 02:10:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:10:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:10:39 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:10:39 INFO - '../fennec_ids.txt'], 02:10:39 INFO - 'tests': ['tcheck2']}, 02:10:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:10:39 INFO - '--tppagecycles', 02:10:39 INFO - '7'], 02:10:39 INFO - 'tests': ['tsvgm']}}, 02:10:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:10:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:10:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:10:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:10:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:10:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:10:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:39 INFO - 'talos_options': ['--e10s'], 02:10:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:39 INFO - 'tests': ['damp', 'tps']}, 02:10:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:39 INFO - 'talos_options': ['--e10s'], 02:10:39 INFO - 'tests': ['damp', 'tps']}, 02:10:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:10:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:10:39 INFO - 'other': {'tests': ['a11yr', 02:10:39 INFO - 'ts_paint', 02:10:39 INFO - 'tpaint', 02:10:39 INFO - 'sessionrestore', 02:10:39 INFO - 'sessionrestore_no_auto_restore']}, 02:10:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:10:39 INFO - 'tests': ['a11yr', 02:10:39 INFO - 'ts_paint', 02:10:39 INFO - 'tpaint', 02:10:39 INFO - 'sessionrestore', 02:10:39 INFO - 'sessionrestore_no_auto_restore']}, 02:10:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:10:39 INFO - 'tests': ['a11yr', 02:10:39 INFO - 'ts_paint', 02:10:39 INFO - 'tpaint', 02:10:39 INFO - 'sessionrestore', 02:10:39 INFO - 'sessionrestore_no_auto_restore']}, 02:10:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:10:39 INFO - 'tests': ['a11yr', 02:10:39 INFO - 'ts_paint', 02:10:39 INFO - 'tpaint', 02:10:39 INFO - 'sessionrestore', 02:10:39 INFO - 'sessionrestore_no_auto_restore']}, 02:10:39 INFO - 'other_l64': {'tests': ['a11yr', 02:10:39 INFO - 'ts_paint', 02:10:39 INFO - 'tpaint', 02:10:39 INFO - 'sessionrestore', 02:10:39 INFO - 'sessionrestore_no_auto_restore']}, 02:10:39 INFO - 'other_nol64': {'tests': ['a11yr', 02:10:39 INFO - 'ts_paint', 02:10:39 INFO - 'tpaint', 02:10:39 INFO - 'sessionrestore', 02:10:39 INFO - 'sessionrestore_no_auto_restore']}, 02:10:39 INFO - 'svgr': {'tests': ['tsvgx', 02:10:39 INFO - 'tsvgr_opacity', 02:10:39 INFO - 'tart', 02:10:39 INFO - 'tscrollx', 02:10:39 INFO - 'cart']}, 02:10:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:10:39 INFO - 'tests': ['tsvgx', 02:10:39 INFO - 'tsvgr_opacity', 02:10:39 INFO - 'tart', 02:10:39 INFO - 'tscrollx', 02:10:39 INFO - 'cart']}, 02:10:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:39 INFO - 'tests': ['tp5o']}, 02:10:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:39 INFO - 'talos_options': ['--e10s'], 02:10:39 INFO - 'tests': ['tp5o']}, 02:10:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:39 INFO - 'talos_options': ['--xperf_path', 02:10:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:39 INFO - 'tests': ['tp5n']}, 02:10:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:39 INFO - 'talos_options': ['--e10s', 02:10:39 INFO - '--xperf_path', 02:10:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:39 INFO - 'tests': ['tp5n']}}, 02:10:39 INFO - 'talos.zip': {'path': '', 02:10:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:10:39 INFO - Running post-action listener: _resource_record_post_action 02:10:39 INFO - ##### 02:10:39 INFO - ##### Running create-virtualenv step. 02:10:39 INFO - ##### 02:10:39 INFO - Running pre-action listener: _resource_record_pre_action 02:10:39 INFO - Running main action method: create_virtualenv 02:10:39 INFO - Creating virtualenv /builds/slave/test/build/venv 02:10:39 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 02:10:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:10:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:10:39 INFO - Using real prefix '/usr' 02:10:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:10:39 INFO - Installing distribute.............................................................................................................................................................................................done. 02:10:41 INFO - Installing pip.................done. 02:10:41 INFO - Return code: 0 02:10:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:10: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')]} 02:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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')]} 02:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ca132bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c26900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb70>, '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 0x2cbddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe250>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082', '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 02:10: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', 'pip>=1.5'] in /builds/slave/test/build 02:10: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 pip>=1.5 02:10:41 INFO - Using env: {'DISPLAY': ':0', 02:10:41 INFO - 'HOME': '/home/cltbld', 02:10:41 INFO - 'LANG': 'en_US.UTF-8', 02:10:41 INFO - 'LANGUAGE': 'en_US:en', 02:10:41 INFO - 'LOGNAME': 'cltbld', 02:10:41 INFO - 'MAIL': '/var/mail/cltbld', 02:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:41 INFO - 'MOZ_NO_REMOTE': '1', 02:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:41 INFO - 'NO_EM_RESTART': '1', 02:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:41 INFO - 'PWD': '/builds/slave/test', 02:10:41 INFO - 'SHELL': '/bin/bash', 02:10:41 INFO - 'SHLVL': '1', 02:10:41 INFO - 'TERM': 'linux', 02:10:41 INFO - 'TMOUT': '86400', 02:10:41 INFO - 'USER': 'cltbld', 02:10:41 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082', 02:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:41 INFO - '_': '/tools/buildbot/bin/python'} 02:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:42 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 02:10:42 INFO - Cleaning up... 02:10:42 INFO - Return code: 0 02:10:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:42 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 0x7f5ca132bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c26900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb70>, '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 0x2cbddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe250>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082', '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 02:10:42 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 02:10:42 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 02:10:42 INFO - Using env: {'DISPLAY': ':0', 02:10:42 INFO - 'HOME': '/home/cltbld', 02:10:42 INFO - 'LANG': 'en_US.UTF-8', 02:10:42 INFO - 'LANGUAGE': 'en_US:en', 02:10:42 INFO - 'LOGNAME': 'cltbld', 02:10:42 INFO - 'MAIL': '/var/mail/cltbld', 02:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:42 INFO - 'MOZ_NO_REMOTE': '1', 02:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:42 INFO - 'NO_EM_RESTART': '1', 02:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:42 INFO - 'PWD': '/builds/slave/test', 02:10:42 INFO - 'SHELL': '/bin/bash', 02:10:42 INFO - 'SHLVL': '1', 02:10:42 INFO - 'TERM': 'linux', 02:10:42 INFO - 'TMOUT': '86400', 02:10:42 INFO - 'USER': 'cltbld', 02:10:42 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082', 02:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:42 INFO - '_': '/tools/buildbot/bin/python'} 02:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:42 INFO - Downloading/unpacking psutil>=0.7.1 02:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:43 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:10:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:10:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:44 INFO - Installing collected packages: psutil 02:10:44 INFO - Running setup.py install for psutil 02:10:44 INFO - building 'psutil._psutil_linux' extension 02:10:44 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 02:10:45 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 02:10:45 INFO - building 'psutil._psutil_posix' extension 02:10:45 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 02:10:45 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 02:10:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:45 INFO - Successfully installed psutil 02:10:45 INFO - Cleaning up... 02:10:45 INFO - Return code: 0 02:10:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:10:45 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')]} 02:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:45 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')]} 02:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:45 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 0x7f5ca132bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c26900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb70>, '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 0x2cbddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe250>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082', '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 02:10:45 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 02:10:45 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 02:10:45 INFO - Using env: {'DISPLAY': ':0', 02:10:45 INFO - 'HOME': '/home/cltbld', 02:10:45 INFO - 'LANG': 'en_US.UTF-8', 02:10:45 INFO - 'LANGUAGE': 'en_US:en', 02:10:45 INFO - 'LOGNAME': 'cltbld', 02:10:45 INFO - 'MAIL': '/var/mail/cltbld', 02:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:45 INFO - 'MOZ_NO_REMOTE': '1', 02:10:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:45 INFO - 'NO_EM_RESTART': '1', 02:10:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:45 INFO - 'PWD': '/builds/slave/test', 02:10:45 INFO - 'SHELL': '/bin/bash', 02:10:45 INFO - 'SHLVL': '1', 02:10:45 INFO - 'TERM': 'linux', 02:10:45 INFO - 'TMOUT': '86400', 02:10:45 INFO - 'USER': 'cltbld', 02:10:45 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082', 02:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:45 INFO - '_': '/tools/buildbot/bin/python'} 02:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:10:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:10:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:10:47 INFO - Installing collected packages: mozsystemmonitor 02:10:47 INFO - Running setup.py install for mozsystemmonitor 02:10:47 INFO - Successfully installed mozsystemmonitor 02:10:47 INFO - Cleaning up... 02:10:47 INFO - Return code: 0 02:10:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:10:47 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')]} 02:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:47 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')]} 02:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:47 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 0x7f5ca132bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c26900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb70>, '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 0x2cbddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe250>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082', '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 02:10:47 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 02:10:47 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 02:10:47 INFO - Using env: {'DISPLAY': ':0', 02:10:47 INFO - 'HOME': '/home/cltbld', 02:10:47 INFO - 'LANG': 'en_US.UTF-8', 02:10:47 INFO - 'LANGUAGE': 'en_US:en', 02:10:47 INFO - 'LOGNAME': 'cltbld', 02:10:47 INFO - 'MAIL': '/var/mail/cltbld', 02:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:47 INFO - 'MOZ_NO_REMOTE': '1', 02:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:47 INFO - 'NO_EM_RESTART': '1', 02:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:47 INFO - 'PWD': '/builds/slave/test', 02:10:47 INFO - 'SHELL': '/bin/bash', 02:10:47 INFO - 'SHLVL': '1', 02:10:47 INFO - 'TERM': 'linux', 02:10:47 INFO - 'TMOUT': '86400', 02:10:47 INFO - 'USER': 'cltbld', 02:10:47 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082', 02:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:47 INFO - '_': '/tools/buildbot/bin/python'} 02:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:47 INFO - Downloading/unpacking blobuploader==1.2.4 02:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:49 INFO - Downloading blobuploader-1.2.4.tar.gz 02:10:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:10:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:10:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:10:50 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 02:10:50 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 02:10:50 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 02:10:50 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 02:10:50 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 02:10:50 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 02:10:50 INFO - Downloading docopt-0.6.1.tar.gz 02:10:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:10:50 INFO - Installing collected packages: blobuploader, requests, docopt 02:10:50 INFO - Running setup.py install for blobuploader 02:10:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:10:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:10:50 INFO - Running setup.py install for requests 02:10:50 INFO - Running setup.py install for docopt 02:10:50 INFO - Successfully installed blobuploader requests docopt 02:10:50 INFO - Cleaning up... 02:10:50 INFO - Return code: 0 02:10:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10: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')]} 02:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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')]} 02:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:50 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 0x7f5ca132bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c26900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb70>, '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 0x2cbddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe250>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082', '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 02:10:50 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 02:10:50 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 02:10:50 INFO - Using env: {'DISPLAY': ':0', 02:10:50 INFO - 'HOME': '/home/cltbld', 02:10:50 INFO - 'LANG': 'en_US.UTF-8', 02:10:50 INFO - 'LANGUAGE': 'en_US:en', 02:10:50 INFO - 'LOGNAME': 'cltbld', 02:10:50 INFO - 'MAIL': '/var/mail/cltbld', 02:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:50 INFO - 'MOZ_NO_REMOTE': '1', 02:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:50 INFO - 'NO_EM_RESTART': '1', 02:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:50 INFO - 'PWD': '/builds/slave/test', 02:10:50 INFO - 'SHELL': '/bin/bash', 02:10:50 INFO - 'SHLVL': '1', 02:10:50 INFO - 'TERM': 'linux', 02:10:50 INFO - 'TMOUT': '86400', 02:10:50 INFO - 'USER': 'cltbld', 02:10:50 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082', 02:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:50 INFO - '_': '/tools/buildbot/bin/python'} 02:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:51 INFO - Running setup.py (path:/tmp/pip-nV4bkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:51 INFO - Running setup.py (path:/tmp/pip-eqWEAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:51 INFO - Running setup.py (path:/tmp/pip-r8EHVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:51 INFO - Running setup.py (path:/tmp/pip-2YFLGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:51 INFO - Running setup.py (path:/tmp/pip-jFOWvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:51 INFO - Running setup.py (path:/tmp/pip-ZFFOwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:51 INFO - Running setup.py (path:/tmp/pip-ATdSjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:51 INFO - Running setup.py (path:/tmp/pip-cUCTzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:51 INFO - Running setup.py (path:/tmp/pip-fST4oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:51 INFO - Running setup.py (path:/tmp/pip-36ylzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:51 INFO - Running setup.py (path:/tmp/pip-aWfJb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:51 INFO - Running setup.py (path:/tmp/pip-eP_xWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:52 INFO - Running setup.py (path:/tmp/pip-65iCVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:52 INFO - Running setup.py (path:/tmp/pip-2M8IrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:52 INFO - Running setup.py (path:/tmp/pip-tDKakn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:52 INFO - Running setup.py (path:/tmp/pip-nBXee6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:52 INFO - Running setup.py (path:/tmp/pip-1YiKpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:10:52 INFO - Running setup.py install for manifestparser 02:10:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:10:52 INFO - Running setup.py install for mozcrash 02:10:52 INFO - Running setup.py install for mozdebug 02:10:52 INFO - Running setup.py install for mozdevice 02:10:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:10:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:10:52 INFO - Running setup.py install for mozfile 02:10:52 INFO - Running setup.py install for mozhttpd 02:10:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:10:52 INFO - Running setup.py install for mozinfo 02:10:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:10:53 INFO - Running setup.py install for mozInstall 02:10:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:10:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:10:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:10:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:10:53 INFO - Running setup.py install for mozleak 02:10:53 INFO - Running setup.py install for mozlog 02:10:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:10:53 INFO - Running setup.py install for moznetwork 02:10:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:10:53 INFO - Running setup.py install for mozprocess 02:10:53 INFO - Running setup.py install for mozprofile 02:10:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:10:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:10:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:10:53 INFO - Running setup.py install for mozrunner 02:10:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:10:53 INFO - Running setup.py install for mozscreenshot 02:10:53 INFO - Running setup.py install for moztest 02:10:54 INFO - Running setup.py install for mozversion 02:10:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:10:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:10:54 INFO - Cleaning up... 02:10:54 INFO - Return code: 0 02:10:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:54 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')]} 02:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:54 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')]} 02:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:54 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 0x7f5ca132bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c26900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb70>, '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 0x2cbddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe250>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082', '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 02:10:54 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 02:10:54 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 02:10:54 INFO - Using env: {'DISPLAY': ':0', 02:10:54 INFO - 'HOME': '/home/cltbld', 02:10:54 INFO - 'LANG': 'en_US.UTF-8', 02:10:54 INFO - 'LANGUAGE': 'en_US:en', 02:10:54 INFO - 'LOGNAME': 'cltbld', 02:10:54 INFO - 'MAIL': '/var/mail/cltbld', 02:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:54 INFO - 'MOZ_NO_REMOTE': '1', 02:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:54 INFO - 'NO_EM_RESTART': '1', 02:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:54 INFO - 'PWD': '/builds/slave/test', 02:10:54 INFO - 'SHELL': '/bin/bash', 02:10:54 INFO - 'SHLVL': '1', 02:10:54 INFO - 'TERM': 'linux', 02:10:54 INFO - 'TMOUT': '86400', 02:10:54 INFO - 'USER': 'cltbld', 02:10:54 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082', 02:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:54 INFO - '_': '/tools/buildbot/bin/python'} 02:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:54 INFO - Running setup.py (path:/tmp/pip-X5ODok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:54 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)) 02:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:54 INFO - Running setup.py (path:/tmp/pip-voyKox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:54 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)) 02:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:54 INFO - Running setup.py (path:/tmp/pip-9NyHLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:54 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)) 02:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:54 INFO - Running setup.py (path:/tmp/pip-ecJAaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:54 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)) 02:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:54 INFO - Running setup.py (path:/tmp/pip-5uOhSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:54 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)) 02:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:54 INFO - Running setup.py (path:/tmp/pip-q4Ahxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:54 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)) 02:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:54 INFO - Running setup.py (path:/tmp/pip-BqxHGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:54 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)) 02:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:54 INFO - Running setup.py (path:/tmp/pip-JaLcru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:54 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)) 02:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:54 INFO - Running setup.py (path:/tmp/pip-wBzdCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:55 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)) 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:55 INFO - Running setup.py (path:/tmp/pip-AL4AKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:55 INFO - Running setup.py (path:/tmp/pip-zKrG81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:55 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)) 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:55 INFO - Running setup.py (path:/tmp/pip-zzQ5dC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:55 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)) 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:55 INFO - Running setup.py (path:/tmp/pip-xKVxmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:55 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)) 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:55 INFO - Running setup.py (path:/tmp/pip-A5GzYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:55 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)) 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:55 INFO - Running setup.py (path:/tmp/pip-GoeA6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:55 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)) 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:55 INFO - Running setup.py (path:/tmp/pip-g3YcUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:55 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)) 02:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:55 INFO - Running setup.py (path:/tmp/pip-kywsP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:55 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)) 02:10:55 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)) 02:10:55 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)) 02:10:55 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)) 02:10:55 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)) 02:10:55 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)) 02:10:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10:57 INFO - Downloading blessings-1.5.1.tar.gz 02:10:57 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 02:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:10:57 INFO - Installing collected packages: blessings 02:10:57 INFO - Running setup.py install for blessings 02:10:57 INFO - Successfully installed blessings 02:10:57 INFO - Cleaning up... 02:10:57 INFO - Return code: 0 02:10:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:10:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:57 INFO - Reading from file tmpfile_stdout 02:10:57 INFO - Current package versions: 02:10:57 INFO - argparse == 1.2.1 02:10:57 INFO - blessings == 1.5.1 02:10:57 INFO - blobuploader == 1.2.4 02:10:57 INFO - docopt == 0.6.1 02:10:57 INFO - manifestparser == 1.1 02:10:57 INFO - mozInstall == 1.12 02:10:57 INFO - mozcrash == 0.16 02:10:57 INFO - mozdebug == 0.1 02:10:57 INFO - mozdevice == 0.47 02:10:57 INFO - mozfile == 1.2 02:10:57 INFO - mozhttpd == 0.7 02:10:57 INFO - mozinfo == 0.9 02:10:57 INFO - mozleak == 0.1 02:10:57 INFO - mozlog == 3.0 02:10:57 INFO - moznetwork == 0.27 02:10:57 INFO - mozprocess == 0.22 02:10:57 INFO - mozprofile == 0.27 02:10:57 INFO - mozrunner == 6.11 02:10:57 INFO - mozscreenshot == 0.1 02:10:57 INFO - mozsystemmonitor == 0.0 02:10:57 INFO - moztest == 0.7 02:10:57 INFO - mozversion == 1.4 02:10:57 INFO - psutil == 3.1.1 02:10:57 INFO - requests == 1.2.3 02:10:57 INFO - wsgiref == 0.1.2 02:10:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:57 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 0x7f5ca132bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c26900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb70>, '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 0x2cbddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe250>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082', '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 02:10:57 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 02:10:57 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 02:10:57 INFO - Using env: {'DISPLAY': ':0', 02:10:57 INFO - 'HOME': '/home/cltbld', 02:10:57 INFO - 'LANG': 'en_US.UTF-8', 02:10:57 INFO - 'LANGUAGE': 'en_US:en', 02:10:57 INFO - 'LOGNAME': 'cltbld', 02:10:57 INFO - 'MAIL': '/var/mail/cltbld', 02:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:57 INFO - 'MOZ_NO_REMOTE': '1', 02:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:57 INFO - 'NO_EM_RESTART': '1', 02:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:57 INFO - 'PWD': '/builds/slave/test', 02:10:57 INFO - 'SHELL': '/bin/bash', 02:10:57 INFO - 'SHLVL': '1', 02:10:57 INFO - 'TERM': 'linux', 02:10:57 INFO - 'TMOUT': '86400', 02:10:57 INFO - 'USER': 'cltbld', 02:10:57 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082', 02:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:57 INFO - '_': '/tools/buildbot/bin/python'} 02:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:10:57 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)) 02:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:10:57 INFO - Cleaning up... 02:10:58 INFO - Return code: 0 02:10:58 INFO - Running post-action listener: _resource_record_post_action 02:10:58 INFO - Running post-action listener: _start_resource_monitoring 02:10:58 INFO - Starting resource monitoring. 02:10:58 INFO - ##### 02:10:58 INFO - ##### Running install step. 02:10:58 INFO - ##### 02:10:58 INFO - Running pre-action listener: _resource_record_pre_action 02:10:58 INFO - Running main action method: install 02:10:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:58 INFO - Reading from file tmpfile_stdout 02:10:58 INFO - Detecting whether we're running mozinstall >=1.0... 02:10:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:10:58 INFO - Reading from file tmpfile_stdout 02:10:58 INFO - Output received: 02:10:58 INFO - Usage: mozinstall [options] installer 02:10:58 INFO - Options: 02:10:58 INFO - -h, --help show this help message and exit 02:10:58 INFO - -d DEST, --destination=DEST 02:10:58 INFO - Directory to install application into. [default: 02:10:58 INFO - "/builds/slave/test"] 02:10:58 INFO - --app=APP Application being installed. [default: firefox] 02:10:58 INFO - mkdir: /builds/slave/test/build/application 02:10:58 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'] 02:10:58 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 02:11:12 INFO - Reading from file tmpfile_stdout 02:11:12 INFO - Output received: 02:11:12 INFO - /builds/slave/test/build/application/firefox/firefox 02:11:12 INFO - Running post-action listener: _resource_record_post_action 02:11:12 INFO - ##### 02:11:12 INFO - ##### Running run-tests step. 02:11:12 INFO - ##### 02:11:12 INFO - Running pre-action listener: _resource_record_pre_action 02:11:12 INFO - Running main action method: run_tests 02:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:11:12 INFO - Python 2.7.3 02:11:12 INFO - Return code: 0 02:11:12 INFO - grabbing minidump binary from tooltool 02:11: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')]} 02:11:12 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 0x2c6cb70>, '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 0x2cbddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:11:12 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 02:11:12 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 02:11:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:11:12 INFO - Return code: 0 02:11:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:11:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:11:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:11:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:11:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] in /builds/slave/test/build 02:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost 02:11:12 INFO - Using env: {'DISPLAY': ':0', 02:11:12 INFO - 'HOME': '/home/cltbld', 02:11:12 INFO - 'LANG': 'en_US.UTF-8', 02:11:12 INFO - 'LANGUAGE': 'en_US:en', 02:11:12 INFO - 'LOGNAME': 'cltbld', 02:11:12 INFO - 'MAIL': '/var/mail/cltbld', 02:11:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:11:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:12 INFO - 'MOZ_NO_REMOTE': '1', 02:11:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:11:12 INFO - 'NO_EM_RESTART': '1', 02:11:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:12 INFO - 'PWD': '/builds/slave/test', 02:11:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:11:12 INFO - 'SHELL': '/bin/bash', 02:11:12 INFO - 'SHLVL': '1', 02:11:12 INFO - 'TERM': 'linux', 02:11:12 INFO - 'TMOUT': '86400', 02:11:12 INFO - 'USER': 'cltbld', 02:11:12 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082', 02:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:12 INFO - '_': '/tools/buildbot/bin/python'} 02:11:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] with output_timeout 3600 02:11:12 INFO - mozversion INFO | application_buildid: 20151119013236 02:11:12 INFO - mozversion INFO | application_changeset: 1ad891c3f905d6b40b88d16b3a37c54c0feb50e5 02:11:12 INFO - mozversion INFO | application_display_name: Nightly 02:11:12 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:11:12 INFO - mozversion INFO | application_name: Firefox 02:11:12 INFO - mozversion INFO | application_remotingname: firefox 02:11:12 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:11:12 INFO - mozversion INFO | application_vendor: Mozilla 02:11:12 INFO - mozversion INFO | application_version: 45.0a1 02:11:12 INFO - mozversion INFO | platform_buildid: 20151119013236 02:11:12 INFO - mozversion INFO | platform_changeset: 1ad891c3f905d6b40b88d16b3a37c54c0feb50e5 02:11:12 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:11:12 INFO - mozversion INFO | platform_version: 45.0a1 02:11:12 INFO - 2015-11-19 02:11:12,866 DEBUG : using testdate: 1447927872 02:11:12 INFO - 2015-11-19 02:11:12,866 DEBUG : actual date: 1447927872 02:11:12 INFO - 2015-11-19 02:11:12,873 INFO : starting webserver on 'localhost:38034' 02:11:12 INFO - 2015-11-19 02:11:12,874 INFO : Starting test suite talos-linux64-ix-037 02:11:12 INFO - 2015-11-19 02:11:12,874 INFO : Starting test dromaeo_css 02:11:12 INFO - 2015-11-19 02:11:12,874 DEBUG : operating with platform_type : linux_ 02:11:12 INFO - 2015-11-19 02:11:12,875 INFO : Initialising browser for dromaeo_css test... 02:11:12 INFO - 2015-11-19 02:11:12,899 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWH2nXi/profile http://localhost:38034/getInfo.html 02:11:19 INFO - 2015-11-19 02:11:19,523 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:11:19 INFO - 2015-11-19 02:11:19,523 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:11:19 INFO - 2015-11-19 02:11:19,523 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:11:19 INFO - 2015-11-19 02:11:19,523 DEBUG : BROWSER_OUTPUT: __metrics 02:11:20 INFO - 2015-11-19 02:11:20,104 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:11:21 INFO - 2015-11-19 02:11:21,570 INFO : Browser initialized. 02:11:21 INFO - 2015-11-19 02:11:21,571 INFO : Running cycle 1/1 for dromaeo_css test... 02:11:21 INFO - 2015-11-19 02:11:21,571 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWH2nXi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:11:33 INFO - 2015-11-19 02:11:33,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 141418496 02:11:33 INFO - 2015-11-19 02:11:33,506 DEBUG : BROWSER_OUTPUT: 02:12:24 INFO - 2015-11-19 02:12:24,801 DEBUG : BROWSER_OUTPUT: 1447927944799 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] 02:14:37 INFO - 2015-11-19 02:14:37,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38034/tests/dromaeo/cssquery-ext.html) 02:14:38 INFO - 2015-11-19 02:14:38,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 246988800 02:14:38 INFO - 2015-11-19 02:14:38,315 DEBUG : BROWSER_OUTPUT: 02:17:40 INFO - 2015-11-19 02:17:40,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/dromaeo/cssquery-ext.html (next: http://localhost:38034/tests/dromaeo/cssquery-jquery.html) 02:17:41 INFO - 2015-11-19 02:17:41,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 218075136 02:17:41 INFO - 2015-11-19 02:17:41,407 DEBUG : BROWSER_OUTPUT: 02:20:43 INFO - 2015-11-19 02:20:43,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38034/tests/dromaeo/cssquery-mootools.html) 02:20:44 INFO - 2015-11-19 02:20:44,049 DEBUG : BROWSER_OUTPUT: RSS: Main: 212414464 02:20:44 INFO - 2015-11-19 02:20:44,050 DEBUG : BROWSER_OUTPUT: 02:23:46 INFO - 2015-11-19 02:23:46,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38034/tests/dromaeo/cssquery-prototype.html) 02:23:46 INFO - 2015-11-19 02:23:46,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 198336512 02:23:46 INFO - 2015-11-19 02:23:46,625 DEBUG : BROWSER_OUTPUT: 02:26:49 INFO - 2015-11-19 02:26:49,326 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38034/tests/dromaeo/cssquery-yui.html) 02:26:49 INFO - 2015-11-19 02:26:49,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 176705536 02:26:49 INFO - 2015-11-19 02:26:49,908 DEBUG : BROWSER_OUTPUT: 02:29:52 INFO - 2015-11-19 02:29:52,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/dromaeo/cssquery-yui.html (next: http://localhost:38034/tests/dromaeo/cssquery-dojo.html) 02:29:52 INFO - 2015-11-19 02:29:52,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 249131008 02:29:52 INFO - 2015-11-19 02:29:52,493 DEBUG : BROWSER_OUTPUT: 02:29:52 INFO - 2015-11-19 02:29:52,494 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:29:52 INFO - 2015-11-19 02:29:52,494 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:29:52 INFO - 2015-11-19 02:29:52,494 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:29:52 INFO - 2015-11-19 02:29:52,494 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:29:52 INFO - 2015-11-19 02:29:52,495 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2631.947361052779;2726.495598314311;2729.836209827409;2743.465024320258;2763.502569537483;4555.88610284743;4634.119517291712;4707.270373092168;4792.83225087122;4834.903301933955;4733.171694953387;4793.161196790566;4801.375821143255;4803.087413391453;4921.926171107436;4424.933625995604;4426.1811564860445;4493.7977790999485;4519.502854685982;4571.542845715435;4480.372747815292;4487.169873573399;4555.316702494619;4564.383808185902;4602.2636378179495;4297.720648157875;4366.323219900921;4398.472183337988;4441.222786012435;4490.550944905516;4432.047109871393;4434.157510073108;4438.889027774299;4439.866803995886;4471.754053527055;4393.450818647669;4395.208862404766;4408.691391602589;4443.688941774077;4459.955400445986;4537.77311134442;4628.305754136873;4634.351190833286;4638.095571363586;4667.976660116712;5161.509656582619;5173.068847607429;5185.274061631375;5187.559057480119;5201.427842937273;5218.6868787872845;5220.565137395106;5236.1098613235845;5240.266362709223;5274.736263186825;4635.69867958585;4695.178343789823;4726.243800991825;4734.289856521549;4827.155247831651;5324.893502129936;5334.306540149833;5336.306280183629;5336.946630533723;5379.031774280589;5097.796088156507;5098.668586541863;5104.872378190501;5105.7191854448365;5126.974365128151;4965.602751779849;5009.499050094962;5065.39215294167;5072.442031376546;5155.32980712505;5176.948230517647;5189.065968125774;5189.662671926313;5196.636235463481;5213.895722085613;5134.922976155361;5162;5174.456682048406;5183.870403239874;5217.321748172713;4125.339945608688;4211.431456753299;4214.05183833635;4304.325634176917;4356.411884395629;3689.6310368963427;3740.4389341598976;3752.6247375262255;3777.2823163598828;3791.374423220138;4440;4452.1763473757455;4460.799264033127;4462.709923854939;4495.662825288116;5060.696358218445;5180.948190518046;5188;5204.193350030751;5210.062188806051;4374.671899607542;4407;4420.911581768347;4446.155230506193;4458.643308535309;4537.274036154199;4542.114287713864;4546.727196368229;4574.4968053514085;4600.263957766808;4754.595859351994;4865.416150062015;4949.034938187091;4959.82640607577;4972.477889821661;5055.368078990126;5117.053345131163;5129.74351282427;5136.434992150935;5152.433232344364;4914.926276105933;4963.478834722447;4964.156093464047;4974.278729584263;5004.349434573628;4847.854564363075;4942.67872588295;5148.9227661584355;5160.948390516047;5171.870703232299;4986.80052797884;5099.592032637306;5106.055379754757;5106.795728170831;5116.386033675983;5053.949460505348;5082.745862706776;5085.211792172219;5086.313347698014;5131.281620573048;4764.737939413366;4875.43932447773;5036.748162591783;5069.721165335942;5087.338645976148;4830.492798256273;4868.196747536616;4926.261060840902;4929.482404347492;4951.133551628379;5079.136546786981;5151.6908985461;5154.974225129;5158.226266060121;5179.223116532399;4741.099191153669;4850.175470170009;5030.0945829751;5046.142155833591;5048.924266136084 02:29:52 INFO - 2015-11-19 02:29:52,497 DEBUG : BROWSER_OUTPUT: |1;ext.html;541.7372574301461;565.0507147991374;569.3338793611472;569.5216018544422;573.125982876114;28110.578341324872;28630.141095767136;28682.569761453567;37505.812470937606;38051.80974095133;40536;41049.58950410495;41106.17787644245;41109;41210.79394603023;7931.325837303822;8101.5544145072;8108.837823243532;8112.269895709385;8124.553149576771;7184;7393.852122957537;9988.300818942676;10238.283320167591;10255.897441025607;10131.848022279672;10170.9491452543;10242.641507547238;10255.846162307571;10263.640772572962;7190.424766018706;7392.741254056083;10015.298929074968;10157.18742500602;10167.135793457564;7096.787096387116;7209.06282183318;10134.695959121238;10431.426271555061;10453.79092418155;37976.050598734975;38471.807640961895;38525.03687407809;38528.22943541114;38570.80714596437;2750.8074434789573;2773.6389684813753;2826.462972035307;2857.157138644084;3276.4280040168355;28510.572341414896;28775.712242877722;28812.711872881213;28855.41868236011;28960.13119606415;3401.812900290508;3445.173158441981;3449.3618680544178;3519.278547897675;3559.839807208682;226367;228821.85589071948;229695;229788;229964;50085.49914500881;56499.717501413055;56848;56868.43131568631;56892;46987.765061174476;65887;67216;67401.32598673951;67448;12003.579874704517;12136.87863121375;12161.209521381083;12168.452419641137;12187.634370968884;10065.144462720604;10192.439415832052;10209.030142136486;10221.131203847608;10223.233257505717;19492.902535487232;19619.90190049069;19631.21475141007;19665.705014424795;19765.60468790645;7314.48798584094;7527.397808175333;7587.355074818592;7593.164751877289;7701.576413297211;876.6493402638868;904.8145130248283;912.3339961827903;979.2802290316612;980.9019098090276;26329.341766455993;26335.73664263333;26382.20853374402;26680.733192668213;26739.732602674114;966.1980556138388;972.3388096094582;981.3277904635347;1045.4720366215013;1134.28540019787;12994.415251313714;13002.804957925639;13072.79716469471;13141.737165256642;13174.143680660727;266947;272956;272968;273186;273470;46159.76920115378;46427;46440.3033954491;46613.766931165126;46634;1021.22897212604;1104.7348636327383;1132.4337831084458;1171.5313874450117;1209.7217639942862;24185.51628967446;24706;25412.491750165264;25500.23499295024;25500.617490738026;36770.632293677794;38067;38080.61919380771;38154.61845381511;38172.23655526818;235082;239171;342744;350691;351541;27116.864415677795;27147.457050859266;27172.45655086927;27255.454890901674;27268;38536;38661.42007869828;39428.60571394364;39608.801955990035;40139.79930100331;33032.66967330296;33613.66386336203;34089.82955085209;34399.828000860834;34533.65466345405;36484.45273320849;38118.428223577226;38301.42547861728;39234;40279.798601006805;35399.82300088483;36677;37033.81483092567;37280.813595931846;37346.813265933495;34833.12917177091;35713.46429803503;36875.44686829646;36914.63085369112;37013.629863702095;28269.293267668472;29211.415771684024;29367.26581835386;30207.546886796277;32510 02:29:52 INFO - 2015-11-19 02:29:52,498 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.09269343546174;341.55427167546355;341.7266187050359;344.63985135533363;344.86205517792894;12526.373681315943;12930.870691293085;15120.395184192634;15161.545153645395;15964.441244556443;14950.476733314335;15179.013364131324;15919.44281950132;15926.920365398186;15981.680366392695;4513.232750432418;4520.638348932078;4521.344405061264;4609.9308510372375;4896.706197628145;3566.4472006838982;3662.7985460799646;3664.8350824212976;3667.853285868562;5010.949890501103;3653.7442379033478;5509.531689806371;5688.658680479164;5690.715464226792;5694.032014557514;5509.807156749514;5632.267805185341;5639.943600563983;5647.463490968352;5647.887042259132;5014.674046186986;5061.316722242487;5061.974690126526;5065.670731402484;5067.189249720027;19029.524261893424;19269.325573604998;19593;19599.706004409945;19896.40310790664;1774.1306759687789;1844.5204246895769;1902.372217168345;1938.5735138269558;1973.6644770389069;13433.194008359433;13463;13491.257980811051;13662.590122296348;13917.23455209963;1833.60577475842;1847.7782666080157;1894.7631546056743;1894.7915729269769;1951.4535929939639;58339.12491312634;59308.99999999957;62730;65165.348346516876;66364.33635663678;15419.61450963735;15441.768373474408;15451.459198927983;15496.845031549765;15545.145017023946;22669.659955100356;22726;22937.655935160987;22941.7705822943;23096.307110786704;7959.363250940027;7971.242731940456;7995.640196191185;8023.716205407107;8080.39397045224;6536.738530458823;6565.343465653492;6604.405603495612;6702.966485167543;6721.428678562279;7425.740099096613;7443.702251909971;7508.361789247866;7515.173330933593;7561.584112873845;1709.4187976087942;1738.0788182263168;2125.873287157809;2934.985325073361;2936.7797415193945;367.3351234265987;367.65991457901333;820.0774129104757;958.8226178157063;969.7236287657984;8532.36007299455;9747.268954828416;10132.290739648153;10206.387616743019;10219.897801022043;379.5824592947791;381.4050081872288;383.05194643257715;389.98440062397754;391.6142599539451;5249.790008399697;5286.735663216824;5318.760655770499;5379.650322729089;5405;476046;476456;485539;489827;492408.18436698784;61705.691471542355;63434.68282658557;63617.681911590145;70735;71774;980.6420656460341;1001.3591301567003;1002.774375765447;1004.0060340263087;1020.5917632946732;13806.309684515532;14542.636434089232;14776.408943642135;14779.556613301618;15043.623909402353;28985.56521652219;30090.24774380658;30110.645020974545;30635.693643064176;32738.836305818317;39872;39885;41096;41864.58135418607;41943;8512.872306915526;8790.824183516166;8894.911050889408;8915.821683566423;9091.727248182566;12577.182483138567;16273.349066037226;16523.173841308126;16801.579960501087;17271.05009224505;11086.667399978014;12989.4154763034;13707.931460342634;13719.588412347646;13893.861061389256;13124.540641077516;13179.275139867399;13497.86502134966;13638.318084095557;13803.2408217549;13568.728625427239;13757.862421375658;13882.375293111632;14023.859761402255;14117.929410352883;8139.593020349077;8785.121487851164;8823.647054117764;8911.955440222757;8929.419587727038;9525.237980961369;9623.951880240555;9624.951875240578;13668.65828354299;14509.637259068608 02:29:52 INFO - 2015-11-19 02:29:52,499 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1424.0814674534918;1657.4447560067376;1720.8107108218098;1720.83652053055;1741.277369891495;6128.11142384354;6833.248342682307;7114.288571142896;7125.073740413745;7135.143782746078;7060.611666358348;7196.712131514733;7200.891986620191;7204.5677259364475;7220.675069621867;1779.7508348831175;1819.927202911882;1820.3082828525141;2094.5601423701005;2116.968245476319;1711.7517959895808;2097.590969760897;2177.7931096545803;2182.508935489518;2183.2686050173133;2088.9164433422643;2095.4447071526056;2099.590579836932;2118.375079351595;2130.7017017617545;1577.5582836805656;1611.8226995030536;2047.672372420413;2060.5981833542464;2079.9688004679942;2122.479992401856;2131.893405329743;2132.69075983983;2134.551744133734;2134.6157691615504;7150.570965742072;7330.560166389981;7338.706451741924;7341.375983041448;7348.5958272295;4244.766537840448;4360.433143691332;4372.344148377737;4372.475302963665;4372.5627437256335;2749.0653177919603;2831.108200916705;2842.6873043965147;2851.3869518053716;2871.124307086338;852.6035393542032;855.850226210417;866.1208872993916;869.1569177897429;880.5113162194979;9722.465264410455;9739.026097390275;9752.609895604168;9753.170980466668;9755.756106097333;3965.0483883867664;4021.7989100544855;4040.373742069984;4052.392141178788;4052.4731784867777;8395.83208335842;8411.621477033548;8416.915830841614;8423.578821058922;8429.620667069996;4418.690691651618;4449.577290157495;4452.065066336041;4452.710573812757;4459.331100334911;4053.533843608023;4054;4062.086030643082;4062.1469491407133;4068.898277543085;3498.8950331490096;3547.0600290922926;3565.0730809989072;3573.857045718194;3605.351036813399;1119.8376235445814;1120.966371008871;1125.7073160978205;1136.1308598921833;1142.5943789954613;947.5925352098664;955.1737746848926;960.6157536985122;1024.359775140537;1189.1854079955258;6574.276829548746;6580.934190658128;6660.866782664417;6674;6702;420.6865884915757;421.1871088798648;421.90507135894177;422.98519551816156;423.61239465888985;5012.548870601663;5096.490350964948;5096.719680417613;5401.702906340189;5571.025070612708;8568.614412351459;8767.956160219159;8790.384673072824;8832.779180520538;8871.379003469696;8383.790405239917;8678.045415004344;8707.434016788888;8715;8721.433106848035;6793.116894803644;6799.082123913307;6861.622610756456;6862.210845752703;6877.518573699893;6763.93236067633;6862.965685171542;6868.519203655696;6872.10662613857;6876.415504681958;7737.148913619385;7859;7904.367650588054;7916.722914697958;7940.6426710796995;7965.163657815846;8017.759467215993;8120.472169308976;8201.79495512617;8274.089850116363;6316.11574379578;6424.164858568356;6431.48548116159;6439.162908821823;6449.419552240321;6893.75871844483;6922.5154239202775;6942.201646810681;6951.409130223988;6957.860842783015;6612.272650008399;6647.268800431852;6651.534392592472;6707.0945422369305;6816.829579260359;6564.8358791030605;6584.901226481511;6619.27188009309;6713.765018224339;6727.091842601186;6681.231658359156;6721.596704197764;6732.629705366252;6739.932600674127;6742.157230346207;6080.69596520181;6083.756649733961;6114.541409394402;6115.510759139347;6145.661988590492;6134.171886795226;6226.85173615102;6247.0629405589525;6253.218347706536;6269.216347956505 02:29:52 INFO - 2015-11-19 02:29:52,499 DEBUG : BROWSER_OUTPUT: |4;prototype.html;290.69767441860455;295.0528802543834;303.0650443382166;303.0952606469686;303.46741468722394;5479.753411096495;5484.698341591211;5554.416786237448;5611.382747897728;5652.745626446809;5424.972875135629;5499.257600223968;5521.116621340586;5521.337439507255;5531.9723401382935;4066.2883995300854;4254.595813397722;4261.254280500915;4262.254105531535;4267.061246525759;4070.1656160487178;4159.438475805758;4205.621494065534;4206.894827629319;4212.473440819897;4141.6065473779945;4147.191297696951;4162.500499940012;4171.228322760284;4174;3976.423418604315;4065.8983525411804;4078.3270760324513;4146.564610715876;4162.0635357044575;3650.945235821465;3662.432322989941;3664.1022949377307;3665.541807274091;3678.0437086357474;5278.762455689503;5286.259923610698;5298.231756395301;5300.0459917214885;5300.655457395295;4838.854834354975;4845.176320025604;4853.150698627726;4854.053459575384;4857.465678775332;5652.378238393773;5796.217510636052;5798.82603521895;5802.506786923117;5808.012637851575;3864.0726225705907;3903.711775114234;3905.1799122184375;3906.980465097685;3910.4916360872903;6029.879402411927;6127.11156882254;6129.601575897597;6136.447719705248;6142.416470435346;4096.959030409657;4100.6924480664065;4102.056526998807;4102.200070986189;4102.466679331727;3964.2467931093;4124.422580838685;4159;4163;4164.1879833432795;4768.856934291976;4773.546513081252;4774.7135171889795;4775.856724298276;4776.402949631296;5798.10129429939;5816.82549523515;5819.214406055213;5821.126830975303;5822.592418530662;1418.858114188573;1444.7832825076323;1445.91324520527;1446.0383844743128;1447.2691290898028;936.1527817325332;943.3679434778714;945.8817647794026;965.7440778193784;969.2778879734502;5071.771770270347;5079.31429257053;5082.136036873666;5089.541941225308;5093.8726531836255;6048.818535443944;6052.66710330936;6055.182550355734;6058.666773327509;6060.454559089615;5056.57019153376;5069.721165335868;5084.466131056186;5086.745662716849;5088.542031217208;3199.616046074486;3240.4977228529615;3270.0516850113677;3276.311974485337;3283.1792051987004;5706.771729130871;5708.914366284509;5715.885682286331;5716.542676585863;5717.428257174332;6137.7851775187655;6204.069389591597;6213.254409470893;6218.533609979269;6222.875542489125;5547.528460080938;5700.287464067074;5701.942980570141;5702;5708.172315014383;6033;6033.456988871023;6045.304789949037;6050.364711705208;6050.788222412194;5884.176215329943;5892.7642894283745;5894.705264736832;5901.262342207224;5901.675407852609;5702.258706368146;5706.3152421709665;5708.172315014383;5709.51469125129;5709.8287051388525;3933.5673075962195;4009.3785463253244;4013.5384430789663;4026.1746341999233;4049.6962727794944;6057.363976782374;6058.939410605837;6062.120992455981;6066.757329706938;6068.089786531879;5835.299764028344;5840.8247752567495;5841.824745257649;5843.912341314969;5846.093855452412;5737.8565535861935;5775.133729940542;5819.94180058194;5846.824595262149;5858.150568167677;5694.259746232963;5697.6296540724725;5706.572007099401;5706.714664266687;5708.65748055118;5661.66030038199;5833.270841144857;5867.794627188028;5873.471387575139;5884.205632239593;5581.804636837691;5766.365699772938;5769.711514424346;5793.188953546591;5793.594448388572 02:29:52 INFO - 2015-11-19 02:29:52,500 DEBUG : BROWSER_OUTPUT: |5;yui.html;622.4553515673788;633.9017452294894;694.3126304958093;731.9780406587801;752.0486584470642;11187.105031597473;11472.196946213768;11497.367644779533;11510.654680359592;13785.310734463286;12828.871711282907;12866.678333041678;12877.67805804853;12939.482420703183;12947.287899165542;612.5008118383503;621.8631900981777;779.867422538167;787.810925377908;799.256691277112;801.4429971170039;802.4663598706853;808.9474184178039;809.2029351089172;809.3444310108802;642.7332656947361;781.0783275734659;828.7430896422098;844.4046946902419;845.995770021149;652.2759736692268;819.0539926385005;834.470111479212;834.8831163637095;835.3776436554745;612.1796792298297;613.2610204703321;616.7779599344233;617.1329282358294;617.4042049422329;12214;12328.383580820922;12347.444365003596;12349.69125771854;12361.752764944651;10982.560697572088;11707.53169873204;11993.520259189709;12148.9673377763;12574.43415046325;8993.460392376479;9314.208292295163;9451.33840631156;9813.90186098137;9824.673669054657;3247.805131692106;3304.322613864152;3317.08780085476;3318.867245310185;3321.9169520761934;42081;42103;42476.57523424788;42741.35887961683;43265.99999999969;9314.208292295096;9397.76505587352;9561.808763824685;9567.37812042215;9578;17386.565335866704;17408.912955435142;17414.82585174132;17420.825791742172;17443.30226790914;6352.205974253218;6432.903506447407;6435.131257280207;6453.1610890583925;6679.332066793282;3292.6378098409155;3393.9490907636405;3394.473856552189;3507.1920197527115;3522.947155792665;2718.198131551197;2747.835129892213;2751.284665986858;2770.2104900103777;2785.7492825645386;491.78607305822084;503.66757939759583;509.3404041765922;518.3753576939779;519.2444992535851;508.5372311196793;544.1918750655274;565.5023579250316;569.2087997683224;572.8567858035491;7747.573883436352;7924.643391047417;7962.657606719258;7967.482113662593;7987.1613480584865;454.69308216953425;528.4398537550132;547.9452054794505;552.1248820619284;555.9610827242054;3700.9444858327147;3707.4728125311676;3741.6819570336825;3764.5294338207723;3793.393057110904;51010.23484647733;51115.233271500954;51268.7182820425;51714.224286635734;51997.7400112997;45329.32006019913;46625.5337446628;47147.764261178476;47273;47300;41523.377149342785;41599;41641.37537936933;42538;42767.35848962268;7016.438684905093;7073.257307982588;7091.82270443243;7129.35835774762;7222.674979625825;32260.19349516281;32633.836830815693;32678;32686;33345.166370840925;36503.45244821277;37272.44091338686;41192.176156477304;41339.586604134776;42016;9091.954540227256;9221.49281789508;9279.164875161268;9401.247900168108;9566.808663826823;9388.108129727665;9524.190443812353;9525;9549.09283618055;9821.165200957712;8683.435576687496;8796.296296296408;8948.552572371225;8957.910420895707;8990.415622984485;9506;9514.619415223313;9519.095685909828;9619.422834629944;9800.460974646463;9005.63977440895;9132.08679132108;9140.22308103792;9143.588538515916;9153.405028673114;8181.79545511367;8259.42184047111;8283.523876244062;8324.125966773401;8392.790180245298;7798.727044553413;8292.543910085004;8439.70461033861;8446.915530844613;8469.491830490191 02:29:52 INFO - 2015-11-19 02:29:52,500 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:29:52 INFO - 2015-11-19 02:29:52,501 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:29:52 INFO - 2015-11-19 02:29:52,501 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,951 02:29:52 INFO - 2015-11-19 02:29:52,501 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:29:52 INFO - 2015-11-19 02:29:52,501 DEBUG : BROWSER_OUTPUT: __startTimestamp1447928992491__endTimestamp 02:29:52 INFO - 2015-11-19 02:29:52,501 DEBUG : BROWSER_OUTPUT: 02:29:52 INFO - 2015-11-19 02:29:52,501 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:29:52 INFO - 2015-11-19 02:29:52,501 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:29:52 INFO - 2015-11-19 02:29:52,501 DEBUG : BROWSER_OUTPUT: 02:29:52 INFO - 2015-11-19 02:29:52,501 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4755.36 Median:4875.44 stddev:509.61 (10.5%) stddev-sans-first:483.18 02:29:52 INFO - 2015-11-19 02:29:52,502 DEBUG : BROWSER_OUTPUT: Values: 2631.9 2726.5 2729.8 2743.5 2763.5 4555.9 4634.1 4707.3 4792.8 4834.9 4733.2 4793.2 4801.4 4803.1 4921.9 4424.9 4426.2 4493.8 4519.5 4571.5 4480.4 4487.2 4555.3 4564.4 4602.3 4297.7 4366.3 4398.5 4441.2 4490.6 4432.0 4434.2 4438.9 4439.9 4471.8 4393.5 4395.2 4408.7 4443.7 4460.0 4537.8 4628.3 4634.4 4638.1 4668.0 5161.5 5173.1 5185.3 5187.6 5201.4 5218.7 5220.6 5236.1 5240.3 5274.7 4635.7 4695.2 4726.2 4734.3 4827.2 5324.9 5334.3 5336.3 5336.9 5379.0 5097.8 5098.7 5104.9 5105.7 5127.0 4965.6 5009.5 5065.4 5072.4 5155.3 5176.9 5189.1 5189.7 5196.6 5213.9 5134.9 5162.0 5174.5 5183.9 5217.3 4125.3 4211.4 4214.1 4304.3 4356.4 3689.6 3740.4 3752.6 3777.3 3791.4 4440.0 4452.2 4460.8 4462.7 4495.7 5060.7 5180.9 5188.0 5204.2 5210.1 4374.7 4407.0 4420.9 4446.2 4458.6 4537.3 4542.1 4546.7 4574.5 4600.3 4754.6 4865.4 4949.0 4959.8 4972.5 5055.4 5117.1 5129.7 5136.4 5152.4 4914.9 4963.5 4964.2 4974.3 5004.3 4847.9 4942.7 5148.9 5160.9 5171.9 4986.8 5099.6 5106.1 5106.8 5116.4 5053.9 5082.7 5085.2 5086.3 5131.3 4764.7 4875.4 5036.7 5069.7 5087.3 4830.5 4868.2 4926.3 4929.5 4951.1 5079.1 5151.7 5155.0 5158.2 5179.2 4741.1 4850.2 5030.1 5046.1 5048.9 02:29:52 INFO - 2015-11-19 02:29:52,503 DEBUG : BROWSER_OUTPUT: 02:29:52 INFO - 2015-11-19 02:29:52,503 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43308.62 Median:18922.50 stddev:71103.02 (375.8%) stddev-sans-first:71229.97 02:29:52 INFO - 2015-11-19 02:29:52,503 DEBUG : BROWSER_OUTPUT: Values: 541.7 565.1 569.3 569.5 573.1 28110.6 28630.1 28682.6 37505.8 38051.8 40536.0 41049.6 41106.2 41109.0 41210.8 7931.3 8101.6 8108.8 8112.3 8124.6 7184.0 7393.9 9988.3 10238.3 10255.9 10131.8 10170.9 10242.6 10255.8 10263.6 7190.4 7392.7 10015.3 10157.2 10167.1 7096.8 7209.1 10134.7 10431.4 10453.8 37976.1 38471.8 38525.0 38528.2 38570.8 2750.8 2773.6 2826.5 2857.2 3276.4 28510.6 28775.7 28812.7 28855.4 28960.1 3401.8 3445.2 3449.4 3519.3 3559.8 226367.0 228821.9 229695.0 229788.0 229964.0 50085.5 56499.7 56848.0 56868.4 56892.0 46987.8 65887.0 67216.0 67401.3 67448.0 12003.6 12136.9 12161.2 12168.5 12187.6 10065.1 10192.4 10209.0 10221.1 10223.2 19492.9 19619.9 19631.2 19665.7 19765.6 7314.5 7527.4 7587.4 7593.2 7701.6 876.6 904.8 912.3 979.3 980.9 26329.3 26335.7 26382.2 26680.7 26739.7 966.2 972.3 981.3 1045.5 1134.3 12994.4 13002.8 13072.8 13141.7 13174.1 266947.0 272956.0 272968.0 273186.0 273470.0 46159.8 46427.0 46440.3 46613.8 46634.0 1021.2 1104.7 1132.4 1171.5 1209.7 24185.5 24706.0 25412.5 25500.2 25500.6 36770.6 38067.0 38080.6 38154.6 38172.2 235082.0 239171.0 342744.0 350691.0 351541.0 27116.9 27147.5 27172.5 27255.5 27268.0 38536.0 38661.4 39428.6 39608.8 40139.8 33032.7 33613.7 34089.8 34399.8 34533.7 36484.5 38118.4 38301.4 39234.0 40279.8 35399.8 36677.0 37033.8 37280.8 37346.8 34833.1 35713.5 36875.4 36914.6 37013.6 28269.3 29211.4 29367.3 30207.5 32510.0 02:29:52 INFO - 2015-11-19 02:29:52,503 DEBUG : BROWSER_OUTPUT: 02:29:52 INFO - 2015-11-19 02:29:52,503 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26540.54 Median:3658.27 stddev:78998.43 (2159.4%) stddev-sans-first:79195.54 02:29:52 INFO - 2015-11-19 02:29:52,503 DEBUG : BROWSER_OUTPUT: Values: 341.1 341.6 341.7 344.6 344.9 12526.4 12930.9 15120.4 15161.5 15964.4 14950.5 15179.0 15919.4 15926.9 15981.7 4513.2 4520.6 4521.3 4609.9 4896.7 3566.4 3662.8 3664.8 3667.9 5010.9 3653.7 5509.5 5688.7 5690.7 5694.0 5509.8 5632.3 5639.9 5647.5 5647.9 5014.7 5061.3 5062.0 5065.7 5067.2 19029.5 19269.3 19593.0 19599.7 19896.4 1774.1 1844.5 1902.4 1938.6 1973.7 13433.2 13463.0 13491.3 13662.6 13917.2 1833.6 1847.8 1894.8 1894.8 1951.5 58339.1 59309.0 62730.0 65165.3 66364.3 15419.6 15441.8 15451.5 15496.8 15545.1 22669.7 22726.0 22937.7 22941.8 23096.3 7959.4 7971.2 7995.6 8023.7 8080.4 6536.7 6565.3 6604.4 6703.0 6721.4 7425.7 7443.7 7508.4 7515.2 7561.6 1709.4 1738.1 2125.9 2935.0 2936.8 367.3 367.7 820.1 958.8 969.7 8532.4 9747.3 10132.3 10206.4 10219.9 379.6 381.4 383.1 390.0 391.6 5249.8 5286.7 5318.8 5379.7 5405.0 476046.0 476456.0 485539.0 489827.0 492408.2 61705.7 63434.7 63617.7 70735.0 71774.0 980.6 1001.4 1002.8 1004.0 1020.6 13806.3 14542.6 14776.4 14779.6 15043.6 28985.6 30090.2 30110.6 30635.7 32738.8 39872.0 39885.0 41096.0 41864.6 41943.0 8512.9 8790.8 8894.9 8915.8 9091.7 12577.2 16273.3 16523.2 16801.6 17271.1 11086.7 12989.4 13707.9 13719.6 13893.9 13124.5 13179.3 13497.9 13638.3 13803.2 13568.7 13757.9 13882.4 14023.9 14117.9 8139.6 8785.1 8823.6 8912.0 8929.4 9525.2 9624.0 9625.0 13668.7 14509.6 02:29:52 INFO - 2015-11-19 02:29:52,503 DEBUG : BROWSER_OUTPUT: 02:29:52 INFO - 2015-11-19 02:29:52,503 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5073.72 Median:6435.32 stddev:2662.06 (41.4%) stddev-sans-first:2655.40 02:29:52 INFO - 2015-11-19 02:29:52,504 DEBUG : BROWSER_OUTPUT: Values: 1424.1 1657.4 1720.8 1720.8 1741.3 6128.1 6833.2 7114.3 7125.1 7135.1 7060.6 7196.7 7200.9 7204.6 7220.7 1779.8 1819.9 1820.3 2094.6 2117.0 1711.8 2097.6 2177.8 2182.5 2183.3 2088.9 2095.4 2099.6 2118.4 2130.7 1577.6 1611.8 2047.7 2060.6 2080.0 2122.5 2131.9 2132.7 2134.6 2134.6 7150.6 7330.6 7338.7 7341.4 7348.6 4244.8 4360.4 4372.3 4372.5 4372.6 2749.1 2831.1 2842.7 2851.4 2871.1 852.6 855.9 866.1 869.2 880.5 9722.5 9739.0 9752.6 9753.2 9755.8 3965.0 4021.8 4040.4 4052.4 4052.5 8395.8 8411.6 8416.9 8423.6 8429.6 4418.7 4449.6 4452.1 4452.7 4459.3 4053.5 4054.0 4062.1 4062.1 4068.9 3498.9 3547.1 3565.1 3573.9 3605.4 1119.8 1121.0 1125.7 1136.1 1142.6 947.6 955.2 960.6 1024.4 1189.2 6574.3 6580.9 6660.9 6674.0 6702.0 420.7 421.2 421.9 423.0 423.6 5012.5 5096.5 5096.7 5401.7 5571.0 8568.6 8768.0 8790.4 8832.8 8871.4 8383.8 8678.0 8707.4 8715.0 8721.4 6793.1 6799.1 6861.6 6862.2 6877.5 6763.9 6863.0 6868.5 6872.1 6876.4 7737.1 7859.0 7904.4 7916.7 7940.6 7965.2 8017.8 8120.5 8201.8 8274.1 6316.1 6424.2 6431.5 6439.2 6449.4 6893.8 6922.5 6942.2 6951.4 6957.9 6612.3 6647.3 6651.5 6707.1 6816.8 6564.8 6584.9 6619.3 6713.8 6727.1 6681.2 6721.6 6732.6 6739.9 6742.2 6080.7 6083.8 6114.5 6115.5 6145.7 6134.2 6226.9 6247.1 6253.2 6269.2 02:29:52 INFO - 2015-11-19 02:29:52,504 DEBUG : BROWSER_OUTPUT: 02:29:52 INFO - 2015-11-19 02:29:52,505 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4790.72 Median:5526.65 stddev:1441.95 (26.1%) stddev-sans-first:1405.88 02:29:52 INFO - 2015-11-19 02:29:52,506 DEBUG : BROWSER_OUTPUT: Values: 290.7 295.1 303.1 303.1 303.5 5479.8 5484.7 5554.4 5611.4 5652.7 5425.0 5499.3 5521.1 5521.3 5532.0 4066.3 4254.6 4261.3 4262.3 4267.1 4070.2 4159.4 4205.6 4206.9 4212.5 4141.6 4147.2 4162.5 4171.2 4174.0 3976.4 4065.9 4078.3 4146.6 4162.1 3650.9 3662.4 3664.1 3665.5 3678.0 5278.8 5286.3 5298.2 5300.0 5300.7 4838.9 4845.2 4853.2 4854.1 4857.5 5652.4 5796.2 5798.8 5802.5 5808.0 3864.1 3903.7 3905.2 3907.0 3910.5 6029.9 6127.1 6129.6 6136.4 6142.4 4097.0 4100.7 4102.1 4102.2 4102.5 3964.2 4124.4 4159.0 4163.0 4164.2 4768.9 4773.5 4774.7 4775.9 4776.4 5798.1 5816.8 5819.2 5821.1 5822.6 1418.9 1444.8 1445.9 1446.0 1447.3 936.2 943.4 945.9 965.7 969.3 5071.8 5079.3 5082.1 5089.5 5093.9 6048.8 6052.7 6055.2 6058.7 6060.5 5056.6 5069.7 5084.5 5086.7 5088.5 3199.6 3240.5 3270.1 3276.3 3283.2 5706.8 5708.9 5715.9 5716.5 5717.4 6137.8 6204.1 6213.3 6218.5 6222.9 5547.5 5700.3 5701.9 5702.0 5708.2 6033.0 6033.5 6045.3 6050.4 6050.8 5884.2 5892.8 5894.7 5901.3 5901.7 5702.3 5706.3 5708.2 5709.5 5709.8 3933.6 4009.4 4013.5 4026.2 4049.7 6057.4 6058.9 6062.1 6066.8 6068.1 5835.3 5840.8 5841.8 5843.9 5846.1 5737.9 5775.1 5819.9 5846.8 5858.2 5694.3 5697.6 5706.6 5706.7 5708.7 5661.7 5833.3 5867.8 5873.5 5884.2 5581.8 5766.4 5769.7 5793.2 5793.6 02:29:52 INFO - 2015-11-19 02:29:52,506 DEBUG : BROWSER_OUTPUT: 02:29:52 INFO - 2015-11-19 02:29:52,506 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12338.94 Median:612.34 stddev:14406.34 (2352.7%) stddev-sans-first:14419.89 02:29:52 INFO - 2015-11-19 02:29:52,506 DEBUG : BROWSER_OUTPUT: Values: 622.5 633.9 694.3 732.0 752.0 11187.1 11472.2 11497.4 11510.7 13785.3 12828.9 12866.7 12877.7 12939.5 12947.3 612.5 621.9 779.9 787.8 799.3 801.4 802.5 808.9 809.2 809.3 642.7 781.1 828.7 844.4 846.0 652.3 819.1 834.5 834.9 835.4 612.2 613.3 616.8 617.1 617.4 12214.0 12328.4 12347.4 12349.7 12361.8 10982.6 11707.5 11993.5 12149.0 12574.4 8993.5 9314.2 9451.3 9813.9 9824.7 3247.8 3304.3 3317.1 3318.9 3321.9 42081.0 42103.0 42476.6 42741.4 43266.0 9314.2 9397.8 9561.8 9567.4 9578.0 17386.6 17408.9 17414.8 17420.8 17443.3 6352.2 6432.9 6435.1 6453.2 6679.3 3292.6 3393.9 3394.5 3507.2 3522.9 2718.2 2747.8 2751.3 2770.2 2785.7 491.8 503.7 509.3 518.4 519.2 508.5 544.2 565.5 569.2 572.9 7747.6 7924.6 7962.7 7967.5 7987.2 454.7 528.4 547.9 552.1 556.0 3700.9 3707.5 3741.7 3764.5 3793.4 51010.2 51115.2 51268.7 51714.2 51997.7 45329.3 46625.5 47147.8 47273.0 47300.0 41523.4 41599.0 41641.4 42538.0 42767.4 7016.4 7073.3 7091.8 7129.4 7222.7 32260.2 32633.8 32678.0 32686.0 33345.2 36503.5 37272.4 41192.2 41339.6 42016.0 9092.0 9221.5 9279.2 9401.2 9566.8 9388.1 9524.2 9525.0 9549.1 9821.2 8683.4 8796.3 8948.6 8957.9 8990.4 9506.0 9514.6 9519.1 9619.4 9800.5 9005.6 9132.1 9140.2 9143.6 9153.4 8181.8 8259.4 8283.5 8324.1 8392.8 7798.7 8292.5 8439.7 8446.9 8469.5 02:29:52 INFO - 2015-11-19 02:29:52,506 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:29:52 INFO - 2015-11-19 02:29:52,506 DEBUG : BROWSER_OUTPUT: 02:29:53 INFO - 2015-11-19 02:29:53,221 INFO : Browser exited with error code: 0 02:29:53 INFO - 2015-11-19 02:29:53,237 INFO : Completed test dromaeo_css (00:18:40) 02:29:53 INFO - 2015-11-19 02:29:53,237 INFO : Starting test kraken 02:29:53 INFO - 2015-11-19 02:29:53,237 DEBUG : operating with platform_type : linux_ 02:29:53 INFO - 2015-11-19 02:29:53,237 INFO : Initialising browser for kraken test... 02:29:53 INFO - 2015-11-19 02:29:53,243 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxXVdd_/profile http://localhost:38034/getInfo.html 02:29:57 INFO - 2015-11-19 02:29:57,392 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:29:57 INFO - 2015-11-19 02:29:57,392 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:29:57 INFO - 2015-11-19 02:29:57,392 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:29:57 INFO - 2015-11-19 02:29:57,392 DEBUG : BROWSER_OUTPUT: __metrics 02:29:57 INFO - 2015-11-19 02:29:57,468 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:29:58 INFO - 2015-11-19 02:29:58,174 DEBUG : BROWSER_OUTPUT: console.error: 02:29:58 INFO - 2015-11-19 02:29:58,178 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 02:29:58 INFO - 2015-11-19 02:29:58,178 DEBUG : BROWSER_OUTPUT: Stack: 02:29:58 INFO - 2015-11-19 02:29:58,178 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 02:29:58 INFO - 2015-11-19 02:29:58,178 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 02:29:58 INFO - 2015-11-19 02:29:58,178 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 02:29:58 INFO - 2015-11-19 02:29:58,179 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 02:29:58 INFO - 2015-11-19 02:29:58,179 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 02:29:58 INFO - 2015-11-19 02:29:58,179 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 02:29:58 INFO - 2015-11-19 02:29:58,179 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 02:29:58 INFO - 2015-11-19 02:29:58,179 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 02:29:58 INFO - 2015-11-19 02:29:58,179 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 02:29:58 INFO - 2015-11-19 02:29:58,179 DEBUG : BROWSER_OUTPUT: 02:29:58 INFO - 2015-11-19 02:29:58,813 INFO : Browser initialized. 02:29:58 INFO - 2015-11-19 02:29:58,814 INFO : Running cycle 1/1 for kraken test... 02:29:58 INFO - 2015-11-19 02:29:58,814 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxXVdd_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:30:10 INFO - 2015-11-19 02:30:10,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 142082048 02:30:10 INFO - 2015-11-19 02:30:10,736 DEBUG : BROWSER_OUTPUT: 02:30:13 INFO - 2015-11-19 02:30:13,383 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38034/tests/kraken/driver.html?testName=audio-beat-detection) 02:30:13 INFO - 2015-11-19 02:30:13,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 174780416 02:30:13 INFO - 2015-11-19 02:30:13,969 DEBUG : BROWSER_OUTPUT: 02:30:16 INFO - 2015-11-19 02:30:16,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38034/tests/kraken/driver.html?testName=audio-dft) 02:30:17 INFO - 2015-11-19 02:30:17,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 166584320 02:30:17 INFO - 2015-11-19 02:30:17,281 DEBUG : BROWSER_OUTPUT: 02:30:20 INFO - 2015-11-19 02:30:20,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38034/tests/kraken/driver.html?testName=audio-fft) 02:30:20 INFO - 2015-11-19 02:30:20,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 151564288 02:30:20 INFO - 2015-11-19 02:30:20,849 DEBUG : BROWSER_OUTPUT: 02:30:22 INFO - 2015-11-19 02:30:22,907 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38034/tests/kraken/driver.html?testName=audio-oscillator) 02:30:23 INFO - 2015-11-19 02:30:23,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 154882048 02:30:23 INFO - 2015-11-19 02:30:23,477 DEBUG : BROWSER_OUTPUT: 02:30:25 INFO - 2015-11-19 02:30:25,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38034/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:30:26 INFO - 2015-11-19 02:30:26,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 156295168 02:30:26 INFO - 2015-11-19 02:30:26,250 DEBUG : BROWSER_OUTPUT: 02:30:29 INFO - 2015-11-19 02:30:29,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38034/tests/kraken/driver.html?testName=imaging-darkroom) 02:30:29 INFO - 2015-11-19 02:30:29,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 156418048 02:30:29 INFO - 2015-11-19 02:30:29,769 DEBUG : BROWSER_OUTPUT: 02:30:33 INFO - 2015-11-19 02:30:33,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38034/tests/kraken/driver.html?testName=imaging-desaturate) 02:30:33 INFO - 2015-11-19 02:30:33,771 DEBUG : BROWSER_OUTPUT: RSS: Main: 157671424 02:30:33 INFO - 2015-11-19 02:30:33,772 DEBUG : BROWSER_OUTPUT: 02:30:36 INFO - 2015-11-19 02:30:36,634 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38034/tests/kraken/driver.html?testName=json-parse-financial) 02:30:37 INFO - 2015-11-19 02:30:37,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 158707712 02:30:37 INFO - 2015-11-19 02:30:37,215 DEBUG : BROWSER_OUTPUT: 02:30:38 INFO - 2015-11-19 02:30:38,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38034/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:30:39 INFO - 2015-11-19 02:30:39,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 163024896 02:30:39 INFO - 2015-11-19 02:30:39,535 DEBUG : BROWSER_OUTPUT: 02:30:41 INFO - 2015-11-19 02:30:41,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38034/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:30:42 INFO - 2015-11-19 02:30:42,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 161153024 02:30:42 INFO - 2015-11-19 02:30:42,011 DEBUG : BROWSER_OUTPUT: 02:30:44 INFO - 2015-11-19 02:30:44,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38034/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:30:45 INFO - 2015-11-19 02:30:45,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 164499456 02:30:45 INFO - 2015-11-19 02:30:45,120 DEBUG : BROWSER_OUTPUT: 02:30:47 INFO - 2015-11-19 02:30:47,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38034/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:30:48 INFO - 2015-11-19 02:30:48,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 175595520 02:30:48 INFO - 2015-11-19 02:30:48,242 DEBUG : BROWSER_OUTPUT: 02:30:50 INFO - 2015-11-19 02:30:50,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38034/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:30:51 INFO - 2015-11-19 02:30:51,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 172777472 02:30:51 INFO - 2015-11-19 02:30:51,370 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38034/tests/kraken/driver.html?testName=ai-astar) 02:30:53 INFO - 2015-11-19 02:30:53,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 231419904 02:30:53 INFO - 2015-11-19 02:30:53,394 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,395 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:30:53 INFO - 2015-11-19 02:30:53,396 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:30:53 INFO - 2015-11-19 02:30:53,396 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:30:53 INFO - 2015-11-19 02:30:53,396 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:30:53 INFO - 2015-11-19 02:30:53,397 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;107;110;112;112;100;111;102;111 02:30:53 INFO - 2015-11-19 02:30:53,397 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;133;159;169;139;157;159;132;169;133 02:30:53 INFO - 2015-11-19 02:30:53,397 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;159;160;162;160;160;161;164;163;162 02:30:53 INFO - 2015-11-19 02:30:53,397 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;75;83;104;72;72;72;112;91;72 02:30:53 INFO - 2015-11-19 02:30:53,397 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;128;92;91;91;134;91;91;127 02:30:53 INFO - 2015-11-19 02:30:53,398 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;109;109;110;110;109 02:30:53 INFO - 2015-11-19 02:30:53,398 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;147;147;146;147;147;148;147;147 02:30:53 INFO - 2015-11-19 02:30:53,398 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;96;96;96;96;96;95 02:30:53 INFO - 2015-11-19 02:30:53,398 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;70;69;69;70;69;76;77;67;67 02:30:53 INFO - 2015-11-19 02:30:53,399 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;70;69;69;68;68;69 02:30:53 INFO - 2015-11-19 02:30:53,399 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;82;83;84;85;86;85;83;83 02:30:53 INFO - 2015-11-19 02:30:53,399 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;119;125;118;126;125;131;121;124;131 02:30:53 INFO - 2015-11-19 02:30:53,399 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;134;152;157;146;137;148;143;145;136 02:30:53 INFO - 2015-11-19 02:30:53,400 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;71;70;70;79;74;70;70;78;70 02:30:53 INFO - 2015-11-19 02:30:53,400 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:30:53 INFO - 2015-11-19 02:30:53,400 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:30:53 INFO - 2015-11-19 02:30:53,400 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,970 02:30:53 INFO - 2015-11-19 02:30:53,401 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:30:53 INFO - 2015-11-19 02:30:53,401 DEBUG : BROWSER_OUTPUT: __startTimestamp1447929053395__endTimestamp 02:30:53 INFO - 2015-11-19 02:30:53,401 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,404 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:30:53 INFO - 2015-11-19 02:30:53,405 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:30:53 INFO - 2015-11-19 02:30:53,405 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,405 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.80 Median:111.00 stddev:4.44 (4.0%) stddev-sans-first:4.69 02:30:53 INFO - 2015-11-19 02:30:53,406 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 107.0 110.0 112.0 112.0 100.0 111.0 102.0 111.0 02:30:53 INFO - 2015-11-19 02:30:53,406 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,406 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.10 Median:158.00 stddev:14.75 (9.3%) stddev-sans-first:15.64 02:30:53 INFO - 2015-11-19 02:30:53,406 DEBUG : BROWSER_OUTPUT: Values: 151.0 133.0 159.0 169.0 139.0 157.0 159.0 132.0 169.0 133.0 02:30:53 INFO - 2015-11-19 02:30:53,407 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,407 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.55 (1.0%) stddev-sans-first:1.64 02:30:53 INFO - 2015-11-19 02:30:53,407 DEBUG : BROWSER_OUTPUT: Values: 161.0 159.0 160.0 162.0 160.0 160.0 161.0 164.0 163.0 162.0 02:30:53 INFO - 2015-11-19 02:30:53,408 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,408 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.50 Median:72.00 stddev:14.95 (20.8%) stddev-sans-first:15.37 02:30:53 INFO - 2015-11-19 02:30:53,408 DEBUG : BROWSER_OUTPUT: Values: 72.0 75.0 83.0 104.0 72.0 72.0 72.0 112.0 91.0 72.0 02:30:53 INFO - 2015-11-19 02:30:53,408 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,409 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.80 Median:91.00 stddev:18.63 (20.5%) stddev-sans-first:19.35 02:30:53 INFO - 2015-11-19 02:30:53,409 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 128.0 92.0 91.0 91.0 134.0 91.0 91.0 127.0 02:30:53 INFO - 2015-11-19 02:30:53,409 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,409 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 02:30:53 INFO - 2015-11-19 02:30:53,409 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 02:30:53 INFO - 2015-11-19 02:30:53,409 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,410 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 02:30:53 INFO - 2015-11-19 02:30:53,410 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 147.0 147.0 146.0 147.0 147.0 148.0 147.0 147.0 02:30:53 INFO - 2015-11-19 02:30:53,410 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,410 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:30:53 INFO - 2015-11-19 02:30:53,410 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 02:30:53 INFO - 2015-11-19 02:30:53,410 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,410 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.40 Median:70.00 stddev:3.41 (4.9%) stddev-sans-first:3.61 02:30:53 INFO - 2015-11-19 02:30:53,410 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 69.0 69.0 70.0 69.0 76.0 77.0 67.0 67.0 02:30:53 INFO - 2015-11-19 02:30:53,410 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,411 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 02:30:53 INFO - 2015-11-19 02:30:53,411 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 70.0 69.0 69.0 68.0 68.0 69.0 02:30:53 INFO - 2015-11-19 02:30:53,411 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,411 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:1.23 (1.5%) stddev-sans-first:1.30 02:30:53 INFO - 2015-11-19 02:30:53,411 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 82.0 83.0 84.0 85.0 86.0 85.0 83.0 83.0 02:30:53 INFO - 2015-11-19 02:30:53,411 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,411 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:125.00 stddev:4.83 (3.9%) stddev-sans-first:4.64 02:30:53 INFO - 2015-11-19 02:30:53,411 DEBUG : BROWSER_OUTPUT: Values: 118.0 119.0 125.0 118.0 126.0 125.0 131.0 121.0 124.0 131.0 02:30:53 INFO - 2015-11-19 02:30:53,411 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,412 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.30 Median:145.50 stddev:7.78 (5.3%) stddev-sans-first:7.64 02:30:53 INFO - 2015-11-19 02:30:53,412 DEBUG : BROWSER_OUTPUT: Values: 135.0 134.0 152.0 157.0 146.0 137.0 148.0 143.0 145.0 136.0 02:30:53 INFO - 2015-11-19 02:30:53,412 DEBUG : BROWSER_OUTPUT: 02:30:53 INFO - 2015-11-19 02:30:53,412 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:71.00 stddev:3.50 (4.9%) stddev-sans-first:3.68 02:30:53 INFO - 2015-11-19 02:30:53,412 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 70.0 70.0 79.0 74.0 70.0 70.0 78.0 70.0 02:30:53 INFO - 2015-11-19 02:30:53,412 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:30:53 INFO - 2015-11-19 02:30:53,412 DEBUG : BROWSER_OUTPUT: 02:30:54 INFO - 2015-11-19 02:30:54,313 INFO : Browser exited with error code: 0 02:30:54 INFO - 2015-11-19 02:30:54,367 INFO : Completed test kraken (00:01:01) 02:30:54 INFO - 2015-11-19 02:30:54,367 INFO : Starting test v8_7 02:30:54 INFO - 2015-11-19 02:30:54,367 DEBUG : operating with platform_type : linux_ 02:30:54 INFO - 2015-11-19 02:30:54,367 INFO : Initialising browser for v8_7 test... 02:30:54 INFO - 2015-11-19 02:30:54,373 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo3CYov/profile http://localhost:38034/getInfo.html 02:30:58 INFO - 2015-11-19 02:30:58,530 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:30:58 INFO - 2015-11-19 02:30:58,530 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:30:58 INFO - 2015-11-19 02:30:58,530 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:30:58 INFO - 2015-11-19 02:30:58,530 DEBUG : BROWSER_OUTPUT: __metrics 02:30:58 INFO - 2015-11-19 02:30:58,692 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:30:59 INFO - 2015-11-19 02:30:59,893 INFO : Browser initialized. 02:30:59 INFO - 2015-11-19 02:30:59,894 INFO : Running cycle 1/1 for v8_7 test... 02:30:59 INFO - 2015-11-19 02:30:59,894 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo3CYov/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:31:11 INFO - 2015-11-19 02:31:11,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 141455360 02:31:11 INFO - 2015-11-19 02:31:11,854 DEBUG : BROWSER_OUTPUT: 02:31:33 INFO - 2015-11-19 02:31:33,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38034/tests/v8_7/run.html (next: http://localhost:38034/tests/v8_7/run.html) 02:31:33 INFO - 2015-11-19 02:31:33,489 DEBUG : BROWSER_OUTPUT: RSS: Main: 441991168 02:31:33 INFO - 2015-11-19 02:31:33,489 DEBUG : BROWSER_OUTPUT: 02:31:33 INFO - 2015-11-19 02:31:33,489 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:31:33 INFO - 2015-11-19 02:31:33,490 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:31:33 INFO - 2015-11-19 02:31:33,490 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:31:33 INFO - 2015-11-19 02:31:33,490 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:31:33 INFO - 2015-11-19 02:31:33,490 DEBUG : BROWSER_OUTPUT: |0;Richards;162.94606485253382 02:31:33 INFO - 2015-11-19 02:31:33,490 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.4984520123839 02:31:33 INFO - 2015-11-19 02:31:33,490 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.12570781426956 02:31:33 INFO - 2015-11-19 02:31:33,490 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 02:31:33 INFO - 2015-11-19 02:31:33,490 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1994.0239043824702 02:31:33 INFO - 2015-11-19 02:31:33,490 DEBUG : BROWSER_OUTPUT: |5;Earley;792.3930269413629 02:31:33 INFO - 2015-11-19 02:31:33,490 DEBUG : BROWSER_OUTPUT: |6;Boyer;12562.5 02:31:33 INFO - 2015-11-19 02:31:33,490 DEBUG : BROWSER_OUTPUT: |7;RegExp;25871.79487179487 02:31:33 INFO - 2015-11-19 02:31:33,490 DEBUG : BROWSER_OUTPUT: |8;Splay;623.0529595015577 02:31:33 INFO - 2015-11-19 02:31:33,490 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 02:31:33 INFO - 2015-11-19 02:31:33,490 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:31:33 INFO - 2015-11-19 02:31:33,490 DEBUG : BROWSER_OUTPUT: __startTimestamp1447929093486__endTimestamp 02:31:33 INFO - 2015-11-19 02:31:33,490 DEBUG : BROWSER_OUTPUT: 02:31:33 INFO - 2015-11-19 02:31:33,491 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:31:33 INFO - 2015-11-19 02:31:33,491 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:31:33 INFO - 2015-11-19 02:31:33,491 DEBUG : BROWSER_OUTPUT: 02:31:33 INFO - 2015-11-19 02:31:33,491 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.95 Median:162.95 stddev:0.00 (0.0%) 02:31:33 INFO - 2015-11-19 02:31:33,491 DEBUG : BROWSER_OUTPUT: Values: 162.9 02:31:33 INFO - 2015-11-19 02:31:33,491 DEBUG : BROWSER_OUTPUT: 02:31:33 INFO - 2015-11-19 02:31:33,491 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.50 Median:193.50 stddev:0.00 (0.0%) 02:31:33 INFO - 2015-11-19 02:31:33,491 DEBUG : BROWSER_OUTPUT: Values: 193.5 02:31:33 INFO - 2015-11-19 02:31:33,491 DEBUG : BROWSER_OUTPUT: 02:31:33 INFO - 2015-11-19 02:31:33,491 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.13 Median:283.13 stddev:0.00 (0.0%) 02:31:33 INFO - 2015-11-19 02:31:33,491 DEBUG : BROWSER_OUTPUT: Values: 283.1 02:31:33 INFO - 2015-11-19 02:31:33,491 DEBUG : BROWSER_OUTPUT: 02:31:33 INFO - 2015-11-19 02:31:33,491 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 02:31:33 INFO - 2015-11-19 02:31:33,491 DEBUG : BROWSER_OUTPUT: Values: 5045.2 02:31:33 INFO - 2015-11-19 02:31:33,491 DEBUG : BROWSER_OUTPUT: 02:31:33 INFO - 2015-11-19 02:31:33,491 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1994.02 Median:1994.02 stddev:0.00 (0.0%) 02:31:33 INFO - 2015-11-19 02:31:33,492 DEBUG : BROWSER_OUTPUT: Values: 1994.0 02:31:33 INFO - 2015-11-19 02:31:33,492 DEBUG : BROWSER_OUTPUT: 02:31:33 INFO - 2015-11-19 02:31:33,492 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 02:31:33 INFO - 2015-11-19 02:31:33,492 DEBUG : BROWSER_OUTPUT: Values: 792.4 02:31:33 INFO - 2015-11-19 02:31:33,492 DEBUG : BROWSER_OUTPUT: 02:31:33 INFO - 2015-11-19 02:31:33,492 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12562.50 Median:12562.50 stddev:0.00 (0.0%) 02:31:33 INFO - 2015-11-19 02:31:33,492 DEBUG : BROWSER_OUTPUT: Values: 12562.5 02:31:33 INFO - 2015-11-19 02:31:33,492 DEBUG : BROWSER_OUTPUT: 02:31:33 INFO - 2015-11-19 02:31:33,492 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25871.79 Median:25871.79 stddev:0.00 (0.0%) 02:31:33 INFO - 2015-11-19 02:31:33,492 DEBUG : BROWSER_OUTPUT: Values: 25871.8 02:31:33 INFO - 2015-11-19 02:31:33,492 DEBUG : BROWSER_OUTPUT: 02:31:33 INFO - 2015-11-19 02:31:33,493 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:623.05 Median:623.05 stddev:0.00 (0.0%) 02:31:33 INFO - 2015-11-19 02:31:33,493 DEBUG : BROWSER_OUTPUT: Values: 623.1 02:31:33 INFO - 2015-11-19 02:31:33,493 DEBUG : BROWSER_OUTPUT: 02:31:33 INFO - 2015-11-19 02:31:33,493 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 02:31:33 INFO - 2015-11-19 02:31:33,493 DEBUG : BROWSER_OUTPUT: Values: 4840.6 02:31:33 INFO - 2015-11-19 02:31:33,493 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:31:33 INFO - 2015-11-19 02:31:33,493 DEBUG : BROWSER_OUTPUT: 02:31:34 INFO - 2015-11-19 02:31:34,421 INFO : Browser exited with error code: 0 02:31:34 INFO - 2015-11-19 02:31:34,438 INFO : Completed test v8_7 (00:00:40) 02:31:34 INFO - 2015-11-19 02:31:34,542 INFO : Completed test suite (00:20:21) 02:31:34 INFO - 2015-11-19 02:31:34,542 DEBUG : Working with test: dromaeo_css 02:31:34 INFO - 2015-11-19 02:31:34,542 DEBUG : Generating results file: dromaeo_css 02:31:34 INFO - 2015-11-19 02:31:34,543 DEBUG : Working with test: kraken 02:31:34 INFO - 2015-11-19 02:31:34,544 DEBUG : Generating results file: kraken 02:31:34 INFO - 2015-11-19 02:31:34,544 INFO : javascript benchmark 02:31:34 INFO - 2015-11-19 02:31:34,544 DEBUG : Working with test: v8_7 02:31:34 INFO - 2015-11-19 02:31:34,544 DEBUG : Generating results file: v8_7 02:31:34 INFO - 2015-11-19 02:31:34,545 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:31:34 INFO - 2015-11-19 02:31:34,601 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,35]] 02:31:34 INFO - 2015-11-19 02:31:34,601 DEBUG : process_Request line: dromaeo_css 6378.84 graph.html#tests=[[72,131,35]] 02:31:34 INFO - 2015-11-19 02:31:34,601 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:31:34 INFO - 2015-11-19 02:31:34,632 DEBUG : process_Request line: kraken 1519.20 graph.html#tests=[[232,131,35]] 02:31:34 INFO - 2015-11-19 02:31:34,632 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:31:34 INFO - 2015-11-19 02:31:34,663 DEBUG : process_Request line: v8_7 19725.73 graph.html#tests=[[230,131,35]] 02:31:34 INFO - 2015-11-19 02:31:34,664 INFO : javascript benchmark 02:31:34 INFO - 2015-11-19 02:31:34,668 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2631.947361052779, 2726.495598314311, 2729.836209827409, 2743.465024320258, 2763.502569537483, 4555.88610284743, 4634.119517291712, 4707.270373092168, 4792.83225087122, 4834.903301933955, 4733.171694953387, 4793.161196790566, 4801.375821143255, 4803.087413391453, 4921.926171107436, 4424.933625995604, 4426.1811564860445, 4493.7977790999485, 4519.502854685982, 4571.542845715435, 4480.372747815292, 4487.169873573399, 4555.316702494619, 4564.383808185902, 4602.2636378179495, 4297.720648157875, 4366.323219900921, 4398.472183337988, 4441.222786012435, 4490.550944905516, 4432.047109871393, 4434.157510073108, 4438.889027774299, 4439.866803995886, 4471.754053527055, 4393.450818647669, 4395.208862404766, 4408.691391602589, 4443.688941774077, 4459.955400445986, 4537.77311134442, 4628.305754136873, 4634.351190833286, 4638.095571363586, 4667.976660116712, 5161.509656582619, 5173.068847607429, 5185.274061631375, 5187.559057480119, 5201.427842937273, 5218.6868787872845, 5220.565137395106, 5236.1098613235845, 5240.266362709223, 5274.736263186825, 4635.69867958585, 4695.178343789823, 4726.243800991825, 4734.289856521549, 4827.155247831651, 5324.893502129936, 5334.306540149833, 5336.306280183629, 5336.946630533723, 5379.031774280589, 5097.796088156507, 5098.668586541863, 5104.872378190501, 5105.7191854448365, 5126.974365128151, 4965.602751779849, 5009.499050094962, 5065.39215294167, 5072.442031376546, 5155.32980712505, 5176.948230517647, 5189.065968125774, 5189.662671926313, 5196.636235463481, 5213.895722085613, 5134.922976155361, 5162.0, 5174.456682048406, 5183.870403239874, 5217.321748172713, 4125.339945608688, 4211.431456753299, 4214.05183833635, 4304.325634176917, 4356.411884395629, 3689.6310368963427, 3740.4389341598976, 3752.6247375262255, 3777.2823163598828, 3791.374423220138, 4440.0, 4452.1763473757455, 4460.799264033127, 4462.709923854939, 4495.662825288116, 5060.696358218445, 5180.948190518046, 5188.0, 5204.193350030751, 5210.062188806051, 4374.671899607542, 4407.0, 4420.911581768347, 4446.155230506193, 4458.643308535309, 4537.274036154199, 4542.114287713864, 4546.727196368229, 4574.4968053514085, 4600.263957766808, 4754.595859351994, 4865.416150062015, 4949.034938187091, 4959.82640607577, 4972.477889821661, 5055.368078990126, 5117.053345131163, 5129.74351282427, 5136.434992150935, 5152.433232344364, 4914.926276105933, 4963.478834722447, 4964.156093464047, 4974.278729584263, 5004.349434573628, 4847.854564363075, 4942.67872588295, 5148.9227661584355, 5160.948390516047, 5171.870703232299, 4986.80052797884, 5099.592032637306, 5106.055379754757, 5106.795728170831, 5116.386033675983, 5053.949460505348, 5082.745862706776, 5085.211792172219, 5086.313347698014, 5131.281620573048, 4764.737939413366, 4875.43932447773, 5036.748162591783, 5069.721165335942, 5087.338645976148, 4830.492798256273, 4868.196747536616, 4926.261060840902, 4929.482404347492, 4951.133551628379, 5079.136546786981, 5151.6908985461, 5154.974225129, 5158.226266060121, 5179.223116532399, 4741.099191153669, 4850.175470170009, 5030.0945829751, 5046.142155833591, 5048.924266136084], "unit": "ms", "name": "dojo.html", "value": 4722.75276296531}, {"lowerIsBetter": false, "replicates": [541.7372574301461, 565.0507147991374, 569.3338793611472, 569.5216018544422, 573.125982876114, 28110.578341324872, 28630.141095767136, 28682.569761453567, 37505.812470937606, 38051.80974095133, 40536.0, 41049.58950410495, 41106.17787644245, 41109.0, 41210.79394603023, 7931.325837303822, 8101.5544145072, 8108.837823243532, 8112.269895709385, 8124.553149576771, 7184.0, 7393.852122957537, 9988.300818942676, 10238.283320167591, 10255.897441025607, 10131.848022279672, 10170.9491452543, 10242.641507547238, 10255.846162307571, 10263.640772572962, 7190.424766018706, 7392.741254056083, 10015.298929074968, 10157.18742500602, 10167.135793457564, 7096.787096387116, 7209.06282183318, 10134.695959121238, 10431.426271555061, 10453.79092418155, 37976.050598734975, 38471.807640961895, 38525.03687407809, 38528.22943541114, 38570.80714596437, 2750.8074434789573, 2773.6389684813753, 2826.462972035307, 2857.157138644084, 3276.4280040168355, 28510.572341414896, 28775.712242877722, 28812.711872881213, 28855.41868236011, 28960.13119606415, 3401.812900290508, 3445.173158441981, 3449.3618680544178, 3519.278547897675, 3559.839807208682, 226367.0, 228821.85589071948, 229695.0, 229788.0, 229964.0, 50085.49914500881, 56499.717501413055, 56848.0, 56868.43131568631, 56892.0, 46987.765061174476, 65887.0, 67216.0, 67401.32598673951, 67448.0, 12003.579874704517, 12136.87863121375, 12161.209521381083, 12168.452419641137, 12187.634370968884, 10065.144462720604, 10192.439415832052, 10209.030142136486, 10221.131203847608, 10223.233257505717, 19492.902535487232, 19619.90190049069, 19631.21475141007, 19665.705014424795, 19765.60468790645, 7314.48798584094, 7527.397808175333, 7587.355074818592, 7593.164751877289, 7701.576413297211, 876.6493402638868, 904.8145130248283, 912.3339961827903, 979.2802290316612, 980.9019098090276, 26329.341766455993, 26335.73664263333, 26382.20853374402, 26680.733192668213, 26739.732602674114, 966.1980556138388, 972.3388096094582, 981.3277904635347, 1045.4720366215013, 1134.28540019787, 12994.415251313714, 13002.804957925639, 13072.79716469471, 13141.737165256642, 13174.143680660727, 266947.0, 272956.0, 272968.0, 273186.0, 273470.0, 46159.76920115378, 46427.0, 46440.3033954491, 46613.766931165126, 46634.0, 1021.22897212604, 1104.7348636327383, 1132.4337831084458, 1171.5313874450117, 1209.7217639942862, 24185.51628967446, 24706.0, 25412.491750165264, 25500.23499295024, 25500.617490738026, 36770.632293677794, 38067.0, 38080.61919380771, 38154.61845381511, 38172.23655526818, 235082.0, 239171.0, 342744.0, 350691.0, 351541.0, 27116.864415677795, 27147.457050859266, 27172.45655086927, 27255.454890901674, 27268.0, 38536.0, 38661.42007869828, 39428.60571394364, 39608.801955990035, 40139.79930100331, 33032.66967330296, 33613.66386336203, 34089.82955085209, 34399.828000860834, 34533.65466345405, 36484.45273320849, 38118.428223577226, 38301.42547861728, 39234.0, 40279.798601006805, 35399.82300088483, 36677.0, 37033.81483092567, 37280.813595931846, 37346.813265933495, 34833.12917177091, 35713.46429803503, 36875.44686829646, 36914.63085369112, 37013.629863702095, 28269.293267668472, 29211.415771684024, 29367.26581835386, 30207.546886796277, 32510.0], "unit": "ms", "name": "ext.html", "value": 17493.052546660525}, {"lowerIsBetter": false, "replicates": [341.09269343546174, 341.55427167546355, 341.7266187050359, 344.63985135533363, 344.86205517792894, 12526.373681315943, 12930.870691293085, 15120.395184192634, 15161.545153645395, 15964.441244556443, 14950.476733314335, 15179.013364131324, 15919.44281950132, 15926.920365398186, 15981.680366392695, 4513.232750432418, 4520.638348932078, 4521.344405061264, 4609.9308510372375, 4896.706197628145, 3566.4472006838982, 3662.7985460799646, 3664.8350824212976, 3667.853285868562, 5010.949890501103, 3653.7442379033478, 5509.531689806371, 5688.658680479164, 5690.715464226792, 5694.032014557514, 5509.807156749514, 5632.267805185341, 5639.943600563983, 5647.463490968352, 5647.887042259132, 5014.674046186986, 5061.316722242487, 5061.974690126526, 5065.670731402484, 5067.189249720027, 19029.524261893424, 19269.325573604998, 19593.0, 19599.706004409945, 19896.40310790664, 1774.1306759687789, 1844.5204246895769, 1902.372217168345, 1938.5735138269558, 1973.6644770389069, 13433.194008359433, 13463.0, 13491.257980811051, 13662.590122296348, 13917.23455209963, 1833.60577475842, 1847.7782666080157, 1894.7631546056743, 1894.7915729269769, 1951.4535929939639, 58339.12491312634, 59308.99999999957, 62730.0, 65165.348346516876, 66364.33635663678, 15419.61450963735, 15441.768373474408, 15451.459198927983, 15496.845031549765, 15545.145017023946, 22669.659955100356, 22726.0, 22937.655935160987, 22941.7705822943, 23096.307110786704, 7959.363250940027, 7971.242731940456, 7995.640196191185, 8023.716205407107, 8080.39397045224, 6536.738530458823, 6565.343465653492, 6604.405603495612, 6702.966485167543, 6721.428678562279, 7425.740099096613, 7443.702251909971, 7508.361789247866, 7515.173330933593, 7561.584112873845, 1709.4187976087942, 1738.0788182263168, 2125.873287157809, 2934.985325073361, 2936.7797415193945, 367.3351234265987, 367.65991457901333, 820.0774129104757, 958.8226178157063, 969.7236287657984, 8532.36007299455, 9747.268954828416, 10132.290739648153, 10206.387616743019, 10219.897801022043, 379.5824592947791, 381.4050081872288, 383.05194643257715, 389.98440062397754, 391.6142599539451, 5249.790008399697, 5286.735663216824, 5318.760655770499, 5379.650322729089, 5405.0, 476046.0, 476456.0, 485539.0, 489827.0, 492408.18436698784, 61705.691471542355, 63434.68282658557, 63617.681911590145, 70735.0, 71774.0, 980.6420656460341, 1001.3591301567003, 1002.774375765447, 1004.0060340263087, 1020.5917632946732, 13806.309684515532, 14542.636434089232, 14776.408943642135, 14779.556613301618, 15043.623909402353, 28985.56521652219, 30090.24774380658, 30110.645020974545, 30635.693643064176, 32738.836305818317, 39872.0, 39885.0, 41096.0, 41864.58135418607, 41943.0, 8512.872306915526, 8790.824183516166, 8894.911050889408, 8915.821683566423, 9091.727248182566, 12577.182483138567, 16273.349066037226, 16523.173841308126, 16801.579960501087, 17271.05009224505, 11086.667399978014, 12989.4154763034, 13707.931460342634, 13719.588412347646, 13893.861061389256, 13124.540641077516, 13179.275139867399, 13497.86502134966, 13638.318084095557, 13803.2408217549, 13568.728625427239, 13757.862421375658, 13882.375293111632, 14023.859761402255, 14117.929410352883, 8139.593020349077, 8785.121487851164, 8823.647054117764, 8911.955440222757, 8929.419587727038, 9525.237980961369, 9623.951880240555, 9624.951875240578, 13668.65828354299, 14509.637259068608], "unit": "ms", "name": "jquery.html", "value": 8274.384549832454}, {"lowerIsBetter": false, "replicates": [1424.0814674534918, 1657.4447560067376, 1720.8107108218098, 1720.83652053055, 1741.277369891495, 6128.11142384354, 6833.248342682307, 7114.288571142896, 7125.073740413745, 7135.143782746078, 7060.611666358348, 7196.712131514733, 7200.891986620191, 7204.5677259364475, 7220.675069621867, 1779.7508348831175, 1819.927202911882, 1820.3082828525141, 2094.5601423701005, 2116.968245476319, 1711.7517959895808, 2097.590969760897, 2177.7931096545803, 2182.508935489518, 2183.2686050173133, 2088.9164433422643, 2095.4447071526056, 2099.590579836932, 2118.375079351595, 2130.7017017617545, 1577.5582836805656, 1611.8226995030536, 2047.672372420413, 2060.5981833542464, 2079.9688004679942, 2122.479992401856, 2131.893405329743, 2132.69075983983, 2134.551744133734, 2134.6157691615504, 7150.570965742072, 7330.560166389981, 7338.706451741924, 7341.375983041448, 7348.5958272295, 4244.766537840448, 4360.433143691332, 4372.344148377737, 4372.475302963665, 4372.5627437256335, 2749.0653177919603, 2831.108200916705, 2842.6873043965147, 2851.3869518053716, 2871.124307086338, 852.6035393542032, 855.850226210417, 866.1208872993916, 869.1569177897429, 880.5113162194979, 9722.465264410455, 9739.026097390275, 9752.609895604168, 9753.170980466668, 9755.756106097333, 3965.0483883867664, 4021.7989100544855, 4040.373742069984, 4052.392141178788, 4052.4731784867777, 8395.83208335842, 8411.621477033548, 8416.915830841614, 8423.578821058922, 8429.620667069996, 4418.690691651618, 4449.577290157495, 4452.065066336041, 4452.710573812757, 4459.331100334911, 4053.533843608023, 4054.0, 4062.086030643082, 4062.1469491407133, 4068.898277543085, 3498.8950331490096, 3547.0600290922926, 3565.0730809989072, 3573.857045718194, 3605.351036813399, 1119.8376235445814, 1120.966371008871, 1125.7073160978205, 1136.1308598921833, 1142.5943789954613, 947.5925352098664, 955.1737746848926, 960.6157536985122, 1024.359775140537, 1189.1854079955258, 6574.276829548746, 6580.934190658128, 6660.866782664417, 6674.0, 6702.0, 420.6865884915757, 421.1871088798648, 421.90507135894177, 422.98519551816156, 423.61239465888985, 5012.548870601663, 5096.490350964948, 5096.719680417613, 5401.702906340189, 5571.025070612708, 8568.614412351459, 8767.956160219159, 8790.384673072824, 8832.779180520538, 8871.379003469696, 8383.790405239917, 8678.045415004344, 8707.434016788888, 8715.0, 8721.433106848035, 6793.116894803644, 6799.082123913307, 6861.622610756456, 6862.210845752703, 6877.518573699893, 6763.93236067633, 6862.965685171542, 6868.519203655696, 6872.10662613857, 6876.415504681958, 7737.148913619385, 7859.0, 7904.367650588054, 7916.722914697958, 7940.6426710796995, 7965.163657815846, 8017.759467215993, 8120.472169308976, 8201.79495512617, 8274.089850116363, 6316.11574379578, 6424.164858568356, 6431.48548116159, 6439.162908821823, 6449.419552240321, 6893.75871844483, 6922.5154239202775, 6942.201646810681, 6951.409130223988, 6957.860842783015, 6612.272650008399, 6647.268800431852, 6651.534392592472, 6707.0945422369305, 6816.829579260359, 6564.8358791030605, 6584.901226481511, 6619.27188009309, 6713.765018224339, 6727.091842601186, 6681.231658359156, 6721.596704197764, 6732.629705366252, 6739.932600674127, 6742.157230346207, 6080.69596520181, 6083.756649733961, 6114.541409394402, 6115.510759139347, 6145.661988590492, 6134.171886795226, 6226.85173615102, 6247.0629405589525, 6253.218347706536, 6269.216347956505], "unit": "ms", "name": "mootools.html", "value": 4068.514446338966}, {"lowerIsBetter": false, "replicates": [290.69767441860455, 295.0528802543834, 303.0650443382166, 303.0952606469686, 303.46741468722394, 5479.753411096495, 5484.698341591211, 5554.416786237448, 5611.382747897728, 5652.745626446809, 5424.972875135629, 5499.257600223968, 5521.116621340586, 5521.337439507255, 5531.9723401382935, 4066.2883995300854, 4254.595813397722, 4261.254280500915, 4262.254105531535, 4267.061246525759, 4070.1656160487178, 4159.438475805758, 4205.621494065534, 4206.894827629319, 4212.473440819897, 4141.6065473779945, 4147.191297696951, 4162.500499940012, 4171.228322760284, 4174.0, 3976.423418604315, 4065.8983525411804, 4078.3270760324513, 4146.564610715876, 4162.0635357044575, 3650.945235821465, 3662.432322989941, 3664.1022949377307, 3665.541807274091, 3678.0437086357474, 5278.762455689503, 5286.259923610698, 5298.231756395301, 5300.0459917214885, 5300.655457395295, 4838.854834354975, 4845.176320025604, 4853.150698627726, 4854.053459575384, 4857.465678775332, 5652.378238393773, 5796.217510636052, 5798.82603521895, 5802.506786923117, 5808.012637851575, 3864.0726225705907, 3903.711775114234, 3905.1799122184375, 3906.980465097685, 3910.4916360872903, 6029.879402411927, 6127.11156882254, 6129.601575897597, 6136.447719705248, 6142.416470435346, 4096.959030409657, 4100.6924480664065, 4102.056526998807, 4102.200070986189, 4102.466679331727, 3964.2467931093, 4124.422580838685, 4159.0, 4163.0, 4164.1879833432795, 4768.856934291976, 4773.546513081252, 4774.7135171889795, 4775.856724298276, 4776.402949631296, 5798.10129429939, 5816.82549523515, 5819.214406055213, 5821.126830975303, 5822.592418530662, 1418.858114188573, 1444.7832825076323, 1445.91324520527, 1446.0383844743128, 1447.2691290898028, 936.1527817325332, 943.3679434778714, 945.8817647794026, 965.7440778193784, 969.2778879734502, 5071.771770270347, 5079.31429257053, 5082.136036873666, 5089.541941225308, 5093.8726531836255, 6048.818535443944, 6052.66710330936, 6055.182550355734, 6058.666773327509, 6060.454559089615, 5056.57019153376, 5069.721165335868, 5084.466131056186, 5086.745662716849, 5088.542031217208, 3199.616046074486, 3240.4977228529615, 3270.0516850113677, 3276.311974485337, 3283.1792051987004, 5706.771729130871, 5708.914366284509, 5715.885682286331, 5716.542676585863, 5717.428257174332, 6137.7851775187655, 6204.069389591597, 6213.254409470893, 6218.533609979269, 6222.875542489125, 5547.528460080938, 5700.287464067074, 5701.942980570141, 5702.0, 5708.172315014383, 6033.0, 6033.456988871023, 6045.304789949037, 6050.364711705208, 6050.788222412194, 5884.176215329943, 5892.7642894283745, 5894.705264736832, 5901.262342207224, 5901.675407852609, 5702.258706368146, 5706.3152421709665, 5708.172315014383, 5709.51469125129, 5709.8287051388525, 3933.5673075962195, 4009.3785463253244, 4013.5384430789663, 4026.1746341999233, 4049.6962727794944, 6057.363976782374, 6058.939410605837, 6062.120992455981, 6066.757329706938, 6068.089786531879, 5835.299764028344, 5840.8247752567495, 5841.824745257649, 5843.912341314969, 5846.093855452412, 5737.8565535861935, 5775.133729940542, 5819.94180058194, 5846.824595262149, 5858.150568167677, 5694.259746232963, 5697.6296540724725, 5706.572007099401, 5706.714664266687, 5708.65748055118, 5661.66030038199, 5833.270841144857, 5867.794627188028, 5873.471387575139, 5884.205632239593, 5581.804636837691, 5766.365699772938, 5769.711514424346, 5793.188953546591, 5793.594448388572], "unit": "ms", "name": "prototype.html", "value": 4318.453270792044}, {"lowerIsBetter": false, "replicates": [622.4553515673788, 633.9017452294894, 694.3126304958093, 731.9780406587801, 752.0486584470642, 11187.105031597473, 11472.196946213768, 11497.367644779533, 11510.654680359592, 13785.310734463286, 12828.871711282907, 12866.678333041678, 12877.67805804853, 12939.482420703183, 12947.287899165542, 612.5008118383503, 621.8631900981777, 779.867422538167, 787.810925377908, 799.256691277112, 801.4429971170039, 802.4663598706853, 808.9474184178039, 809.2029351089172, 809.3444310108802, 642.7332656947361, 781.0783275734659, 828.7430896422098, 844.4046946902419, 845.995770021149, 652.2759736692268, 819.0539926385005, 834.470111479212, 834.8831163637095, 835.3776436554745, 612.1796792298297, 613.2610204703321, 616.7779599344233, 617.1329282358294, 617.4042049422329, 12214.0, 12328.383580820922, 12347.444365003596, 12349.69125771854, 12361.752764944651, 10982.560697572088, 11707.53169873204, 11993.520259189709, 12148.9673377763, 12574.43415046325, 8993.460392376479, 9314.208292295163, 9451.33840631156, 9813.90186098137, 9824.673669054657, 3247.805131692106, 3304.322613864152, 3317.08780085476, 3318.867245310185, 3321.9169520761934, 42081.0, 42103.0, 42476.57523424788, 42741.35887961683, 43265.99999999969, 9314.208292295096, 9397.76505587352, 9561.808763824685, 9567.37812042215, 9578.0, 17386.565335866704, 17408.912955435142, 17414.82585174132, 17420.825791742172, 17443.30226790914, 6352.205974253218, 6432.903506447407, 6435.131257280207, 6453.1610890583925, 6679.332066793282, 3292.6378098409155, 3393.9490907636405, 3394.473856552189, 3507.1920197527115, 3522.947155792665, 2718.198131551197, 2747.835129892213, 2751.284665986858, 2770.2104900103777, 2785.7492825645386, 491.78607305822084, 503.66757939759583, 509.3404041765922, 518.3753576939779, 519.2444992535851, 508.5372311196793, 544.1918750655274, 565.5023579250316, 569.2087997683224, 572.8567858035491, 7747.573883436352, 7924.643391047417, 7962.657606719258, 7967.482113662593, 7987.1613480584865, 454.69308216953425, 528.4398537550132, 547.9452054794505, 552.1248820619284, 555.9610827242054, 3700.9444858327147, 3707.4728125311676, 3741.6819570336825, 3764.5294338207723, 3793.393057110904, 51010.23484647733, 51115.233271500954, 51268.7182820425, 51714.224286635734, 51997.7400112997, 45329.32006019913, 46625.5337446628, 47147.764261178476, 47273.0, 47300.0, 41523.377149342785, 41599.0, 41641.37537936933, 42538.0, 42767.35848962268, 7016.438684905093, 7073.257307982588, 7091.82270443243, 7129.35835774762, 7222.674979625825, 32260.19349516281, 32633.836830815693, 32678.0, 32686.0, 33345.166370840925, 36503.45244821277, 37272.44091338686, 41192.176156477304, 41339.586604134776, 42016.0, 9091.954540227256, 9221.49281789508, 9279.164875161268, 9401.247900168108, 9566.808663826823, 9388.108129727665, 9524.190443812353, 9525.0, 9549.09283618055, 9821.165200957712, 8683.435576687496, 8796.296296296408, 8948.552572371225, 8957.910420895707, 8990.415622984485, 9506.0, 9514.619415223313, 9519.095685909828, 9619.422834629944, 9800.460974646463, 9005.63977440895, 9132.08679132108, 9140.22308103792, 9143.588538515916, 9153.405028673114, 8181.79545511367, 8259.42184047111, 8283.523876244062, 8324.125966773401, 8392.790180245298, 7798.727044553413, 8292.543910085004, 8439.70461033861, 8446.915530844613, 8469.491830490191], "unit": "ms", "name": "yui.html", "value": 5608.476643801281}], "name": "dromaeo_css", "value": 6378.841873822857}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 107.0, 110.0, 112.0, 112.0, 100.0, 111.0, 102.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [151.0, 133.0, 159.0, 169.0, 139.0, 157.0, 159.0, 132.0, 169.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 160.0, 162.0, 160.0, 160.0, 161.0, 164.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 83.0, 104.0, 72.0, 72.0, 72.0, 112.0, 91.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 128.0, 92.0, 91.0, 91.0, 134.0, 91.0, 91.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 102.8}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 69.0, 70.0, 69.0, 76.0, 77.0, 67.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 70.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 70.0, 69.0, 69.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 82.0, 83.0, 84.0, 85.0, 86.0, 85.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [118.0, 119.0, 125.0, 118.0, 126.0, 125.0, 131.0, 121.0, 124.0, 131.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.8}, {"lowerIsBetter": true, "replicates": [135.0, 134.0, 152.0, 157.0, 146.0, 137.0, 148.0, 143.0, 145.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.3}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 70.0, 79.0, 74.0, 70.0, 70.0, 78.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 72.3}], "name": "kraken", "value": 1519.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.94606485253382], "unit": "score", "name": "Richards", "value": 216.64837400000005}, {"lowerIsBetter": false, "replicates": [193.4984520123839], "unit": "score", "name": "DeltaBlue", "value": 341.6978240000001}, {"lowerIsBetter": false, "replicates": [283.12570781426956], "unit": "score", "name": "Encrypt", "value": 940.1512919999999}, {"lowerIsBetter": false, "replicates": [5045.226130653266], "unit": "score", "name": "Decrypt", "value": 52.75898306772911}, {"lowerIsBetter": false, "replicates": [1994.0239043824702], "unit": "score", "name": "RayTrace", "value": 371.1033746253746}, {"lowerIsBetter": false, "replicates": [792.3930269413629], "unit": "score", "name": "Earley", "value": 841.0763060000003}, {"lowerIsBetter": false, "replicates": [12562.5], "unit": "score", "name": "Boyer", "value": 53.05178109452737}, {"lowerIsBetter": false, "replicates": [25871.79487179487], "unit": "score", "name": "RegExp", "value": 35.21151139742318}, {"lowerIsBetter": false, "replicates": [623.0529595015577], "unit": "score", "name": "Splay", "value": 130.793055}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19725.732060584156}]} 02:31:34 INFO - RETURN: dromaeo_css: 6378.84 02:31:34 INFO - RETURN: kraken: 1519.20 02:31:34 INFO - RETURN: v8_7: 19725.73 02:31:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,35]]", "result": "19725.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,35]]", "result": "1519.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,35]]", "result": "6378.84"}}} 02:31:34 INFO - Return code: 0 02:31:34 INFO - # TBPL SUCCESS # 02:31:34 INFO - Running post-action listener: _resource_record_post_action 02:31:34 INFO - Running post-run listener: _resource_record_post_run 02:31:35 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 10756096; Write bytes: 394117120; Read time: 4712; Write time: 365128 02:31:35 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 229376; Read time: 0; Write time: 36 02:31:35 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 8249344; Write bytes: 393887744; Read time: 2616; Write time: 365092 02:31:35 INFO - Running post-run listener: _upload_blobber_files 02:31:35 INFO - Blob upload gear active. 02:31:35 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:31:35 INFO - Copying logs to upload dir... 02:31:35 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1288.094456 ========= master_lag: 0.97 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2015-11-19 02:31:36.714668) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 02:31:36.722156) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009920 build_url: 'https://queue.taskcluster.net/v1/task/oYRXIC5lTfWsSBmvEKaq-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 02:31:36.748037) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 02:31:36.748370) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1447924458.548195-305405082 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004613 ========= master_lag: 0.33 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 02:31:37.087842) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 02:31:37.088150) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 02:31:37.088438) ========= ========= Total master_lag: 1.40 =========