builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1448309762.41 results: success (0) buildid: 20151121014332 builduid: 366d0f62097c4c84bad0a3f63b5705d4 revision: 489332006384610e3322739f66729448da0e98d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.414953) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.415413) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.415726) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006514 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.441617) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.442775) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.458581) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.458948) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004809 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.509683) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.510203) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.510799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.511144) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 12:16:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 78.2M=0s 2015-11-23 12:16:03 (78.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167266 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.692874) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.693244) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018076 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.743434) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 12:16:02.743821) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 489332006384610e3322739f66729448da0e98d9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 489332006384610e3322739f66729448da0e98d9 --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=b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 12:16:03,222 truncating revision to first 12 chars 2015-11-23 12:16:03,222 Setting DEBUG logging. 2015-11-23 12:16:03,222 attempt 1/10 2015-11-23 12:16:03,222 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/489332006384?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 12:16:04,352 unpacking tar archive at: fx-team-489332006384/testing/mozharness/ program finished with exit code 0 elapsedTime=1.462292 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 12:16:04.219235) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:04.219541) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:04.229961) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:04.230370) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:04.230811) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-23 12:16:04.231174) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:16:04 INFO - MultiFileLogger online at 20151123 12:16:04 in /builds/slave/test 12:16:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:16:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:16:04 INFO - {'append_to_log': False, 12:16:04 INFO - 'base_work_dir': '/builds/slave/test', 12:16:04 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:16:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:16:04 INFO - 'branch': 'Fx-Team-Non-PGO', 12:16:04 INFO - 'buildbot_json_path': 'buildprops.json', 12:16:04 INFO - 'config_files': ('talos/linux_config.py',), 12:16:04 INFO - 'default_actions': ('clobber', 12:16:04 INFO - 'read-buildbot-config', 12:16:04 INFO - 'download-and-extract', 12:16:04 INFO - 'populate-webroot', 12:16:04 INFO - 'create-virtualenv', 12:16:04 INFO - 'install', 12:16:04 INFO - 'run-tests'), 12:16:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:16:04 INFO - 'download_minidump_stackwalk': True, 12:16:04 INFO - 'download_symbols': 'ondemand', 12:16:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:16:04 INFO - 'tooltool.py': '/tools/tooltool.py', 12:16:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:16:04 INFO - '/tools/misc-python/virtualenv.py')}, 12:16:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:16:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:16:04 INFO - 'installer_path': 'installer.exe', 12:16:04 INFO - 'log_level': 'info', 12:16:04 INFO - 'log_name': 'talos', 12:16:04 INFO - 'log_to_console': True, 12:16:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:16:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:16:04 INFO - 'opt_config_files': (), 12:16:04 INFO - 'pip_index': False, 12:16:04 INFO - 'sps_profile': False, 12:16:04 INFO - 'sps_profile_interval': 0, 12:16:04 INFO - 'suite': 'dromaeojs', 12:16:04 INFO - 'system_bits': '64', 12:16:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:16:04 INFO - 'title': 'talos-linux64-ix-001', 12:16:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:16:04 INFO - 'use_talos_json': True, 12:16:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:16:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:16:04 INFO - 'work_dir': 'build'} 12:16:04 INFO - ##### 12:16:04 INFO - ##### Running clobber step. 12:16:04 INFO - ##### 12:16:04 INFO - Running pre-action listener: _resource_record_pre_action 12:16:04 INFO - Running main action method: clobber 12:16:04 INFO - rmtree: /builds/slave/test/build 12:16:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:16:05 INFO - Running post-action listener: _resource_record_post_action 12:16:05 INFO - ##### 12:16:05 INFO - ##### Running read-buildbot-config step. 12:16:05 INFO - ##### 12:16:05 INFO - Running pre-action listener: _resource_record_pre_action 12:16:05 INFO - Running main action method: read_buildbot_config 12:16:05 INFO - Using buildbot properties: 12:16:05 INFO - { 12:16:05 INFO - "properties": { 12:16:05 INFO - "buildnumber": 2107, 12:16:05 INFO - "product": "firefox", 12:16:05 INFO - "script_repo_revision": "production", 12:16:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:16:05 INFO - "repository": "", 12:16:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:16:05 INFO - "buildid": "20151121014332", 12:16:05 INFO - "slavename": "talos-linux64-ix-001", 12:16:05 INFO - "pgo_build": "False", 12:16:05 INFO - "basedir": "/builds/slave/test", 12:16:05 INFO - "project": "", 12:16:05 INFO - "platform": "ubuntu64_hw", 12:16:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:16:05 INFO - "slavebuilddir": "test", 12:16:05 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:16:05 INFO - "branch": "fx-team", 12:16:05 INFO - "repo_path": "integration/fx-team", 12:16:05 INFO - "stage_platform": "linux64", 12:16:05 INFO - "builduid": "366d0f62097c4c84bad0a3f63b5705d4", 12:16:05 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 12:16:05 INFO - }, 12:16:05 INFO - "sourcestamp": { 12:16:05 INFO - "repository": "", 12:16:05 INFO - "hasPatch": false, 12:16:05 INFO - "project": "", 12:16:05 INFO - "branch": "fx-team-linux64-talos", 12:16:05 INFO - "changes": [ 12:16:05 INFO - { 12:16:05 INFO - "category": null, 12:16:05 INFO - "files": [ 12:16:05 INFO - { 12:16:05 INFO - "url": null, 12:16:05 INFO - "name": "https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:16:05 INFO - } 12:16:05 INFO - ], 12:16:05 INFO - "repository": "", 12:16:05 INFO - "rev": "489332006384610e3322739f66729448da0e98d9", 12:16:05 INFO - "who": "dgottwald@mozilla.com", 12:16:05 INFO - "when": 1448100613, 12:16:05 INFO - "number": 6692170, 12:16:05 INFO - "comments": "Bug 644529 - Remove gap between bookmarks toolbar menu buttons and their popups. r=gijs", 12:16:05 INFO - "project": "", 12:16:05 INFO - "at": "Sat 21 Nov 2015 02:10:13", 12:16:05 INFO - "branch": "fx-team-linux64-talos", 12:16:05 INFO - "revlink": "", 12:16:05 INFO - "properties": [ 12:16:05 INFO - [ 12:16:05 INFO - "buildid", 12:16:05 INFO - "20151121014332", 12:16:05 INFO - "Change" 12:16:05 INFO - ], 12:16:05 INFO - [ 12:16:05 INFO - "builduid", 12:16:05 INFO - "366d0f62097c4c84bad0a3f63b5705d4", 12:16:05 INFO - "Change" 12:16:05 INFO - ], 12:16:05 INFO - [ 12:16:05 INFO - "pgo_build", 12:16:05 INFO - "False", 12:16:05 INFO - "Change" 12:16:05 INFO - ] 12:16:05 INFO - ], 12:16:05 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 12:16:05 INFO - } 12:16:05 INFO - ], 12:16:05 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 12:16:05 INFO - } 12:16:05 INFO - } 12:16:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:16:05 INFO - Running post-action listener: _resource_record_post_action 12:16:05 INFO - ##### 12:16:05 INFO - ##### Running download-and-extract step. 12:16:05 INFO - ##### 12:16:05 INFO - Running pre-action listener: _resource_record_pre_action 12:16:05 INFO - Running main action method: download_and_extract 12:16:05 INFO - mkdir: /builds/slave/test/build/tests 12:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:05 INFO - https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:16:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json 12:16:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json 12:16:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:16:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:16:06 INFO - Downloaded 1302 bytes. 12:16:06 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:16:06 INFO - Using the following test package requirements: 12:16:06 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:06 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:16:06 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:06 INFO - u'jsshell-linux-x86_64.zip'], 12:16:06 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:16:06 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:06 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:16:06 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:16:06 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:16:06 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:06 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:16:06 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:06 INFO - https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:16:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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 12:16:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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 12:16:07 INFO - Downloaded 21339409 bytes. 12:16:07 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 12:16:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:07 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 12:16:08 INFO - Return code: 0 12:16:08 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 12:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:08 INFO - https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:16:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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 12:16:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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 12:16:10 INFO - Downloaded 21339409 bytes. 12:16:10 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 12:16:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:10 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 12:16:11 INFO - Return code: 0 12:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:11 INFO - https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:16:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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 12:16:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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 12:16:12 INFO - Downloaded 11130997 bytes. 12:16:12 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 12:16:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:12 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 12:16:12 INFO - Return code: 0 12:16: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')]} 12:16:12 INFO - https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:16:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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 12:16:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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 12:16:15 INFO - Downloaded 55909927 bytes. 12:16:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:15 INFO - mkdir: /builds/slave/test/properties 12:16:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:16:15 INFO - Writing to file /builds/slave/test/properties/build_url 12:16:15 INFO - Contents: 12:16:15 INFO - build_url:https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:15 INFO - Running post-action listener: _resource_record_post_action 12:16:15 INFO - Running post-action listener: set_extra_try_arguments 12:16:15 INFO - ##### 12:16:15 INFO - ##### Running populate-webroot step. 12:16:15 INFO - ##### 12:16:15 INFO - Running pre-action listener: _resource_record_pre_action 12:16:15 INFO - Running main action method: populate_webroot 12:16:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:16:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:16:15 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:16:15 INFO - '../fennec_ids.txt'], 12:16:15 INFO - 'tests': ['tcheck2']}, 12:16:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:16:15 INFO - '--tppagecycles', 12:16:15 INFO - '7'], 12:16:15 INFO - 'tests': ['tsvgm']}}, 12:16:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:16:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:16:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:16:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:16:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:16:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:16:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:15 INFO - 'talos_options': ['--e10s'], 12:16:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:15 INFO - 'tests': ['damp', 'tps']}, 12:16:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:15 INFO - 'talos_options': ['--e10s'], 12:16:15 INFO - 'tests': ['damp', 'tps']}, 12:16:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:16:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:16:15 INFO - 'other': {'tests': ['a11yr', 12:16:15 INFO - 'ts_paint', 12:16:15 INFO - 'tpaint', 12:16:15 INFO - 'sessionrestore', 12:16:15 INFO - 'sessionrestore_no_auto_restore']}, 12:16:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:16:15 INFO - 'tests': ['a11yr', 12:16:15 INFO - 'ts_paint', 12:16:15 INFO - 'tpaint', 12:16:15 INFO - 'sessionrestore', 12:16:15 INFO - 'sessionrestore_no_auto_restore']}, 12:16:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:16:15 INFO - 'tests': ['a11yr', 12:16:15 INFO - 'ts_paint', 12:16:15 INFO - 'tpaint', 12:16:15 INFO - 'sessionrestore', 12:16:15 INFO - 'sessionrestore_no_auto_restore']}, 12:16:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:16:15 INFO - 'tests': ['a11yr', 12:16:15 INFO - 'ts_paint', 12:16:15 INFO - 'tpaint', 12:16:15 INFO - 'sessionrestore', 12:16:15 INFO - 'sessionrestore_no_auto_restore']}, 12:16:15 INFO - 'other_l64': {'tests': ['a11yr', 12:16:15 INFO - 'ts_paint', 12:16:15 INFO - 'tpaint', 12:16:15 INFO - 'sessionrestore', 12:16:15 INFO - 'sessionrestore_no_auto_restore']}, 12:16:15 INFO - 'other_nol64': {'tests': ['a11yr', 12:16:15 INFO - 'ts_paint', 12:16:15 INFO - 'tpaint', 12:16:15 INFO - 'sessionrestore', 12:16:15 INFO - 'sessionrestore_no_auto_restore']}, 12:16:15 INFO - 'svgr': {'tests': ['tsvgx', 12:16:15 INFO - 'tsvgr_opacity', 12:16:15 INFO - 'tart', 12:16:15 INFO - 'tscrollx', 12:16:15 INFO - 'cart']}, 12:16:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:16:15 INFO - 'tests': ['tsvgx', 12:16:15 INFO - 'tsvgr_opacity', 12:16:15 INFO - 'tart', 12:16:15 INFO - 'tscrollx', 12:16:15 INFO - 'cart']}, 12:16:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:15 INFO - 'tests': ['tp5o']}, 12:16:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:15 INFO - 'talos_options': ['--e10s'], 12:16:15 INFO - 'tests': ['tp5o']}, 12:16:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:15 INFO - 'talos_options': ['--xperf_path', 12:16:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:15 INFO - 'tests': ['tp5n']}, 12:16:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:15 INFO - 'talos_options': ['--e10s', 12:16:15 INFO - '--xperf_path', 12:16:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:15 INFO - 'tests': ['tp5n']}}, 12:16:15 INFO - 'talos.zip': {'path': '', 12:16:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:16:15 INFO - Running post-action listener: _resource_record_post_action 12:16:15 INFO - ##### 12:16:15 INFO - ##### Running create-virtualenv step. 12:16:15 INFO - ##### 12:16:15 INFO - Running pre-action listener: _resource_record_pre_action 12:16:15 INFO - Running main action method: create_virtualenv 12:16:15 INFO - Creating virtualenv /builds/slave/test/build/venv 12:16:15 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 12:16:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:16:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:16:15 INFO - Using real prefix '/usr' 12:16:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:16:15 INFO - Installing distribute.............................................................................................................................................................................................done. 12:16:17 INFO - Installing pip.................done. 12:16:17 INFO - Return code: 0 12:16:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:17 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 0x7febd9342c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b76b70>, '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 0x1bc7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8250>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203', '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 12:16:17 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 12:16:17 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 12:16:17 INFO - Using env: {'DISPLAY': ':0', 12:16:17 INFO - 'HOME': '/home/cltbld', 12:16:17 INFO - 'LANG': 'en_US.UTF-8', 12:16:17 INFO - 'LANGUAGE': 'en_US:en', 12:16:17 INFO - 'LOGNAME': 'cltbld', 12:16:17 INFO - 'MAIL': '/var/mail/cltbld', 12:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:17 INFO - 'MOZ_NO_REMOTE': '1', 12:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:17 INFO - 'NO_EM_RESTART': '1', 12:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:17 INFO - 'PWD': '/builds/slave/test', 12:16:17 INFO - 'SHELL': '/bin/bash', 12:16:17 INFO - 'SHLVL': '1', 12:16:17 INFO - 'TERM': 'linux', 12:16:17 INFO - 'TMOUT': '86400', 12:16:17 INFO - 'USER': 'cltbld', 12:16:17 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203', 12:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:17 INFO - '_': '/tools/buildbot/bin/python'} 12:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:17 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 12:16:17 INFO - Cleaning up... 12:16:17 INFO - Return code: 0 12:16:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:17 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 0x7febd9342c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b76b70>, '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 0x1bc7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8250>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203', '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 12:16:17 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 12:16:17 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 12:16:17 INFO - Using env: {'DISPLAY': ':0', 12:16:17 INFO - 'HOME': '/home/cltbld', 12:16:17 INFO - 'LANG': 'en_US.UTF-8', 12:16:17 INFO - 'LANGUAGE': 'en_US:en', 12:16:17 INFO - 'LOGNAME': 'cltbld', 12:16:17 INFO - 'MAIL': '/var/mail/cltbld', 12:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:17 INFO - 'MOZ_NO_REMOTE': '1', 12:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:17 INFO - 'NO_EM_RESTART': '1', 12:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:17 INFO - 'PWD': '/builds/slave/test', 12:16:17 INFO - 'SHELL': '/bin/bash', 12:16:17 INFO - 'SHLVL': '1', 12:16:17 INFO - 'TERM': 'linux', 12:16:17 INFO - 'TMOUT': '86400', 12:16:17 INFO - 'USER': 'cltbld', 12:16:17 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203', 12:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:17 INFO - '_': '/tools/buildbot/bin/python'} 12:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:18 INFO - Downloading/unpacking psutil>=0.7.1 12:16:18 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 12:16:18 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 12:16:18 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 12:16:18 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 12:16:18 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 12:16:18 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 12:16:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:16:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:16:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:19 INFO - Installing collected packages: psutil 12:16:19 INFO - Running setup.py install for psutil 12:16:20 INFO - building 'psutil._psutil_linux' extension 12:16:20 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 12:16:20 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 12:16:20 INFO - building 'psutil._psutil_posix' extension 12:16:20 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 12:16:20 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 12:16:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:20 INFO - Successfully installed psutil 12:16:20 INFO - Cleaning up... 12:16:20 INFO - Return code: 0 12:16:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:16: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')]} 12:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16: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')]} 12:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:20 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 0x7febd9342c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b76b70>, '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 0x1bc7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8250>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203', '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 12:16:20 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 12:16:20 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 12:16:20 INFO - Using env: {'DISPLAY': ':0', 12:16:20 INFO - 'HOME': '/home/cltbld', 12:16:20 INFO - 'LANG': 'en_US.UTF-8', 12:16:20 INFO - 'LANGUAGE': 'en_US:en', 12:16:20 INFO - 'LOGNAME': 'cltbld', 12:16:20 INFO - 'MAIL': '/var/mail/cltbld', 12:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:20 INFO - 'MOZ_NO_REMOTE': '1', 12:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:20 INFO - 'NO_EM_RESTART': '1', 12:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:20 INFO - 'PWD': '/builds/slave/test', 12:16:20 INFO - 'SHELL': '/bin/bash', 12:16:20 INFO - 'SHLVL': '1', 12:16:20 INFO - 'TERM': 'linux', 12:16:20 INFO - 'TMOUT': '86400', 12:16:20 INFO - 'USER': 'cltbld', 12:16:20 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203', 12:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:20 INFO - '_': '/tools/buildbot/bin/python'} 12:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:16:20 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 12:16:20 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 12:16:20 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 12:16:20 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 12:16:20 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 12:16:20 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 12:16:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:16:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:16:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:16:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:16:22 INFO - Installing collected packages: mozsystemmonitor 12:16:22 INFO - Running setup.py install for mozsystemmonitor 12:16:22 INFO - Successfully installed mozsystemmonitor 12:16:22 INFO - Cleaning up... 12:16:22 INFO - Return code: 0 12:16:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:16:22 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')]} 12:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:22 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')]} 12:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:22 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 0x7febd9342c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b76b70>, '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 0x1bc7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8250>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203', '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 12:16:22 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 12:16:22 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 12:16:22 INFO - Using env: {'DISPLAY': ':0', 12:16:22 INFO - 'HOME': '/home/cltbld', 12:16:22 INFO - 'LANG': 'en_US.UTF-8', 12:16:22 INFO - 'LANGUAGE': 'en_US:en', 12:16:22 INFO - 'LOGNAME': 'cltbld', 12:16:22 INFO - 'MAIL': '/var/mail/cltbld', 12:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:22 INFO - 'MOZ_NO_REMOTE': '1', 12:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:22 INFO - 'NO_EM_RESTART': '1', 12:16:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:22 INFO - 'PWD': '/builds/slave/test', 12:16:22 INFO - 'SHELL': '/bin/bash', 12:16:22 INFO - 'SHLVL': '1', 12:16:22 INFO - 'TERM': 'linux', 12:16:22 INFO - 'TMOUT': '86400', 12:16:22 INFO - 'USER': 'cltbld', 12:16:22 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203', 12:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:22 INFO - '_': '/tools/buildbot/bin/python'} 12:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:22 INFO - Downloading/unpacking blobuploader==1.2.4 12:16:22 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 12:16:22 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 12:16:22 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 12:16:22 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 12:16:22 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 12:16:22 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 12:16:24 INFO - Downloading blobuploader-1.2.4.tar.gz 12:16:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:16:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:16:24 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 12:16:24 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 12:16:24 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 12:16:24 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 12:16:24 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 12:16:24 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 12:16:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:16:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:16:24 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 12:16:24 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 12:16:24 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 12:16:24 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 12:16:24 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 12:16:24 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 12:16:25 INFO - Downloading docopt-0.6.1.tar.gz 12:16:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:16:25 INFO - Installing collected packages: blobuploader, requests, docopt 12:16:25 INFO - Running setup.py install for blobuploader 12:16:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:16:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:16:25 INFO - Running setup.py install for requests 12:16:25 INFO - Running setup.py install for docopt 12:16:25 INFO - Successfully installed blobuploader requests docopt 12:16:25 INFO - Cleaning up... 12:16:25 INFO - Return code: 0 12:16:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:25 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')]} 12:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:25 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')]} 12:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:25 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 0x7febd9342c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b76b70>, '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 0x1bc7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8250>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203', '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 12:16:25 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 12:16:25 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 12:16:25 INFO - Using env: {'DISPLAY': ':0', 12:16:25 INFO - 'HOME': '/home/cltbld', 12:16:25 INFO - 'LANG': 'en_US.UTF-8', 12:16:25 INFO - 'LANGUAGE': 'en_US:en', 12:16:25 INFO - 'LOGNAME': 'cltbld', 12:16:25 INFO - 'MAIL': '/var/mail/cltbld', 12:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:25 INFO - 'MOZ_NO_REMOTE': '1', 12:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:25 INFO - 'NO_EM_RESTART': '1', 12:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:25 INFO - 'PWD': '/builds/slave/test', 12:16:25 INFO - 'SHELL': '/bin/bash', 12:16:25 INFO - 'SHLVL': '1', 12:16:25 INFO - 'TERM': 'linux', 12:16:25 INFO - 'TMOUT': '86400', 12:16:25 INFO - 'USER': 'cltbld', 12:16:25 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203', 12:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:25 INFO - '_': '/tools/buildbot/bin/python'} 12:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:25 INFO - Running setup.py (path:/tmp/pip-JDVZjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:26 INFO - Running setup.py (path:/tmp/pip-8r_2TF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:26 INFO - Running setup.py (path:/tmp/pip-ONSBIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:26 INFO - Running setup.py (path:/tmp/pip-aBj71G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:26 INFO - Running setup.py (path:/tmp/pip-58H70r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:26 INFO - Running setup.py (path:/tmp/pip-UpHeL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:26 INFO - Running setup.py (path:/tmp/pip-sI3Jz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:26 INFO - Running setup.py (path:/tmp/pip-PLk_kF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:26 INFO - Running setup.py (path:/tmp/pip-hPWS5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:26 INFO - Running setup.py (path:/tmp/pip-4fk7Hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:26 INFO - Running setup.py (path:/tmp/pip-V9sarV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:26 INFO - Running setup.py (path:/tmp/pip-_Co0e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:26 INFO - Running setup.py (path:/tmp/pip-AUJQdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:26 INFO - Running setup.py (path:/tmp/pip-8v0djV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:26 INFO - Running setup.py (path:/tmp/pip-i4J9ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:27 INFO - Running setup.py (path:/tmp/pip-5wJUOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:27 INFO - Running setup.py (path:/tmp/pip-jCRfm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:16:27 INFO - Running setup.py install for manifestparser 12:16:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:16:27 INFO - Running setup.py install for mozcrash 12:16:27 INFO - Running setup.py install for mozdebug 12:16:27 INFO - Running setup.py install for mozdevice 12:16:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:16:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:16:27 INFO - Running setup.py install for mozfile 12:16:27 INFO - Running setup.py install for mozhttpd 12:16:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:16:27 INFO - Running setup.py install for mozinfo 12:16:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:16:27 INFO - Running setup.py install for mozInstall 12:16:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:16:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:16:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:16:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:16:27 INFO - Running setup.py install for mozleak 12:16:28 INFO - Running setup.py install for mozlog 12:16:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:16:28 INFO - Running setup.py install for moznetwork 12:16:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:16:28 INFO - Running setup.py install for mozprocess 12:16:28 INFO - Running setup.py install for mozprofile 12:16:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:16:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:16:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:16:28 INFO - Running setup.py install for mozrunner 12:16:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:16:28 INFO - Running setup.py install for mozscreenshot 12:16:28 INFO - Running setup.py install for moztest 12:16:28 INFO - Running setup.py install for mozversion 12:16:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:16:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:16:28 INFO - Cleaning up... 12:16:28 INFO - Return code: 0 12:16:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:28 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')]} 12:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:28 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')]} 12:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:28 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 0x7febd9342c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b76b70>, '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 0x1bc7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8250>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203', '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 12:16:28 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 12:16:28 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 12:16:28 INFO - Using env: {'DISPLAY': ':0', 12:16:28 INFO - 'HOME': '/home/cltbld', 12:16:28 INFO - 'LANG': 'en_US.UTF-8', 12:16:28 INFO - 'LANGUAGE': 'en_US:en', 12:16:28 INFO - 'LOGNAME': 'cltbld', 12:16:28 INFO - 'MAIL': '/var/mail/cltbld', 12:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:28 INFO - 'MOZ_NO_REMOTE': '1', 12:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:28 INFO - 'NO_EM_RESTART': '1', 12:16:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:28 INFO - 'PWD': '/builds/slave/test', 12:16:28 INFO - 'SHELL': '/bin/bash', 12:16:28 INFO - 'SHLVL': '1', 12:16:28 INFO - 'TERM': 'linux', 12:16:28 INFO - 'TMOUT': '86400', 12:16:28 INFO - 'USER': 'cltbld', 12:16:28 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203', 12:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:28 INFO - '_': '/tools/buildbot/bin/python'} 12:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:29 INFO - Running setup.py (path:/tmp/pip-NvMM__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:29 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)) 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:29 INFO - Running setup.py (path:/tmp/pip-g0YLu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:29 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)) 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:29 INFO - Running setup.py (path:/tmp/pip-wJZI9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:29 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)) 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:29 INFO - Running setup.py (path:/tmp/pip-x0tVHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:29 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)) 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:29 INFO - Running setup.py (path:/tmp/pip-1_1NYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:29 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)) 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:29 INFO - Running setup.py (path:/tmp/pip-P2QY_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:29 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)) 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:29 INFO - Running setup.py (path:/tmp/pip-iVV9T_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:29 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)) 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:29 INFO - Running setup.py (path:/tmp/pip-w76zEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:29 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)) 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:29 INFO - Running setup.py (path:/tmp/pip-XgOKVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:29 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)) 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:29 INFO - Running setup.py (path:/tmp/pip-FctMd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:29 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)) 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:29 INFO - Running setup.py (path:/tmp/pip-Wdxock-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:29 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)) 12:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:29 INFO - Running setup.py (path:/tmp/pip-q_4Jte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:30 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)) 12:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:30 INFO - Running setup.py (path:/tmp/pip-x5CdkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:30 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)) 12:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:30 INFO - Running setup.py (path:/tmp/pip-NRdjjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:30 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)) 12:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:30 INFO - Running setup.py (path:/tmp/pip-c0jhLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:30 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)) 12:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:30 INFO - Running setup.py (path:/tmp/pip-9eLekF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:30 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)) 12:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:30 INFO - Running setup.py (path:/tmp/pip-BX9ac0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:30 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)) 12:16:30 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)) 12:16:30 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)) 12:16:30 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)) 12:16:30 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)) 12:16:30 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)) 12:16:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:32 INFO - Downloading blessings-1.5.1.tar.gz 12:16:32 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 12:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:16:32 INFO - Installing collected packages: blessings 12:16:32 INFO - Running setup.py install for blessings 12:16:32 INFO - Successfully installed blessings 12:16:32 INFO - Cleaning up... 12:16:32 INFO - Return code: 0 12:16:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:16:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:32 INFO - Reading from file tmpfile_stdout 12:16:32 INFO - Current package versions: 12:16:32 INFO - argparse == 1.2.1 12:16:32 INFO - blessings == 1.5.1 12:16:32 INFO - blobuploader == 1.2.4 12:16:32 INFO - docopt == 0.6.1 12:16:32 INFO - manifestparser == 1.1 12:16:32 INFO - mozInstall == 1.12 12:16:32 INFO - mozcrash == 0.16 12:16:32 INFO - mozdebug == 0.1 12:16:32 INFO - mozdevice == 0.47 12:16:32 INFO - mozfile == 1.2 12:16:32 INFO - mozhttpd == 0.7 12:16:32 INFO - mozinfo == 0.9 12:16:32 INFO - mozleak == 0.1 12:16:32 INFO - mozlog == 3.0 12:16:32 INFO - moznetwork == 0.27 12:16:32 INFO - mozprocess == 0.22 12:16:32 INFO - mozprofile == 0.27 12:16:32 INFO - mozrunner == 6.11 12:16:32 INFO - mozscreenshot == 0.1 12:16:32 INFO - mozsystemmonitor == 0.0 12:16:32 INFO - moztest == 0.7 12:16:32 INFO - mozversion == 1.4 12:16:32 INFO - psutil == 3.1.1 12:16:32 INFO - requests == 1.2.3 12:16:32 INFO - wsgiref == 0.1.2 12:16:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:32 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 0x7febd9342c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b30900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b76b70>, '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 0x1bc7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8250>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203', '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 12:16:32 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 12:16:32 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 12:16:32 INFO - Using env: {'DISPLAY': ':0', 12:16:32 INFO - 'HOME': '/home/cltbld', 12:16:32 INFO - 'LANG': 'en_US.UTF-8', 12:16:32 INFO - 'LANGUAGE': 'en_US:en', 12:16:32 INFO - 'LOGNAME': 'cltbld', 12:16:32 INFO - 'MAIL': '/var/mail/cltbld', 12:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:32 INFO - 'MOZ_NO_REMOTE': '1', 12:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:32 INFO - 'NO_EM_RESTART': '1', 12:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:32 INFO - 'PWD': '/builds/slave/test', 12:16:32 INFO - 'SHELL': '/bin/bash', 12:16:32 INFO - 'SHLVL': '1', 12:16:32 INFO - 'TERM': 'linux', 12:16:32 INFO - 'TMOUT': '86400', 12:16:32 INFO - 'USER': 'cltbld', 12:16:32 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203', 12:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:32 INFO - '_': '/tools/buildbot/bin/python'} 12:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 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)) 12:16:32 INFO - Cleaning up... 12:16:32 INFO - Return code: 0 12:16:32 INFO - Running post-action listener: _resource_record_post_action 12:16:32 INFO - Running post-action listener: _start_resource_monitoring 12:16:32 INFO - Starting resource monitoring. 12:16:32 INFO - ##### 12:16:32 INFO - ##### Running install step. 12:16:32 INFO - ##### 12:16:32 INFO - Running pre-action listener: _resource_record_pre_action 12:16:32 INFO - Running main action method: install 12:16:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:32 INFO - Reading from file tmpfile_stdout 12:16:32 INFO - Detecting whether we're running mozinstall >=1.0... 12:16:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:16:33 INFO - Reading from file tmpfile_stdout 12:16:33 INFO - Output received: 12:16:33 INFO - Usage: mozinstall [options] installer 12:16:33 INFO - Options: 12:16:33 INFO - -h, --help show this help message and exit 12:16:33 INFO - -d DEST, --destination=DEST 12:16:33 INFO - Directory to install application into. [default: 12:16:33 INFO - "/builds/slave/test"] 12:16:33 INFO - --app=APP Application being installed. [default: firefox] 12:16:33 INFO - mkdir: /builds/slave/test/build/application 12:16:33 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'] 12:16:33 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 12:16:47 INFO - Reading from file tmpfile_stdout 12:16:47 INFO - Output received: 12:16:47 INFO - /builds/slave/test/build/application/firefox/firefox 12:16:47 INFO - Running post-action listener: _resource_record_post_action 12:16:47 INFO - ##### 12:16:47 INFO - ##### Running run-tests step. 12:16:47 INFO - ##### 12:16:47 INFO - Running pre-action listener: _resource_record_pre_action 12:16:47 INFO - Running main action method: run_tests 12:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:16:47 INFO - Python 2.7.3 12:16:47 INFO - Return code: 0 12:16:47 INFO - grabbing minidump binary from tooltool 12:16: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')]} 12:16:47 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 0x1b76b70>, '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 0x1bc7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:16:47 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 12:16:47 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 12:16:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:16:47 INFO - Return code: 0 12:16:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:16:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:16:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:16:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:16:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] in /builds/slave/test/build 12:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost 12:16:47 INFO - Using env: {'DISPLAY': ':0', 12:16:47 INFO - 'HOME': '/home/cltbld', 12:16:47 INFO - 'LANG': 'en_US.UTF-8', 12:16:47 INFO - 'LANGUAGE': 'en_US:en', 12:16:47 INFO - 'LOGNAME': 'cltbld', 12:16:47 INFO - 'MAIL': '/var/mail/cltbld', 12:16:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:16:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:47 INFO - 'MOZ_NO_REMOTE': '1', 12:16:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:47 INFO - 'NO_EM_RESTART': '1', 12:16:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:47 INFO - 'PWD': '/builds/slave/test', 12:16:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:16:47 INFO - 'SHELL': '/bin/bash', 12:16:47 INFO - 'SHLVL': '1', 12:16:47 INFO - 'TERM': 'linux', 12:16:47 INFO - 'TMOUT': '86400', 12:16:47 INFO - 'USER': 'cltbld', 12:16:47 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203', 12:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:47 INFO - '_': '/tools/buildbot/bin/python'} 12:16:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] with output_timeout 3600 12:16:47 INFO - mozversion INFO | application_buildid: 20151121014332 12:16:47 INFO - mozversion INFO | application_changeset: 489332006384610e3322739f66729448da0e98d9 12:16:47 INFO - mozversion INFO | application_display_name: Nightly 12:16:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:16:47 INFO - mozversion INFO | application_name: Firefox 12:16:47 INFO - mozversion INFO | application_remotingname: firefox 12:16:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:16:47 INFO - mozversion INFO | application_vendor: Mozilla 12:16:47 INFO - mozversion INFO | application_version: 45.0a1 12:16:47 INFO - mozversion INFO | platform_buildid: 20151121014332 12:16:47 INFO - mozversion INFO | platform_changeset: 489332006384610e3322739f66729448da0e98d9 12:16:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:16:47 INFO - mozversion INFO | platform_version: 45.0a1 12:16:47 INFO - 2015-11-23 12:16:47,457 DEBUG : using testdate: 1448309807 12:16:47 INFO - 2015-11-23 12:16:47,457 DEBUG : actual date: 1448309807 12:16:47 INFO - 2015-11-23 12:16:47,507 INFO : starting webserver on 'localhost:32860' 12:16:47 INFO - 2015-11-23 12:16:47,508 INFO : Starting test suite talos-linux64-ix-001 12:16:47 INFO - 2015-11-23 12:16:47,509 INFO : Starting test dromaeo_css 12:16:47 INFO - 2015-11-23 12:16:47,509 DEBUG : operating with platform_type : linux_ 12:16:47 INFO - 2015-11-23 12:16:47,509 INFO : Initialising browser for dromaeo_css test... 12:16:47 INFO - 2015-11-23 12:16:47,526 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprFnRUT/profile http://localhost:32860/getInfo.html 12:16:52 INFO - 2015-11-23 12:16:52,128 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:16:52 INFO - 2015-11-23 12:16:52,128 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:16:52 INFO - 2015-11-23 12:16:52,128 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:16:52 INFO - 2015-11-23 12:16:52,128 DEBUG : BROWSER_OUTPUT: __metrics 12:16:52 INFO - 2015-11-23 12:16:52,305 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:16:53 INFO - 2015-11-23 12:16:53,563 INFO : Browser initialized. 12:16:53 INFO - 2015-11-23 12:16:53,564 INFO : Running cycle 1/1 for dromaeo_css test... 12:16:53 INFO - 2015-11-23 12:16:53,564 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprFnRUT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:17:05 INFO - 2015-11-23 12:17:05,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 139821056 12:17:05 INFO - 2015-11-23 12:17:05,494 DEBUG : BROWSER_OUTPUT: 12:17:56 INFO - 2015-11-23 12:17:56,994 DEBUG : BROWSER_OUTPUT: 1448309876993 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] 12:20:09 INFO - 2015-11-23 12:20:09,333 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32860/tests/dromaeo/cssquery-ext.html) 12:20:10 INFO - 2015-11-23 12:20:10,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 259551232 12:20:10 INFO - 2015-11-23 12:20:10,579 DEBUG : BROWSER_OUTPUT: 12:23:13 INFO - 2015-11-23 12:23:13,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/dromaeo/cssquery-ext.html (next: http://localhost:32860/tests/dromaeo/cssquery-jquery.html) 12:23:13 INFO - 2015-11-23 12:23:13,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 223371264 12:23:13 INFO - 2015-11-23 12:23:13,651 DEBUG : BROWSER_OUTPUT: 12:26:15 INFO - 2015-11-23 12:26:15,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32860/tests/dromaeo/cssquery-mootools.html) 12:26:16 INFO - 2015-11-23 12:26:16,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 218722304 12:26:16 INFO - 2015-11-23 12:26:16,232 DEBUG : BROWSER_OUTPUT: 12:29:18 INFO - 2015-11-23 12:29:18,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32860/tests/dromaeo/cssquery-prototype.html) 12:29:18 INFO - 2015-11-23 12:29:18,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 203259904 12:29:18 INFO - 2015-11-23 12:29:18,709 DEBUG : BROWSER_OUTPUT: 12:32:21 INFO - 2015-11-23 12:32:21,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32860/tests/dromaeo/cssquery-yui.html) 12:32:22 INFO - 2015-11-23 12:32:22,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 205381632 12:32:22 INFO - 2015-11-23 12:32:22,130 DEBUG : BROWSER_OUTPUT: 12:35:24 INFO - 2015-11-23 12:35:24,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/dromaeo/cssquery-yui.html (next: http://localhost:32860/tests/dromaeo/cssquery-dojo.html) 12:35:24 INFO - 2015-11-23 12:35:24,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 268677120 12:35:24 INFO - 2015-11-23 12:35:24,960 DEBUG : BROWSER_OUTPUT: 12:35:24 INFO - 2015-11-23 12:35:24,961 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:35:24 INFO - 2015-11-23 12:35:24,961 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:35:24 INFO - 2015-11-23 12:35:24,961 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:35:24 INFO - 2015-11-23 12:35:24,962 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:35:24 INFO - 2015-11-23 12:35:24,963 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2634.4335967766933;2667.1865081150268;2680.289723223345;2693.892244310228;2699.7165297643746;4552.544745525446;4640.048789998046;4642.094791515656;4684.484706682267;4723.929141062887;4647.07058588282;4687.929681054787;4709.0346478971815;4710;4724.196886529289;4302.935455968163;4336.132773445308;4393.7803109844535;4433.445819272591;4493.146302202587;4211.726237794549;4388.561143885618;4423.225935461298;4469.190573312894;4508.977455112737;4263.104748002923;4273.572642735733;4332.241857674894;4350.216960947028;4355.695101342907;4317.330813723846;4345.326474396474;4365.279728844736;4375.037491751809;4412.779361031936;4138.482689663792;4222.092250166229;4325.416068830699;4353.0423306872435;4401.295792673157;4555.681102322838;4617.3304870793545;4636.211843986531;4645.349651048856;4674.182018146811;5081.5426611605135;5085.389753229636;5095.923561146586;5097.7196254206;5116.104681680691;4866.537678920497;4989.326440930464;4992.600591952635;5095.210242412432;5102.36220472441;4685.88285292867;4742.312364707167;4756.096341695067;4767.141914455431;4805.9759701201965;5142.9742851286255;5145.202493613496;5149.588032957355;5149.665271757399;5183.196604526304;4700.318453824245;4817.156997525419;4817.879553011133;4944.035912996931;4953.8018479261145;5045.621578381636;5131.076406246837;5132.743362831843;5139.743012849342;5159.303494028333;5083.74581270935;5098.821541246039;5100.515451032146;5100.872478188075;5146.433892271847;4787.688800228044;4907.484714105039;4907.509249075135;5062.265971434195;5065.240213967861;4140.523839758466;4189.350650649154;4198.223328684203;4200.033992181815;4236.2586547354085;3696.1129328960856;3708.1841994761107;3719.0702324418894;3736.3648179809497;3744.251149770057;4174.373843923436;4245.3631955206965;4363.170997510463;4370.584794444522;4405.559444055569;4981.726005069683;4994.4755800640405;5036.269740887551;5077.822276220389;5121.308623335802;4393.582609652078;4434.445694288214;4434.933475997863;4436.600705936481;4473.105378924228;4279.893002674958;4378.562143785596;4547.3179023146795;4558.49856515783;4592.563706447882;4666;4696.671233013724;4725.929111063406;4746.074515469589;4769.4753577107185;5033.094043072282;5160.845174644766;5165.431802501646;5167.509086636764;5214.217867319932;4612.74629895359;4722.5513576210205;4852.199387101089;4877.463479017234;4924.778384972613;4850.029994001285;4890.828820991248;4949.82675606352;4972.825951091694;5016.698998060128;5053.11570475158;5092.643514954066;5097;5100.311457953278;5151.098557752303;4707.411573553306;4807.038592281628;4905.313256144214;4915.508449155056;4920.606351491943;4796.136695394863;4798.760061996816;4860.1251774680895;4877.853664390074;4914.729689867092;4848.12733707936;4858.90282194347;4875.902481950412;4879.756012199305;4923;4664.720116793003;4746.501617330131;4994.9500504994485;5004.599632029356;5049.166887463527;4724.71651700899;4747.596454301285;4794.328793968777;4811.591014763644;4852.902941941212 12:35:24 INFO - 2015-11-23 12:35:24,966 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.0866092599525;570.8287513745876;578.3522454850568;584.906414973604;585.8213244960286;28405.431891362186;28986.275343116406;29016.709832901666;29022.70977290232;29055.854720726365;29666.555001674937;30203;30213.072300600892;38468.61531384692;38561.614383856155;7866.252705992936;7998;8004.279614834663;8006.319462845665;8007.1992800720045;7736.961315193416;7830.177831327714;7832.686692532292;7833.020872390951;7836.451448398614;7085.43316534676;7231.385332246766;7897.960510197441;10143.442110683945;10450.372977621368;10107.494625268708;10226.130778883804;10231.283810133295;10237.850051489197;10291.279610427273;7083.18543367509;9846.359986600919;9958.651447199314;9961.302708810386;9969.850452243221;26937.191884243308;40237.19525609501;40808.18383632311;40876.59123408757;40900.59099409027;2857.7285157909964;2957.7190166934106;2995.1463832807544;3459.5329630499814;3526.9647303526895;27071.1878643641;27149.321266968287;27347.726522734716;27564.310892227655;27939.301517462023;3331.566896303489;3351.074708314818;3457.4640930655787;3514.121469632592;3539.7345199109914;202855;203590;203595;203747;204319;53924.46075539273;54056.72971635117;54114.729426353406;54138.45861541413;54173;57545;57668.71165644145;57706;57760;57797.71101144468;13723.725525489433;14131.081479703786;14132.293385330693;14208.715825683428;14221;10161.54273057714;10217.386956782468;10258.794824103476;10265.178785697126;10269.640562580274;18720.61407383406;19440.513987150152;19443.513912152026;19457.708134377997;19494.902525487283;7625;7877.779880289643;7923.603819808986;7931.56376399292;8010.319122874621;833.7040350675422;890.5725251879135;903.7243640689653;924.7595625137378;961.7211008807368;25942.740572594408;26514;26903.461930761274;27609.585856212172;27635;946.2193690205607;998.5107297424355;998.6953979036464;999.2505620784411;1001.2590682894605;12885.291308978096;12891.226526408445;12957.416916238792;13243.536476223286;13244.139130956457;288356;292220;292303;292551;292700;46884.531154688695;47028.29457558139;47064;47129;47192.7640361796;1084.0785332467497;1112.1714322829544;1115.1691989467736;1116.3302018788825;1237.6348977051612;23781.503385959186;25789.871050644626;26708.599371009062;26864.59703104416;26981.460370792865;38009.61990380061;38078.428823568225;38371.424428633036;38411.80794096012;38478.80760596179;229489;234372;357544;367868;369814;28620.14139575816;28660.42679146447;28687;28746.281342966595;29104.854475728334;38315.808420957714;40156.598434015286;40418.79790601146;40654.59345406508;40805.1838963225;33164.170895726835;33563.83218083894;34340.14149646279;34830.82584587162;34852.825735871156;33795.76666183783;34687.13282167966;34863.65136348604;34925.47611785775;35036.474452882714;33634.34980442233;34131.65868341384;34503.4824477628;34567.827160864035;34779.478307825906;28248.29379265535;29270.853645731637;30043;31054;31139.221519462193;23029.769702303434;23524.109513055246;23716.169934052916;25135.74864251407;25635.230943071736 12:35:24 INFO - 2015-11-23 12:35:24,966 DEBUG : BROWSER_OUTPUT: |2;jquery.html;340.4620699295114;341.20499236778306;342.1395191094398;345.0178723235014;345.4541823918209;12085.637430877066;12490.313032783193;15072.095674259539;15138.924305378472;15912.68174636508;12468;14282.714345713079;14426.639334016654;14610.926945365258;14785.852141478583;4910.484399138101;4920.557149856512;5058.190689489682;5059.898802023958;5062.620303477235;3590.2460483298537;3682.8895133146048;5054.039732450822;5105.821296254632;5582.358028826676;5891.11633255013;5913;5936.584439089265;5942.108683697436;5943.702814859262;5726.885462290752;5852.326982397015;5854.034084376073;5854.151148083504;5857.209276747627;5123.846284611468;5124.333836601218;5124.92312615311;5136.974315128437;5143.048536020848;19419.611607767765;20457.67025143376;20597.897010515;20690.48273793152;20847;1765.8852174608737;1834.6881030224895;1965.6756635155182;2036.1244664794133;2069.9793002070087;12815.935920320338;12930.54743083997;12961;13143.27711975841;13148.934255328757;1691.8392752688476;1807.566184115816;1811.0763510609552;1819.818018198183;1822.2437688359314;46728.299075513896;47557.28664070007;53241.2013819793;54445.455545444434;55883.72058139724;14232.573022809333;14656.926715366568;14667.266636668124;14724.411023558938;14727.926360368343;22899;23008.424789380064;23046.7695323048;23077.653835192486;23179.768202318097;8281.917180828235;8357.665693372319;8502;8537.103604121601;8592.957035214784;7151.463640227003;7168.677409516585;7170.892436613455;7212.71149154028;7224.060872086595;7581.431392645573;7592.620368981528;7594.240575942362;7620.542767433972;7626.389888808882;1702.446704820938;1705.4286813917229;1731.7835270591177;2148.78512148787;2902.1003488918504;823.0658202939707;825.4964471672275;838.2120806441925;842.877782721502;897.5422534507318;12498;14188.85811141896;14485.275736213147;15376.308066137051;15704.685906281811;798.2097723254053;831.1397703376975;849.562475325208;856.0668870930715;906.619219927632;8443.324534037261;8774.868376974351;8785;8856.557172141496;8967.372283940193;492935;493339;494068;514355;524686;67344.32655673381;72168.63915680493;74028;74958;75853;1063.1919740997052;1065.046783129095;1077.208251934843;1100.9394483303495;1110.4947249001684;13510.324483775968;14130.717385652435;14240.71518569602;14300.713985720435;14304.213268270345;27167.45665086727;28138;28700.569491458064;29383.853080734458;29930.959320491456;33087.338253235284;33892.15269618279;34351.31297374088;35036.12409689778;36625.70368666833;8416.242538171595;8701.651933922825;8863;8869.556522173994;8907.688230912147;13830.515931942333;16170;16368.345266189219;16411.717656468514;16478.505644830675;13875.653108672364;13985.790213146607;14015.859841401863;14138.575842724735;14143.64640883986;13155.276459794803;13509.797353039909;13645.658858528615;13710.657233568842;13872.375743091787;10086;13670.17978921268;13909.513167039106;14073.718525629634;14101.365438555495;9016.729498115066;9160.587773550073;9175.587098580447;9204.355695101278;9212.355135140477;13752.587422377344;13782.724345513234;13930.58208253754;14300.928495357457;14368.640783980067 12:35:24 INFO - 2015-11-23 12:35:24,967 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1400.4818217259615;1590.9124998125103;1622.9026258424497;1649.4886585158602;1670.415354625881;5863.384344643815;6657.30098339674;6821;6822.590644561317;6829.556078854877;6751;6798.694058767355;6851.657417129149;6855.622940738257;6883.174019117713;1755.569885378084;1803.9278428862895;2083.2187929526426;2104.5370018595886;2115.2596591193114;2047.7030830529563;2103.8842863642494;2105.652567326389;2106.7577228618675;2107.2624581396467;1997.600479904025;2010.628033813742;2014.546726986431;2063.4222417722985;2070.33749200256;2039.9796002040086;2067.1937944201773;2088.905999230023;2095.287602215254;2100.33839340608;2073.2950796729183;2097.0144032304793;2098.244631932503;2101.191041449038;2103.3584756649216;6881.380675739208;6921;6934.514583979124;6952.096227490444;6980.685869135901;4021.235965166609;4102.815373308208;4106.178764247133;4132.772697501636;4142.91714165715;2749.092799376201;2910.825350478978;2921.590977263185;2938.4563855686765;2942.955855662167;773.8607050730923;891.1801142948503;900.9549522523913;906.7415786500816;942.4345392764286;9084.818303633956;9171.082891710843;9175.541222938826;9191.172794448465;9196.264298856075;3963.1875465530075;3996.360582306817;4024.6176613221696;4038.7374820636564;4040.3939409088284;7757.72847950319;7796.688132474637;7799.805004874924;7846.136924938252;7850;4259.190753756776;4281.207976524353;4281.593248641374;4294.420253265832;4294.82820687169;3881.4760007399204;3897.5322961244265;3921.490206273166;3923.0388554804254;3925;3415;3417.4532074867902;3437.1750779812664;3452.879149229765;3464.4976478410995;1118.4519585403257;1125.2123513540555;1132.1565433751907;1136.187625847523;1145.7078444996473;1125.4597793059377;1129.0967226219157;1141.0643272516456;1141.4635121492886;1160;6501.2523559791225;6550.639714815731;6580.11168492257;6585.275619681831;6590.406863382223;443.844654370974;447.64859585226094;450.4864454521848;454.17567115684926;454.2504866969461;5052.141136006814;5141.434442211354;5141.562967147759;5145.07388670043;5145.253938178943;7907.9604601976625;7962.3630109591095;8157.510549367057;8222.218889205516;8278.503289802631;8081.797955051054;8104.5137291762685;8121.187881211949;8199.95900020496;8224;6323.810285691437;6369.0764839099;6411.487081033506;6436.13112229843;6487.124238227779;6071.453569178795;6097.359777223328;6104.755809767559;6115.327313995368;6120.510359171345;7112.964435177791;7305.561666300039;7313.341799237881;7373.594452305175;7387.741429049957;7297.416206703557;7512.5492470451945;7525.887111693439;7540.359069479156;7627.046619172604;6066.817995460143;6094.238220222473;6110.327863934875;6117.541184411098;6117.602355846856;6271.498280137669;6463.57986730861;6526.314736952551;6543.051257567531;6663.600183988976;6291.276503202007;6295.1186833842385;6328.841778955563;6438.066480360415;6440.484761219185;6095.939040609537;6137.232845894263;6198.318184999556;6271.090691849748;6336.239651241696;6173.074038894202;6316;6337.65142917144;6358.745650173942;6373.840653983688;5454.645448045864;5479.753411096431;5483.890322193613;5491.643043202179;5504.669719816824;5147.510986456281;5926.703664816828;5947.762089516544;5954.166416701752;5963.612365196248 12:35:24 INFO - 2015-11-23 12:35:24,969 DEBUG : BROWSER_OUTPUT: |4;prototype.html;312.69824619242434;315.8562853901475;321.0897106702498;322.6434789557537;323.9335936133092;5241.8427447176555;5304.2043693446;5354.651947623402;5401.513863752261;5415.702136382497;5136.563392111675;5276.103062479378;5313.282706834586;5321.893562128756;5325;4220.53574106848;4223.324268117102;4226.661867050629;4230.788460576974;4240.787960601973;4010.2981978153853;4099.836006559734;4126.834926602933;4156.1687662467475;4226.260404429228;4167.520735115455;4170.8540201092965;4182.372644103379;4183.811728472226;4193.972476743203;4179.937300940488;4181.686373521983;4185.66514678828;4188.539260681323;4195.181939521794;3710.3135919854913;3710.888673339777;3715.64701353371;3718.2377612589353;3724.627537246281;5004.099262132815;5132.255822905695;5134.537891589737;5143.691378517264;5143.7685304161405;4835.226363781778;4837.637177211688;4841.661083724141;4844.055409195208;4844.612431005511;5654.886902261932;5666.121751128581;5666.490015898589;5670.8015219467125;5672.14917762339;3815.4849095372047;3922.195949830278;3929.292727309083;4038.172174704179;4058.5129784425762;5924.170616113747;5935.139404786325;5943.524518038546;5949.6430214187285;5953.868764934648;4171.436856024458;4173.6661067114555;4177.373393990925;4183.937240941388;4186.769727665008;4241.97879010603;4252.532221455637;4254.064105896698;4256.851010214689;4261.147770445923;4663.740789986752;4789.521047895182;4801.255805350176;4804.327394164749;4812.759362031955;5642.4075472075665;5646.548276137899;5647.124695672177;5651.943480565142;5663.980483513007;1477.6822983058694;1495.2150121186464;1496.2369191712305;1498.7002599480147;1498.9475368362055;1024.3444195714749;1030.5877648940334;1032.9793404131876;1050.6900464363032;1053.2311412668794;4972.055309491185;4975.676581022222;4976.178930476503;4976.90046199074;4984.401871775338;5841.06542953134;5871.3541510433815;5873.735681894325;5875.823725288248;5880.617759845596;4939.135651261086;4963;4982.850514484571;4989.077020751172;4989.775460104304;3106.0681795461273;3150.401423729484;3168.1287645897564;3181.316017056298;3182.0612919188893;5551.944480555224;5562.332520097614;5567.944320556742;5568.582356323211;5568.638038527482;6041.486473649701;6048.969755151196;6051.515878729691;6054.545909056838;6055.333913269536;5535.944640553543;5543.6396634218645;5560.666360018412;5561.249231353877;5562.833115006556;5788.363280039276;5948.732307046107;5958.940410596012;5970.432808883149;5973.193618861572;5520.171974203901;5631.915521267266;5705.087186050212;5817.680027598522;5824.184614153937;5597.832065038056;5611.5230205433;5612.579056570692;5614.157876318585;5615.663060216237;4045.8988525287104;4075.3886916962692;4077.26609210345;4080.0615858352153;4080.367543030835;5916.911246331222;5918.082697181943;5928.79249226275;5931.733072011856;5934.050551911673;5562.860928476821;5706.657600543981;5706.942930570641;5708.743106560131;5717.714114294352;5687.3459552152035;5704.600677952503;5705.771769129188;5707.4577915098;5711.771529138954;5589.329280486368;5592.524635406036;5594.272744543184;5597.6641401516035;5598.860028499157;5606.915896261477;5744.3394009687745;5754.136879468113;5755.338136114233;5764.106563482667;5613.607047506799;5620.437956204347;5622.2128901954575;5622.24099746529;5624.35319938196 12:35:24 INFO - 2015-11-23 12:35:24,969 DEBUG : BROWSER_OUTPUT: |5;yui.html;666.9266380698123;700.324187159391;787.3150359187506;804.1194891593707;825.9132791056938;10859.13126949844;10965.61620343288;10979.560817567297;10992.505337259823;10996;11492.71268218295;12346.506139754421;12457.128001039931;12476.93761531191;12513.436895339708;624.4099326136802;633.9302676705581;797.6530209358933;811.4725428471511;812.6830536090899;793.8213901872061;803.6704950970103;809.5911564659839;809.874469457235;811.0875265326507;831.8128421105264;843.2115971566604;843.8354520868434;844.4131328726537;844.7592436155696;651.6871901487289;661.6327937994387;824.295227580416;835.048045228437;839.7061028639988;617.6911544227886;618.6257314324814;618.9628622282678;619.1053927075333;619.1424876545972;11272.323660580392;11408.429578521042;11417.31496110236;11420.71448213793;11427.314361138358;10788.514516846682;11288.548458061668;11347.489362978686;11388;11479.713007174803;9097.317701172373;9470.668526601536;9541.952290238505;9581.952090239503;9901.900980990169;3092.845357732127;3108.6425061118034;3136.4197623439736;3169.524571314298;3188.1870123118456;42744;43299;43323.350149747464;43353.566464335585;43398.349024764655;8909.420887642282;9125.45247285165;9163.31275154366;9235.07649235071;9295.72112836616;15392.384304627689;15412.537623871302;15423.228838558027;15429.768553471707;15451.304691288919;5980.55145864062;6112.205413296243;6146.815595532141;6184.783532576428;6291.056341548804;3587.515685382492;3601.405768048295;3641.5083963665097;3648.5074514940675;3713.034611001105;2712.8372297662204;2772.6672799264215;2779.680336761258;2780.3883145707914;2783.053761721025;490.31111288639516;492.7831754028216;496.87329730918384;498.9052080104768;499.2461383311226;487.19369443570946;561.9943800562024;584.4126652713995;596.2457491273542;620.8758248350348;7839.255270749384;7942.569878140806;7944.84078909971;7945.404094692805;8130.471519351223;478.44022493682473;583.2534356024296;584.6316820403118;591.9378465261171;610.9122593357216;3719.8326075326677;3770.8868733938025;3795.791231482295;3802.296575133609;3854.4411060396087;49609;50043;50263.74868125636;50331.49668503268;50506;42629.57370426318;42649;43287.783561082;43439.782801086425;45747;40643;40805.59194408077;41994.58005419907;42507.57492425036;42810.143797123885;8025.197480251928;8132.512049277062;8142.8778568322705;8176.959115204386;8213.835723285381;31667.52498712475;32256.838715806272;32470.188245294055;32563.18592035218;32734.672653273163;38055;40579.1884162321;40581.39127913024;40995.590044099175;41606.37590436085;9701.126898579161;9701.902980970382;10114.544845481823;10283.794324113625;10308.226882983956;10968;11285.830712539482;11332.093432525213;11557.42212889369;11629.825552616549;10524.579016839241;10894.237403381687;11124.61063862761;11203.663890083311;11488.080953523866;10207.438590877277;10357.378557286587;10687.625933092304;10774.407407592658;10827.296225745302;10313.22650801208;10320.277580569287;10399.376037437778;10680.73298167521;10808.89191108079;9182.770430739285;9328.160465558132;9371.718848434557;9385.38994965325;9658;8632.877725895594;9438.669646562337;9463;9475.57359918819;9501.762455938657 12:35:24 INFO - 2015-11-23 12:35:24,969 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:35:24 INFO - 2015-11-23 12:35:24,969 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:35:24 INFO - 2015-11-23 12:35:24,969 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1033 12:35:24 INFO - 2015-11-23 12:35:24,969 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:35:24 INFO - 2015-11-23 12:35:24,969 DEBUG : BROWSER_OUTPUT: __startTimestamp1448310924960__endTimestamp 12:35:24 INFO - 2015-11-23 12:35:24,969 DEBUG : BROWSER_OUTPUT: 12:35:24 INFO - 2015-11-23 12:35:24,970 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:35:24 INFO - 2015-11-23 12:35:24,970 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:35:24 INFO - 2015-11-23 12:35:24,970 DEBUG : BROWSER_OUTPUT: 12:35:24 INFO - 2015-11-23 12:35:24,970 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4653.51 Median:4746.50 stddev:488.94 (10.3%) stddev-sans-first:464.08 12:35:24 INFO - 2015-11-23 12:35:24,971 DEBUG : BROWSER_OUTPUT: Values: 2634.4 2667.2 2680.3 2693.9 2699.7 4552.5 4640.0 4642.1 4684.5 4723.9 4647.1 4687.9 4709.0 4710.0 4724.2 4302.9 4336.1 4393.8 4433.4 4493.1 4211.7 4388.6 4423.2 4469.2 4509.0 4263.1 4273.6 4332.2 4350.2 4355.7 4317.3 4345.3 4365.3 4375.0 4412.8 4138.5 4222.1 4325.4 4353.0 4401.3 4555.7 4617.3 4636.2 4645.3 4674.2 5081.5 5085.4 5095.9 5097.7 5116.1 4866.5 4989.3 4992.6 5095.2 5102.4 4685.9 4742.3 4756.1 4767.1 4806.0 5143.0 5145.2 5149.6 5149.7 5183.2 4700.3 4817.2 4817.9 4944.0 4953.8 5045.6 5131.1 5132.7 5139.7 5159.3 5083.7 5098.8 5100.5 5100.9 5146.4 4787.7 4907.5 4907.5 5062.3 5065.2 4140.5 4189.4 4198.2 4200.0 4236.3 3696.1 3708.2 3719.1 3736.4 3744.3 4174.4 4245.4 4363.2 4370.6 4405.6 4981.7 4994.5 5036.3 5077.8 5121.3 4393.6 4434.4 4434.9 4436.6 4473.1 4279.9 4378.6 4547.3 4558.5 4592.6 4666.0 4696.7 4725.9 4746.1 4769.5 5033.1 5160.8 5165.4 5167.5 5214.2 4612.7 4722.6 4852.2 4877.5 4924.8 4850.0 4890.8 4949.8 4972.8 5016.7 5053.1 5092.6 5097.0 5100.3 5151.1 4707.4 4807.0 4905.3 4915.5 4920.6 4796.1 4798.8 4860.1 4877.9 4914.7 4848.1 4858.9 4875.9 4879.8 4923.0 4664.7 4746.5 4995.0 5004.6 5049.2 4724.7 4747.6 4794.3 4811.6 4852.9 12:35:24 INFO - 2015-11-23 12:35:24,971 DEBUG : BROWSER_OUTPUT: 12:35:24 INFO - 2015-11-23 12:35:24,971 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42489.27 Median:33599.09 stddev:72339.99 (215.3%) stddev-sans-first:72474.43 12:35:24 INFO - 2015-11-23 12:35:24,971 DEBUG : BROWSER_OUTPUT: Values: 562.1 570.8 578.4 584.9 585.8 28405.4 28986.3 29016.7 29022.7 29055.9 29666.6 30203.0 30213.1 38468.6 38561.6 7866.3 7998.0 8004.3 8006.3 8007.2 7737.0 7830.2 7832.7 7833.0 7836.5 7085.4 7231.4 7898.0 10143.4 10450.4 10107.5 10226.1 10231.3 10237.9 10291.3 7083.2 9846.4 9958.7 9961.3 9969.9 26937.2 40237.2 40808.2 40876.6 40900.6 2857.7 2957.7 2995.1 3459.5 3527.0 27071.2 27149.3 27347.7 27564.3 27939.3 3331.6 3351.1 3457.5 3514.1 3539.7 202855.0 203590.0 203595.0 203747.0 204319.0 53924.5 54056.7 54114.7 54138.5 54173.0 57545.0 57668.7 57706.0 57760.0 57797.7 13723.7 14131.1 14132.3 14208.7 14221.0 10161.5 10217.4 10258.8 10265.2 10269.6 18720.6 19440.5 19443.5 19457.7 19494.9 7625.0 7877.8 7923.6 7931.6 8010.3 833.7 890.6 903.7 924.8 961.7 25942.7 26514.0 26903.5 27609.6 27635.0 946.2 998.5 998.7 999.3 1001.3 12885.3 12891.2 12957.4 13243.5 13244.1 288356.0 292220.0 292303.0 292551.0 292700.0 46884.5 47028.3 47064.0 47129.0 47192.8 1084.1 1112.2 1115.2 1116.3 1237.6 23781.5 25789.9 26708.6 26864.6 26981.5 38009.6 38078.4 38371.4 38411.8 38478.8 229489.0 234372.0 357544.0 367868.0 369814.0 28620.1 28660.4 28687.0 28746.3 29104.9 38315.8 40156.6 40418.8 40654.6 40805.2 33164.2 33563.8 34340.1 34830.8 34852.8 33795.8 34687.1 34863.7 34925.5 35036.5 33634.3 34131.7 34503.5 34567.8 34779.5 28248.3 29270.9 30043.0 31054.0 31139.2 23029.8 23524.1 23716.2 25135.7 25635.2 12:35:24 INFO - 2015-11-23 12:35:24,972 DEBUG : BROWSER_OUTPUT: 12:35:24 INFO - 2015-11-23 12:35:24,972 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27093.76 Median:33489.75 stddev:82111.53 (245.2%) stddev-sans-first:82317.30 12:35:24 INFO - 2015-11-23 12:35:24,972 DEBUG : BROWSER_OUTPUT: Values: 340.5 341.2 342.1 345.0 345.5 12085.6 12490.3 15072.1 15138.9 15912.7 12468.0 14282.7 14426.6 14610.9 14785.9 4910.5 4920.6 5058.2 5059.9 5062.6 3590.2 3682.9 5054.0 5105.8 5582.4 5891.1 5913.0 5936.6 5942.1 5943.7 5726.9 5852.3 5854.0 5854.2 5857.2 5123.8 5124.3 5124.9 5137.0 5143.0 19419.6 20457.7 20597.9 20690.5 20847.0 1765.9 1834.7 1965.7 2036.1 2070.0 12815.9 12930.5 12961.0 13143.3 13148.9 1691.8 1807.6 1811.1 1819.8 1822.2 46728.3 47557.3 53241.2 54445.5 55883.7 14232.6 14656.9 14667.3 14724.4 14727.9 22899.0 23008.4 23046.8 23077.7 23179.8 8281.9 8357.7 8502.0 8537.1 8593.0 7151.5 7168.7 7170.9 7212.7 7224.1 7581.4 7592.6 7594.2 7620.5 7626.4 1702.4 1705.4 1731.8 2148.8 2902.1 823.1 825.5 838.2 842.9 897.5 12498.0 14188.9 14485.3 15376.3 15704.7 798.2 831.1 849.6 856.1 906.6 8443.3 8774.9 8785.0 8856.6 8967.4 492935.0 493339.0 494068.0 514355.0 524686.0 67344.3 72168.6 74028.0 74958.0 75853.0 1063.2 1065.0 1077.2 1100.9 1110.5 13510.3 14130.7 14240.7 14300.7 14304.2 27167.5 28138.0 28700.6 29383.9 29931.0 33087.3 33892.2 34351.3 35036.1 36625.7 8416.2 8701.7 8863.0 8869.6 8907.7 13830.5 16170.0 16368.3 16411.7 16478.5 13875.7 13985.8 14015.9 14138.6 14143.6 13155.3 13509.8 13645.7 13710.7 13872.4 10086.0 13670.2 13909.5 14073.7 14101.4 9016.7 9160.6 9175.6 9204.4 9212.4 13752.6 13782.7 13930.6 14300.9 14368.6 12:35:24 INFO - 2015-11-23 12:35:24,972 DEBUG : BROWSER_OUTPUT: 12:35:24 INFO - 2015-11-23 12:35:24,973 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4817.27 Median:6015.22 stddev:2439.44 (40.6%) stddev-sans-first:2432.76 12:35:24 INFO - 2015-11-23 12:35:24,973 DEBUG : BROWSER_OUTPUT: Values: 1400.5 1590.9 1622.9 1649.5 1670.4 5863.4 6657.3 6821.0 6822.6 6829.6 6751.0 6798.7 6851.7 6855.6 6883.2 1755.6 1803.9 2083.2 2104.5 2115.3 2047.7 2103.9 2105.7 2106.8 2107.3 1997.6 2010.6 2014.5 2063.4 2070.3 2040.0 2067.2 2088.9 2095.3 2100.3 2073.3 2097.0 2098.2 2101.2 2103.4 6881.4 6921.0 6934.5 6952.1 6980.7 4021.2 4102.8 4106.2 4132.8 4142.9 2749.1 2910.8 2921.6 2938.5 2943.0 773.9 891.2 901.0 906.7 942.4 9084.8 9171.1 9175.5 9191.2 9196.3 3963.2 3996.4 4024.6 4038.7 4040.4 7757.7 7796.7 7799.8 7846.1 7850.0 4259.2 4281.2 4281.6 4294.4 4294.8 3881.5 3897.5 3921.5 3923.0 3925.0 3415.0 3417.5 3437.2 3452.9 3464.5 1118.5 1125.2 1132.2 1136.2 1145.7 1125.5 1129.1 1141.1 1141.5 1160.0 6501.3 6550.6 6580.1 6585.3 6590.4 443.8 447.6 450.5 454.2 454.3 5052.1 5141.4 5141.6 5145.1 5145.3 7908.0 7962.4 8157.5 8222.2 8278.5 8081.8 8104.5 8121.2 8200.0 8224.0 6323.8 6369.1 6411.5 6436.1 6487.1 6071.5 6097.4 6104.8 6115.3 6120.5 7113.0 7305.6 7313.3 7373.6 7387.7 7297.4 7512.5 7525.9 7540.4 7627.0 6066.8 6094.2 6110.3 6117.5 6117.6 6271.5 6463.6 6526.3 6543.1 6663.6 6291.3 6295.1 6328.8 6438.1 6440.5 6095.9 6137.2 6198.3 6271.1 6336.2 6173.1 6316.0 6337.7 6358.7 6373.8 5454.6 5479.8 5483.9 5491.6 5504.7 5147.5 5926.7 5947.8 5954.2 5963.6 12:35:24 INFO - 2015-11-23 12:35:24,973 DEBUG : BROWSER_OUTPUT: 12:35:24 INFO - 2015-11-23 12:35:24,973 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4721.53 Median:5192.81 stddev:1372.28 (26.4%) stddev-sans-first:1335.63 12:35:24 INFO - 2015-11-23 12:35:24,974 DEBUG : BROWSER_OUTPUT: Values: 312.7 315.9 321.1 322.6 323.9 5241.8 5304.2 5354.7 5401.5 5415.7 5136.6 5276.1 5313.3 5321.9 5325.0 4220.5 4223.3 4226.7 4230.8 4240.8 4010.3 4099.8 4126.8 4156.2 4226.3 4167.5 4170.9 4182.4 4183.8 4194.0 4179.9 4181.7 4185.7 4188.5 4195.2 3710.3 3710.9 3715.6 3718.2 3724.6 5004.1 5132.3 5134.5 5143.7 5143.8 4835.2 4837.6 4841.7 4844.1 4844.6 5654.9 5666.1 5666.5 5670.8 5672.1 3815.5 3922.2 3929.3 4038.2 4058.5 5924.2 5935.1 5943.5 5949.6 5953.9 4171.4 4173.7 4177.4 4183.9 4186.8 4242.0 4252.5 4254.1 4256.9 4261.1 4663.7 4789.5 4801.3 4804.3 4812.8 5642.4 5646.5 5647.1 5651.9 5664.0 1477.7 1495.2 1496.2 1498.7 1498.9 1024.3 1030.6 1033.0 1050.7 1053.2 4972.1 4975.7 4976.2 4976.9 4984.4 5841.1 5871.4 5873.7 5875.8 5880.6 4939.1 4963.0 4982.9 4989.1 4989.8 3106.1 3150.4 3168.1 3181.3 3182.1 5551.9 5562.3 5567.9 5568.6 5568.6 6041.5 6049.0 6051.5 6054.5 6055.3 5535.9 5543.6 5560.7 5561.2 5562.8 5788.4 5948.7 5958.9 5970.4 5973.2 5520.2 5631.9 5705.1 5817.7 5824.2 5597.8 5611.5 5612.6 5614.2 5615.7 4045.9 4075.4 4077.3 4080.1 4080.4 5916.9 5918.1 5928.8 5931.7 5934.1 5562.9 5706.7 5706.9 5708.7 5717.7 5687.3 5704.6 5705.8 5707.5 5711.8 5589.3 5592.5 5594.3 5597.7 5598.9 5606.9 5744.3 5754.1 5755.3 5764.1 5613.6 5620.4 5622.2 5622.2 5624.4 12:35:24 INFO - 2015-11-23 12:35:24,974 DEBUG : BROWSER_OUTPUT: 12:35:24 INFO - 2015-11-23 12:35:24,974 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12367.95 Median:43419.07 stddev:14082.66 (32.4%) stddev-sans-first:14094.76 12:35:24 INFO - 2015-11-23 12:35:24,974 DEBUG : BROWSER_OUTPUT: Values: 666.9 700.3 787.3 804.1 825.9 10859.1 10965.6 10979.6 10992.5 10996.0 11492.7 12346.5 12457.1 12476.9 12513.4 624.4 633.9 797.7 811.5 812.7 793.8 803.7 809.6 809.9 811.1 831.8 843.2 843.8 844.4 844.8 651.7 661.6 824.3 835.0 839.7 617.7 618.6 619.0 619.1 619.1 11272.3 11408.4 11417.3 11420.7 11427.3 10788.5 11288.5 11347.5 11388.0 11479.7 9097.3 9470.7 9542.0 9582.0 9901.9 3092.8 3108.6 3136.4 3169.5 3188.2 42744.0 43299.0 43323.4 43353.6 43398.3 8909.4 9125.5 9163.3 9235.1 9295.7 15392.4 15412.5 15423.2 15429.8 15451.3 5980.6 6112.2 6146.8 6184.8 6291.1 3587.5 3601.4 3641.5 3648.5 3713.0 2712.8 2772.7 2779.7 2780.4 2783.1 490.3 492.8 496.9 498.9 499.2 487.2 562.0 584.4 596.2 620.9 7839.3 7942.6 7944.8 7945.4 8130.5 478.4 583.3 584.6 591.9 610.9 3719.8 3770.9 3795.8 3802.3 3854.4 49609.0 50043.0 50263.7 50331.5 50506.0 42629.6 42649.0 43287.8 43439.8 45747.0 40643.0 40805.6 41994.6 42507.6 42810.1 8025.2 8132.5 8142.9 8177.0 8213.8 31667.5 32256.8 32470.2 32563.2 32734.7 38055.0 40579.2 40581.4 40995.6 41606.4 9701.1 9701.9 10114.5 10283.8 10308.2 10968.0 11285.8 11332.1 11557.4 11629.8 10524.6 10894.2 11124.6 11203.7 11488.1 10207.4 10357.4 10687.6 10774.4 10827.3 10313.2 10320.3 10399.4 10680.7 10808.9 9182.8 9328.2 9371.7 9385.4 9658.0 8632.9 9438.7 9463.0 9475.6 9501.8 12:35:24 INFO - 2015-11-23 12:35:24,974 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:35:24 INFO - 2015-11-23 12:35:24,974 DEBUG : BROWSER_OUTPUT: 12:35:25 INFO - 2015-11-23 12:35:25,745 INFO : Browser exited with error code: 0 12:35:25 INFO - 2015-11-23 12:35:25,764 INFO : Completed test dromaeo_css (00:18:38) 12:35:25 INFO - 2015-11-23 12:35:25,764 INFO : Starting test kraken 12:35:25 INFO - 2015-11-23 12:35:25,764 DEBUG : operating with platform_type : linux_ 12:35:25 INFO - 2015-11-23 12:35:25,764 INFO : Initialising browser for kraken test... 12:35:25 INFO - 2015-11-23 12:35:25,770 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm3pJie/profile http://localhost:32860/getInfo.html 12:35:30 INFO - 2015-11-23 12:35:30,080 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:35:30 INFO - 2015-11-23 12:35:30,080 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:35:30 INFO - 2015-11-23 12:35:30,080 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:35:30 INFO - 2015-11-23 12:35:30,080 DEBUG : BROWSER_OUTPUT: __metrics 12:35:30 INFO - 2015-11-23 12:35:30,238 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:35:31 INFO - 2015-11-23 12:35:31,491 INFO : Browser initialized. 12:35:31 INFO - 2015-11-23 12:35:31,491 INFO : Running cycle 1/1 for kraken test... 12:35:31 INFO - 2015-11-23 12:35:31,492 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm3pJie/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:35:43 INFO - 2015-11-23 12:35:43,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 142123008 12:35:43 INFO - 2015-11-23 12:35:43,450 DEBUG : BROWSER_OUTPUT: 12:35:46 INFO - 2015-11-23 12:35:46,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32860/tests/kraken/driver.html?testName=audio-beat-detection) 12:35:46 INFO - 2015-11-23 12:35:46,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 178896896 12:35:46 INFO - 2015-11-23 12:35:46,606 DEBUG : BROWSER_OUTPUT: 12:35:49 INFO - 2015-11-23 12:35:49,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32860/tests/kraken/driver.html?testName=audio-dft) 12:35:49 INFO - 2015-11-23 12:35:49,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 165990400 12:35:49 INFO - 2015-11-23 12:35:49,917 DEBUG : BROWSER_OUTPUT: 12:35:52 INFO - 2015-11-23 12:35:52,937 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32860/tests/kraken/driver.html?testName=audio-fft) 12:35:53 INFO - 2015-11-23 12:35:53,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 150638592 12:35:53 INFO - 2015-11-23 12:35:53,500 DEBUG : BROWSER_OUTPUT: 12:35:55 INFO - 2015-11-23 12:35:55,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32860/tests/kraken/driver.html?testName=audio-oscillator) 12:35:56 INFO - 2015-11-23 12:35:56,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 154288128 12:35:56 INFO - 2015-11-23 12:35:56,139 DEBUG : BROWSER_OUTPUT: 12:35:58 INFO - 2015-11-23 12:35:58,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32860/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:35:58 INFO - 2015-11-23 12:35:58,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 156110848 12:35:58 INFO - 2015-11-23 12:35:58,923 DEBUG : BROWSER_OUTPUT: 12:36:01 INFO - 2015-11-23 12:36:01,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32860/tests/kraken/driver.html?testName=imaging-darkroom) 12:36:02 INFO - 2015-11-23 12:36:02,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 156962816 12:36:02 INFO - 2015-11-23 12:36:02,529 DEBUG : BROWSER_OUTPUT: 12:36:05 INFO - 2015-11-23 12:36:05,937 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32860/tests/kraken/driver.html?testName=imaging-desaturate) 12:36:06 INFO - 2015-11-23 12:36:06,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 157089792 12:36:06 INFO - 2015-11-23 12:36:06,518 DEBUG : BROWSER_OUTPUT: 12:36:09 INFO - 2015-11-23 12:36:09,356 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32860/tests/kraken/driver.html?testName=json-parse-financial) 12:36:09 INFO - 2015-11-23 12:36:09,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 157233152 12:36:09 INFO - 2015-11-23 12:36:09,943 DEBUG : BROWSER_OUTPUT: 12:36:11 INFO - 2015-11-23 12:36:11,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32860/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:36:12 INFO - 2015-11-23 12:36:12,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 167710720 12:36:12 INFO - 2015-11-23 12:36:12,263 DEBUG : BROWSER_OUTPUT: 12:36:14 INFO - 2015-11-23 12:36:14,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32860/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:36:14 INFO - 2015-11-23 12:36:14,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 165974016 12:36:14 INFO - 2015-11-23 12:36:14,695 DEBUG : BROWSER_OUTPUT: 12:36:16 INFO - 2015-11-23 12:36:16,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32860/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:36:17 INFO - 2015-11-23 12:36:17,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 175468544 12:36:17 INFO - 2015-11-23 12:36:17,551 DEBUG : BROWSER_OUTPUT: 12:36:20 INFO - 2015-11-23 12:36:20,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:36:20 INFO - 2015-11-23 12:36:20,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 182116352 12:36:20 INFO - 2015-11-23 12:36:20,680 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:36:23 INFO - 2015-11-23 12:36:23,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 182304768 12:36:23 INFO - 2015-11-23 12:36:23,811 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32860/tests/kraken/driver.html?testName=ai-astar) 12:36:25 INFO - 2015-11-23 12:36:25,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 241680384 12:36:25 INFO - 2015-11-23 12:36:25,792 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,795 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:36:25 INFO - 2015-11-23 12:36:25,795 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:36:25 INFO - 2015-11-23 12:36:25,796 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:36:25 INFO - 2015-11-23 12:36:25,796 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:36:25 INFO - 2015-11-23 12:36:25,796 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;106;113;113;112;101;112;118;114 12:36:25 INFO - 2015-11-23 12:36:25,796 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;130;159;163;136;150;149;140;175;130 12:36:25 INFO - 2015-11-23 12:36:25,796 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;161;161;160;160;162;160;161;163 12:36:25 INFO - 2015-11-23 12:36:25,796 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;88;93;73;74;72;98;91;72 12:36:25 INFO - 2015-11-23 12:36:25,796 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;125;90;91;91;128;91;91;128 12:36:25 INFO - 2015-11-23 12:36:25,797 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;109;110;110;110;109;110;111 12:36:25 INFO - 2015-11-23 12:36:25,797 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;146;147;146;148;146;147;146;149 12:36:25 INFO - 2015-11-23 12:36:25,797 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;95 12:36:25 INFO - 2015-11-23 12:36:25,797 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;70;71;69;68;69;70;70;66;67 12:36:25 INFO - 2015-11-23 12:36:25,797 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;68;68;69;69;69;70;69;68 12:36:25 INFO - 2015-11-23 12:36:25,797 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;84;83;82;83;83;90;82;84 12:36:25 INFO - 2015-11-23 12:36:25,797 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;132;126;119;123;127;128;128;135;127 12:36:25 INFO - 2015-11-23 12:36:25,798 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;135;150;149;145;142;147;138;139;140 12:36:25 INFO - 2015-11-23 12:36:25,798 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;68;69;68;71;68;69;68;68 12:36:25 INFO - 2015-11-23 12:36:25,798 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:36:25 INFO - 2015-11-23 12:36:25,798 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:36:25 INFO - 2015-11-23 12:36:25,798 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,980 12:36:25 INFO - 2015-11-23 12:36:25,798 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:36:25 INFO - 2015-11-23 12:36:25,798 DEBUG : BROWSER_OUTPUT: __startTimestamp1448310985794__endTimestamp 12:36:25 INFO - 2015-11-23 12:36:25,798 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,806 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:36:25 INFO - 2015-11-23 12:36:25,806 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:36:25 INFO - 2015-11-23 12:36:25,806 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,806 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.20 Median:113.00 stddev:4.69 (4.1%) stddev-sans-first:4.95 12:36:25 INFO - 2015-11-23 12:36:25,806 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 106.0 113.0 113.0 112.0 101.0 112.0 118.0 114.0 12:36:25 INFO - 2015-11-23 12:36:25,806 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,807 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.40 Median:151.00 stddev:14.72 (9.7%) stddev-sans-first:15.56 12:36:25 INFO - 2015-11-23 12:36:25,807 DEBUG : BROWSER_OUTPUT: Values: 152.0 130.0 159.0 163.0 136.0 150.0 149.0 140.0 175.0 130.0 12:36:25 INFO - 2015-11-23 12:36:25,807 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,807 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 12:36:25 INFO - 2015-11-23 12:36:25,807 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 161.0 161.0 160.0 160.0 162.0 160.0 161.0 163.0 12:36:25 INFO - 2015-11-23 12:36:25,807 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,807 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.70 Median:81.00 stddev:10.46 (12.9%) stddev-sans-first:10.71 12:36:25 INFO - 2015-11-23 12:36:25,808 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 88.0 93.0 73.0 74.0 72.0 98.0 91.0 72.0 12:36:25 INFO - 2015-11-23 12:36:25,808 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,808 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:101.90 Median:91.00 stddev:17.35 (19.1%) stddev-sans-first:18.03 12:36:25 INFO - 2015-11-23 12:36:25,808 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 125.0 90.0 91.0 91.0 128.0 91.0 91.0 128.0 12:36:25 INFO - 2015-11-23 12:36:25,808 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,808 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 12:36:25 INFO - 2015-11-23 12:36:25,808 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 110.0 111.0 12:36:25 INFO - 2015-11-23 12:36:25,808 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,808 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:1.10 (0.7%) stddev-sans-first:1.12 12:36:25 INFO - 2015-11-23 12:36:25,808 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 146.0 147.0 146.0 148.0 146.0 147.0 146.0 149.0 12:36:25 INFO - 2015-11-23 12:36:25,808 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,808 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:36:25 INFO - 2015-11-23 12:36:25,808 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 12:36:25 INFO - 2015-11-23 12:36:25,808 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,808 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:68.90 Median:69.50 stddev:1.52 (2.2%) stddev-sans-first:1.62 12:36:25 INFO - 2015-11-23 12:36:25,808 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 71.0 69.0 68.0 69.0 70.0 70.0 66.0 67.0 12:36:25 INFO - 2015-11-23 12:36:25,809 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,809 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 12:36:25 INFO - 2015-11-23 12:36:25,809 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 68.0 69.0 69.0 69.0 70.0 69.0 68.0 12:36:25 INFO - 2015-11-23 12:36:25,809 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,809 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.00 stddev:2.42 (2.9%) stddev-sans-first:2.50 12:36:25 INFO - 2015-11-23 12:36:25,809 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 84.0 83.0 82.0 83.0 83.0 90.0 82.0 84.0 12:36:25 INFO - 2015-11-23 12:36:25,809 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,809 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:127.50 stddev:4.42 (3.5%) stddev-sans-first:4.63 12:36:25 INFO - 2015-11-23 12:36:25,809 DEBUG : BROWSER_OUTPUT: Values: 125.0 132.0 126.0 119.0 123.0 127.0 128.0 128.0 135.0 127.0 12:36:25 INFO - 2015-11-23 12:36:25,809 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,809 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.00 Median:143.50 stddev:5.52 (3.8%) stddev-sans-first:5.24 12:36:25 INFO - 2015-11-23 12:36:25,809 DEBUG : BROWSER_OUTPUT: Values: 135.0 135.0 150.0 149.0 145.0 142.0 147.0 138.0 139.0 140.0 12:36:25 INFO - 2015-11-23 12:36:25,809 DEBUG : BROWSER_OUTPUT: 12:36:25 INFO - 2015-11-23 12:36:25,809 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:0.97 (1.4%) stddev-sans-first:1.00 12:36:25 INFO - 2015-11-23 12:36:25,809 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 68.0 71.0 68.0 69.0 68.0 68.0 12:36:25 INFO - 2015-11-23 12:36:25,810 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:36:25 INFO - 2015-11-23 12:36:25,810 DEBUG : BROWSER_OUTPUT: 12:36:26 INFO - 2015-11-23 12:36:26,710 INFO : Browser exited with error code: 0 12:36:26 INFO - 2015-11-23 12:36:26,758 INFO : Completed test kraken (00:01:00) 12:36:26 INFO - 2015-11-23 12:36:26,758 INFO : Starting test v8_7 12:36:26 INFO - 2015-11-23 12:36:26,758 DEBUG : operating with platform_type : linux_ 12:36:26 INFO - 2015-11-23 12:36:26,758 INFO : Initialising browser for v8_7 test... 12:36:26 INFO - 2015-11-23 12:36:26,764 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvmMuZw/profile http://localhost:32860/getInfo.html 12:36:31 INFO - 2015-11-23 12:36:31,033 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:36:31 INFO - 2015-11-23 12:36:31,033 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:36:31 INFO - 2015-11-23 12:36:31,033 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:36:31 INFO - 2015-11-23 12:36:31,033 DEBUG : BROWSER_OUTPUT: __metrics 12:36:31 INFO - 2015-11-23 12:36:31,190 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:36:32 INFO - 2015-11-23 12:36:32,485 INFO : Browser initialized. 12:36:32 INFO - 2015-11-23 12:36:32,486 INFO : Running cycle 1/1 for v8_7 test... 12:36:32 INFO - 2015-11-23 12:36:32,486 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvmMuZw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:36:44 INFO - 2015-11-23 12:36:44,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 139853824 12:36:44 INFO - 2015-11-23 12:36:44,424 DEBUG : BROWSER_OUTPUT: 12:37:05 INFO - 2015-11-23 12:37:05,862 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32860/tests/v8_7/run.html (next: http://localhost:32860/tests/v8_7/run.html) 12:37:06 INFO - 2015-11-23 12:37:06,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 450494464 12:37:06 INFO - 2015-11-23 12:37:06,120 DEBUG : BROWSER_OUTPUT: 12:37:06 INFO - 2015-11-23 12:37:06,120 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:37:06 INFO - 2015-11-23 12:37:06,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:37:06 INFO - 2015-11-23 12:37:06,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:37:06 INFO - 2015-11-23 12:37:06,120 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:37:06 INFO - 2015-11-23 12:37:06,120 DEBUG : BROWSER_OUTPUT: |0;Richards;162.78691193228065 12:37:06 INFO - 2015-11-23 12:37:06,120 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.49751053236307 12:37:06 INFO - 2015-11-23 12:37:06,121 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.662363177098 12:37:06 INFO - 2015-11-23 12:37:06,121 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5055.555555555556 12:37:06 INFO - 2015-11-23 12:37:06,121 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1982.1782178217823 12:37:06 INFO - 2015-11-23 12:37:06,121 DEBUG : BROWSER_OUTPUT: |5;Earley;796.8127490039841 12:37:06 INFO - 2015-11-23 12:37:06,121 DEBUG : BROWSER_OUTPUT: |6;Boyer;12060.240963855422 12:37:06 INFO - 2015-11-23 12:37:06,121 DEBUG : BROWSER_OUTPUT: |7;RegExp;25974.358974358973 12:37:06 INFO - 2015-11-23 12:37:06,121 DEBUG : BROWSER_OUTPUT: |8;Splay;611.6207951070336 12:37:06 INFO - 2015-11-23 12:37:06,122 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 12:37:06 INFO - 2015-11-23 12:37:06,122 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:37:06 INFO - 2015-11-23 12:37:06,122 DEBUG : BROWSER_OUTPUT: __startTimestamp1448311026113__endTimestamp 12:37:06 INFO - 2015-11-23 12:37:06,122 DEBUG : BROWSER_OUTPUT: 12:37:06 INFO - 2015-11-23 12:37:06,122 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:37:06 INFO - 2015-11-23 12:37:06,122 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:37:06 INFO - 2015-11-23 12:37:06,122 DEBUG : BROWSER_OUTPUT: 12:37:06 INFO - 2015-11-23 12:37:06,122 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.79 Median:162.79 stddev:0.00 (0.0%) 12:37:06 INFO - 2015-11-23 12:37:06,123 DEBUG : BROWSER_OUTPUT: Values: 162.8 12:37:06 INFO - 2015-11-23 12:37:06,123 DEBUG : BROWSER_OUTPUT: 12:37:06 INFO - 2015-11-23 12:37:06,123 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.50 Median:191.50 stddev:0.00 (0.0%) 12:37:06 INFO - 2015-11-23 12:37:06,123 DEBUG : BROWSER_OUTPUT: Values: 191.5 12:37:06 INFO - 2015-11-23 12:37:06,123 DEBUG : BROWSER_OUTPUT: 12:37:06 INFO - 2015-11-23 12:37:06,123 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.66 Median:280.66 stddev:0.00 (0.0%) 12:37:06 INFO - 2015-11-23 12:37:06,123 DEBUG : BROWSER_OUTPUT: Values: 280.7 12:37:06 INFO - 2015-11-23 12:37:06,124 DEBUG : BROWSER_OUTPUT: 12:37:06 INFO - 2015-11-23 12:37:06,124 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5055.56 Median:5055.56 stddev:0.00 (0.0%) 12:37:06 INFO - 2015-11-23 12:37:06,124 DEBUG : BROWSER_OUTPUT: Values: 5055.6 12:37:06 INFO - 2015-11-23 12:37:06,124 DEBUG : BROWSER_OUTPUT: 12:37:06 INFO - 2015-11-23 12:37:06,124 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1982.18 Median:1982.18 stddev:0.00 (0.0%) 12:37:06 INFO - 2015-11-23 12:37:06,124 DEBUG : BROWSER_OUTPUT: Values: 1982.2 12:37:06 INFO - 2015-11-23 12:37:06,124 DEBUG : BROWSER_OUTPUT: 12:37:06 INFO - 2015-11-23 12:37:06,124 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.81 Median:796.81 stddev:0.00 (0.0%) 12:37:06 INFO - 2015-11-23 12:37:06,125 DEBUG : BROWSER_OUTPUT: Values: 796.8 12:37:06 INFO - 2015-11-23 12:37:06,125 DEBUG : BROWSER_OUTPUT: 12:37:06 INFO - 2015-11-23 12:37:06,125 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12060.24 Median:12060.24 stddev:0.00 (0.0%) 12:37:06 INFO - 2015-11-23 12:37:06,125 DEBUG : BROWSER_OUTPUT: Values: 12060.2 12:37:06 INFO - 2015-11-23 12:37:06,125 DEBUG : BROWSER_OUTPUT: 12:37:06 INFO - 2015-11-23 12:37:06,125 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25974.36 Median:25974.36 stddev:0.00 (0.0%) 12:37:06 INFO - 2015-11-23 12:37:06,125 DEBUG : BROWSER_OUTPUT: Values: 25974.4 12:37:06 INFO - 2015-11-23 12:37:06,125 DEBUG : BROWSER_OUTPUT: 12:37:06 INFO - 2015-11-23 12:37:06,125 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:611.62 Median:611.62 stddev:0.00 (0.0%) 12:37:06 INFO - 2015-11-23 12:37:06,125 DEBUG : BROWSER_OUTPUT: Values: 611.6 12:37:06 INFO - 2015-11-23 12:37:06,125 DEBUG : BROWSER_OUTPUT: 12:37:06 INFO - 2015-11-23 12:37:06,126 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 12:37:06 INFO - 2015-11-23 12:37:06,126 DEBUG : BROWSER_OUTPUT: Values: 4822.1 12:37:06 INFO - 2015-11-23 12:37:06,126 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:37:06 INFO - 2015-11-23 12:37:06,126 DEBUG : BROWSER_OUTPUT: 12:37:07 INFO - 2015-11-23 12:37:07,017 INFO : Browser exited with error code: 0 12:37:07 INFO - 2015-11-23 12:37:07,032 INFO : Completed test v8_7 (00:00:40) 12:37:07 INFO - 2015-11-23 12:37:07,128 INFO : Completed test suite (00:20:19) 12:37:07 INFO - 2015-11-23 12:37:07,128 DEBUG : Working with test: dromaeo_css 12:37:07 INFO - 2015-11-23 12:37:07,128 DEBUG : Generating results file: dromaeo_css 12:37:07 INFO - 2015-11-23 12:37:07,129 DEBUG : Working with test: kraken 12:37:07 INFO - 2015-11-23 12:37:07,129 DEBUG : Generating results file: kraken 12:37:07 INFO - 2015-11-23 12:37:07,130 INFO : javascript benchmark 12:37:07 INFO - 2015-11-23 12:37:07,130 DEBUG : Working with test: v8_7 12:37:07 INFO - 2015-11-23 12:37:07,130 DEBUG : Generating results file: v8_7 12:37:07 INFO - 2015-11-23 12:37:07,130 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:07 INFO - 2015-11-23 12:37:07,189 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:37:07 INFO - 2015-11-23 12:37:07,189 DEBUG : process_Request line: dromaeo_css 6375.50 graph.html#tests=[[72,132,35]] 12:37:07 INFO - 2015-11-23 12:37:07,190 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:07 INFO - 2015-11-23 12:37:07,225 DEBUG : process_Request line: kraken 1513.70 graph.html#tests=[[232,132,35]] 12:37:07 INFO - 2015-11-23 12:37:07,225 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:07 INFO - 2015-11-23 12:37:07,254 DEBUG : process_Request line: v8_7 19878.68 graph.html#tests=[[230,132,35]] 12:37:07 INFO - 2015-11-23 12:37:07,255 INFO : javascript benchmark 12:37:07 INFO - 2015-11-23 12:37:07,259 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2634.4335967766933, 2667.1865081150268, 2680.289723223345, 2693.892244310228, 2699.7165297643746, 4552.544745525446, 4640.048789998046, 4642.094791515656, 4684.484706682267, 4723.929141062887, 4647.07058588282, 4687.929681054787, 4709.0346478971815, 4710.0, 4724.196886529289, 4302.935455968163, 4336.132773445308, 4393.7803109844535, 4433.445819272591, 4493.146302202587, 4211.726237794549, 4388.561143885618, 4423.225935461298, 4469.190573312894, 4508.977455112737, 4263.104748002923, 4273.572642735733, 4332.241857674894, 4350.216960947028, 4355.695101342907, 4317.330813723846, 4345.326474396474, 4365.279728844736, 4375.037491751809, 4412.779361031936, 4138.482689663792, 4222.092250166229, 4325.416068830699, 4353.0423306872435, 4401.295792673157, 4555.681102322838, 4617.3304870793545, 4636.211843986531, 4645.349651048856, 4674.182018146811, 5081.5426611605135, 5085.389753229636, 5095.923561146586, 5097.7196254206, 5116.104681680691, 4866.537678920497, 4989.326440930464, 4992.600591952635, 5095.210242412432, 5102.36220472441, 4685.88285292867, 4742.312364707167, 4756.096341695067, 4767.141914455431, 4805.9759701201965, 5142.9742851286255, 5145.202493613496, 5149.588032957355, 5149.665271757399, 5183.196604526304, 4700.318453824245, 4817.156997525419, 4817.879553011133, 4944.035912996931, 4953.8018479261145, 5045.621578381636, 5131.076406246837, 5132.743362831843, 5139.743012849342, 5159.303494028333, 5083.74581270935, 5098.821541246039, 5100.515451032146, 5100.872478188075, 5146.433892271847, 4787.688800228044, 4907.484714105039, 4907.509249075135, 5062.265971434195, 5065.240213967861, 4140.523839758466, 4189.350650649154, 4198.223328684203, 4200.033992181815, 4236.2586547354085, 3696.1129328960856, 3708.1841994761107, 3719.0702324418894, 3736.3648179809497, 3744.251149770057, 4174.373843923436, 4245.3631955206965, 4363.170997510463, 4370.584794444522, 4405.559444055569, 4981.726005069683, 4994.4755800640405, 5036.269740887551, 5077.822276220389, 5121.308623335802, 4393.582609652078, 4434.445694288214, 4434.933475997863, 4436.600705936481, 4473.105378924228, 4279.893002674958, 4378.562143785596, 4547.3179023146795, 4558.49856515783, 4592.563706447882, 4666.0, 4696.671233013724, 4725.929111063406, 4746.074515469589, 4769.4753577107185, 5033.094043072282, 5160.845174644766, 5165.431802501646, 5167.509086636764, 5214.217867319932, 4612.74629895359, 4722.5513576210205, 4852.199387101089, 4877.463479017234, 4924.778384972613, 4850.029994001285, 4890.828820991248, 4949.82675606352, 4972.825951091694, 5016.698998060128, 5053.11570475158, 5092.643514954066, 5097.0, 5100.311457953278, 5151.098557752303, 4707.411573553306, 4807.038592281628, 4905.313256144214, 4915.508449155056, 4920.606351491943, 4796.136695394863, 4798.760061996816, 4860.1251774680895, 4877.853664390074, 4914.729689867092, 4848.12733707936, 4858.90282194347, 4875.902481950412, 4879.756012199305, 4923.0, 4664.720116793003, 4746.501617330131, 4994.9500504994485, 5004.599632029356, 5049.166887463527, 4724.71651700899, 4747.596454301285, 4794.328793968777, 4811.591014763644, 4852.902941941212], "unit": "ms", "name": "dojo.html", "value": 4622.960626313627}, {"lowerIsBetter": false, "replicates": [562.0866092599525, 570.8287513745876, 578.3522454850568, 584.906414973604, 585.8213244960286, 28405.431891362186, 28986.275343116406, 29016.709832901666, 29022.70977290232, 29055.854720726365, 29666.555001674937, 30203.0, 30213.072300600892, 38468.61531384692, 38561.614383856155, 7866.252705992936, 7998.0, 8004.279614834663, 8006.319462845665, 8007.1992800720045, 7736.961315193416, 7830.177831327714, 7832.686692532292, 7833.020872390951, 7836.451448398614, 7085.43316534676, 7231.385332246766, 7897.960510197441, 10143.442110683945, 10450.372977621368, 10107.494625268708, 10226.130778883804, 10231.283810133295, 10237.850051489197, 10291.279610427273, 7083.18543367509, 9846.359986600919, 9958.651447199314, 9961.302708810386, 9969.850452243221, 26937.191884243308, 40237.19525609501, 40808.18383632311, 40876.59123408757, 40900.59099409027, 2857.7285157909964, 2957.7190166934106, 2995.1463832807544, 3459.5329630499814, 3526.9647303526895, 27071.1878643641, 27149.321266968287, 27347.726522734716, 27564.310892227655, 27939.301517462023, 3331.566896303489, 3351.074708314818, 3457.4640930655787, 3514.121469632592, 3539.7345199109914, 202855.0, 203590.0, 203595.0, 203747.0, 204319.0, 53924.46075539273, 54056.72971635117, 54114.729426353406, 54138.45861541413, 54173.0, 57545.0, 57668.71165644145, 57706.0, 57760.0, 57797.71101144468, 13723.725525489433, 14131.081479703786, 14132.293385330693, 14208.715825683428, 14221.0, 10161.54273057714, 10217.386956782468, 10258.794824103476, 10265.178785697126, 10269.640562580274, 18720.61407383406, 19440.513987150152, 19443.513912152026, 19457.708134377997, 19494.902525487283, 7625.0, 7877.779880289643, 7923.603819808986, 7931.56376399292, 8010.319122874621, 833.7040350675422, 890.5725251879135, 903.7243640689653, 924.7595625137378, 961.7211008807368, 25942.740572594408, 26514.0, 26903.461930761274, 27609.585856212172, 27635.0, 946.2193690205607, 998.5107297424355, 998.6953979036464, 999.2505620784411, 1001.2590682894605, 12885.291308978096, 12891.226526408445, 12957.416916238792, 13243.536476223286, 13244.139130956457, 288356.0, 292220.0, 292303.0, 292551.0, 292700.0, 46884.531154688695, 47028.29457558139, 47064.0, 47129.0, 47192.7640361796, 1084.0785332467497, 1112.1714322829544, 1115.1691989467736, 1116.3302018788825, 1237.6348977051612, 23781.503385959186, 25789.871050644626, 26708.599371009062, 26864.59703104416, 26981.460370792865, 38009.61990380061, 38078.428823568225, 38371.424428633036, 38411.80794096012, 38478.80760596179, 229489.0, 234372.0, 357544.0, 367868.0, 369814.0, 28620.14139575816, 28660.42679146447, 28687.0, 28746.281342966595, 29104.854475728334, 38315.808420957714, 40156.598434015286, 40418.79790601146, 40654.59345406508, 40805.1838963225, 33164.170895726835, 33563.83218083894, 34340.14149646279, 34830.82584587162, 34852.825735871156, 33795.76666183783, 34687.13282167966, 34863.65136348604, 34925.47611785775, 35036.474452882714, 33634.34980442233, 34131.65868341384, 34503.4824477628, 34567.827160864035, 34779.478307825906, 28248.29379265535, 29270.853645731637, 30043.0, 31054.0, 31139.221519462193, 23029.769702303434, 23524.109513055246, 23716.169934052916, 25135.74864251407, 25635.230943071736], "unit": "ms", "name": "ext.html", "value": 17073.700218273098}, {"lowerIsBetter": false, "replicates": [340.4620699295114, 341.20499236778306, 342.1395191094398, 345.0178723235014, 345.4541823918209, 12085.637430877066, 12490.313032783193, 15072.095674259539, 15138.924305378472, 15912.68174636508, 12468.0, 14282.714345713079, 14426.639334016654, 14610.926945365258, 14785.852141478583, 4910.484399138101, 4920.557149856512, 5058.190689489682, 5059.898802023958, 5062.620303477235, 3590.2460483298537, 3682.8895133146048, 5054.039732450822, 5105.821296254632, 5582.358028826676, 5891.11633255013, 5913.0, 5936.584439089265, 5942.108683697436, 5943.702814859262, 5726.885462290752, 5852.326982397015, 5854.034084376073, 5854.151148083504, 5857.209276747627, 5123.846284611468, 5124.333836601218, 5124.92312615311, 5136.974315128437, 5143.048536020848, 19419.611607767765, 20457.67025143376, 20597.897010515, 20690.48273793152, 20847.0, 1765.8852174608737, 1834.6881030224895, 1965.6756635155182, 2036.1244664794133, 2069.9793002070087, 12815.935920320338, 12930.54743083997, 12961.0, 13143.27711975841, 13148.934255328757, 1691.8392752688476, 1807.566184115816, 1811.0763510609552, 1819.818018198183, 1822.2437688359314, 46728.299075513896, 47557.28664070007, 53241.2013819793, 54445.455545444434, 55883.72058139724, 14232.573022809333, 14656.926715366568, 14667.266636668124, 14724.411023558938, 14727.926360368343, 22899.0, 23008.424789380064, 23046.7695323048, 23077.653835192486, 23179.768202318097, 8281.917180828235, 8357.665693372319, 8502.0, 8537.103604121601, 8592.957035214784, 7151.463640227003, 7168.677409516585, 7170.892436613455, 7212.71149154028, 7224.060872086595, 7581.431392645573, 7592.620368981528, 7594.240575942362, 7620.542767433972, 7626.389888808882, 1702.446704820938, 1705.4286813917229, 1731.7835270591177, 2148.78512148787, 2902.1003488918504, 823.0658202939707, 825.4964471672275, 838.2120806441925, 842.877782721502, 897.5422534507318, 12498.0, 14188.85811141896, 14485.275736213147, 15376.308066137051, 15704.685906281811, 798.2097723254053, 831.1397703376975, 849.562475325208, 856.0668870930715, 906.619219927632, 8443.324534037261, 8774.868376974351, 8785.0, 8856.557172141496, 8967.372283940193, 492935.0, 493339.0, 494068.0, 514355.0, 524686.0, 67344.32655673381, 72168.63915680493, 74028.0, 74958.0, 75853.0, 1063.1919740997052, 1065.046783129095, 1077.208251934843, 1100.9394483303495, 1110.4947249001684, 13510.324483775968, 14130.717385652435, 14240.71518569602, 14300.713985720435, 14304.213268270345, 27167.45665086727, 28138.0, 28700.569491458064, 29383.853080734458, 29930.959320491456, 33087.338253235284, 33892.15269618279, 34351.31297374088, 35036.12409689778, 36625.70368666833, 8416.242538171595, 8701.651933922825, 8863.0, 8869.556522173994, 8907.688230912147, 13830.515931942333, 16170.0, 16368.345266189219, 16411.717656468514, 16478.505644830675, 13875.653108672364, 13985.790213146607, 14015.859841401863, 14138.575842724735, 14143.64640883986, 13155.276459794803, 13509.797353039909, 13645.658858528615, 13710.657233568842, 13872.375743091787, 10086.0, 13670.17978921268, 13909.513167039106, 14073.718525629634, 14101.365438555495, 9016.729498115066, 9160.587773550073, 9175.587098580447, 9204.355695101278, 9212.355135140477, 13752.587422377344, 13782.724345513234, 13930.58208253754, 14300.928495357457, 14368.640783980067], "unit": "ms", "name": "jquery.html", "value": 8787.224355368666}, {"lowerIsBetter": false, "replicates": [1400.4818217259615, 1590.9124998125103, 1622.9026258424497, 1649.4886585158602, 1670.415354625881, 5863.384344643815, 6657.30098339674, 6821.0, 6822.590644561317, 6829.556078854877, 6751.0, 6798.694058767355, 6851.657417129149, 6855.622940738257, 6883.174019117713, 1755.569885378084, 1803.9278428862895, 2083.2187929526426, 2104.5370018595886, 2115.2596591193114, 2047.7030830529563, 2103.8842863642494, 2105.652567326389, 2106.7577228618675, 2107.2624581396467, 1997.600479904025, 2010.628033813742, 2014.546726986431, 2063.4222417722985, 2070.33749200256, 2039.9796002040086, 2067.1937944201773, 2088.905999230023, 2095.287602215254, 2100.33839340608, 2073.2950796729183, 2097.0144032304793, 2098.244631932503, 2101.191041449038, 2103.3584756649216, 6881.380675739208, 6921.0, 6934.514583979124, 6952.096227490444, 6980.685869135901, 4021.235965166609, 4102.815373308208, 4106.178764247133, 4132.772697501636, 4142.91714165715, 2749.092799376201, 2910.825350478978, 2921.590977263185, 2938.4563855686765, 2942.955855662167, 773.8607050730923, 891.1801142948503, 900.9549522523913, 906.7415786500816, 942.4345392764286, 9084.818303633956, 9171.082891710843, 9175.541222938826, 9191.172794448465, 9196.264298856075, 3963.1875465530075, 3996.360582306817, 4024.6176613221696, 4038.7374820636564, 4040.3939409088284, 7757.72847950319, 7796.688132474637, 7799.805004874924, 7846.136924938252, 7850.0, 4259.190753756776, 4281.207976524353, 4281.593248641374, 4294.420253265832, 4294.82820687169, 3881.4760007399204, 3897.5322961244265, 3921.490206273166, 3923.0388554804254, 3925.0, 3415.0, 3417.4532074867902, 3437.1750779812664, 3452.879149229765, 3464.4976478410995, 1118.4519585403257, 1125.2123513540555, 1132.1565433751907, 1136.187625847523, 1145.7078444996473, 1125.4597793059377, 1129.0967226219157, 1141.0643272516456, 1141.4635121492886, 1160.0, 6501.2523559791225, 6550.639714815731, 6580.11168492257, 6585.275619681831, 6590.406863382223, 443.844654370974, 447.64859585226094, 450.4864454521848, 454.17567115684926, 454.2504866969461, 5052.141136006814, 5141.434442211354, 5141.562967147759, 5145.07388670043, 5145.253938178943, 7907.9604601976625, 7962.3630109591095, 8157.510549367057, 8222.218889205516, 8278.503289802631, 8081.797955051054, 8104.5137291762685, 8121.187881211949, 8199.95900020496, 8224.0, 6323.810285691437, 6369.0764839099, 6411.487081033506, 6436.13112229843, 6487.124238227779, 6071.453569178795, 6097.359777223328, 6104.755809767559, 6115.327313995368, 6120.510359171345, 7112.964435177791, 7305.561666300039, 7313.341799237881, 7373.594452305175, 7387.741429049957, 7297.416206703557, 7512.5492470451945, 7525.887111693439, 7540.359069479156, 7627.046619172604, 6066.817995460143, 6094.238220222473, 6110.327863934875, 6117.541184411098, 6117.602355846856, 6271.498280137669, 6463.57986730861, 6526.314736952551, 6543.051257567531, 6663.600183988976, 6291.276503202007, 6295.1186833842385, 6328.841778955563, 6438.066480360415, 6440.484761219185, 6095.939040609537, 6137.232845894263, 6198.318184999556, 6271.090691849748, 6336.239651241696, 6173.074038894202, 6316.0, 6337.65142917144, 6358.745650173942, 6373.840653983688, 5454.645448045864, 5479.753411096431, 5483.890322193613, 5491.643043202179, 5504.669719816824, 5147.510986456281, 5926.703664816828, 5947.762089516544, 5954.166416701752, 5963.612365196248], "unit": "ms", "name": "mootools.html", "value": 3939.0928162201517}, {"lowerIsBetter": false, "replicates": [312.69824619242434, 315.8562853901475, 321.0897106702498, 322.6434789557537, 323.9335936133092, 5241.8427447176555, 5304.2043693446, 5354.651947623402, 5401.513863752261, 5415.702136382497, 5136.563392111675, 5276.103062479378, 5313.282706834586, 5321.893562128756, 5325.0, 4220.53574106848, 4223.324268117102, 4226.661867050629, 4230.788460576974, 4240.787960601973, 4010.2981978153853, 4099.836006559734, 4126.834926602933, 4156.1687662467475, 4226.260404429228, 4167.520735115455, 4170.8540201092965, 4182.372644103379, 4183.811728472226, 4193.972476743203, 4179.937300940488, 4181.686373521983, 4185.66514678828, 4188.539260681323, 4195.181939521794, 3710.3135919854913, 3710.888673339777, 3715.64701353371, 3718.2377612589353, 3724.627537246281, 5004.099262132815, 5132.255822905695, 5134.537891589737, 5143.691378517264, 5143.7685304161405, 4835.226363781778, 4837.637177211688, 4841.661083724141, 4844.055409195208, 4844.612431005511, 5654.886902261932, 5666.121751128581, 5666.490015898589, 5670.8015219467125, 5672.14917762339, 3815.4849095372047, 3922.195949830278, 3929.292727309083, 4038.172174704179, 4058.5129784425762, 5924.170616113747, 5935.139404786325, 5943.524518038546, 5949.6430214187285, 5953.868764934648, 4171.436856024458, 4173.6661067114555, 4177.373393990925, 4183.937240941388, 4186.769727665008, 4241.97879010603, 4252.532221455637, 4254.064105896698, 4256.851010214689, 4261.147770445923, 4663.740789986752, 4789.521047895182, 4801.255805350176, 4804.327394164749, 4812.759362031955, 5642.4075472075665, 5646.548276137899, 5647.124695672177, 5651.943480565142, 5663.980483513007, 1477.6822983058694, 1495.2150121186464, 1496.2369191712305, 1498.7002599480147, 1498.9475368362055, 1024.3444195714749, 1030.5877648940334, 1032.9793404131876, 1050.6900464363032, 1053.2311412668794, 4972.055309491185, 4975.676581022222, 4976.178930476503, 4976.90046199074, 4984.401871775338, 5841.06542953134, 5871.3541510433815, 5873.735681894325, 5875.823725288248, 5880.617759845596, 4939.135651261086, 4963.0, 4982.850514484571, 4989.077020751172, 4989.775460104304, 3106.0681795461273, 3150.401423729484, 3168.1287645897564, 3181.316017056298, 3182.0612919188893, 5551.944480555224, 5562.332520097614, 5567.944320556742, 5568.582356323211, 5568.638038527482, 6041.486473649701, 6048.969755151196, 6051.515878729691, 6054.545909056838, 6055.333913269536, 5535.944640553543, 5543.6396634218645, 5560.666360018412, 5561.249231353877, 5562.833115006556, 5788.363280039276, 5948.732307046107, 5958.940410596012, 5970.432808883149, 5973.193618861572, 5520.171974203901, 5631.915521267266, 5705.087186050212, 5817.680027598522, 5824.184614153937, 5597.832065038056, 5611.5230205433, 5612.579056570692, 5614.157876318585, 5615.663060216237, 4045.8988525287104, 4075.3886916962692, 4077.26609210345, 4080.0615858352153, 4080.367543030835, 5916.911246331222, 5918.082697181943, 5928.79249226275, 5931.733072011856, 5934.050551911673, 5562.860928476821, 5706.657600543981, 5706.942930570641, 5708.743106560131, 5717.714114294352, 5687.3459552152035, 5704.600677952503, 5705.771769129188, 5707.4577915098, 5711.771529138954, 5589.329280486368, 5592.524635406036, 5594.272744543184, 5597.6641401516035, 5598.860028499157, 5606.915896261477, 5744.3394009687745, 5754.136879468113, 5755.338136114233, 5764.106563482667, 5613.607047506799, 5620.437956204347, 5622.2128901954575, 5622.24099746529, 5624.35319938196], "unit": "ms", "name": "prototype.html", "value": 4287.144774519246}, {"lowerIsBetter": false, "replicates": [666.9266380698123, 700.324187159391, 787.3150359187506, 804.1194891593707, 825.9132791056938, 10859.13126949844, 10965.61620343288, 10979.560817567297, 10992.505337259823, 10996.0, 11492.71268218295, 12346.506139754421, 12457.128001039931, 12476.93761531191, 12513.436895339708, 624.4099326136802, 633.9302676705581, 797.6530209358933, 811.4725428471511, 812.6830536090899, 793.8213901872061, 803.6704950970103, 809.5911564659839, 809.874469457235, 811.0875265326507, 831.8128421105264, 843.2115971566604, 843.8354520868434, 844.4131328726537, 844.7592436155696, 651.6871901487289, 661.6327937994387, 824.295227580416, 835.048045228437, 839.7061028639988, 617.6911544227886, 618.6257314324814, 618.9628622282678, 619.1053927075333, 619.1424876545972, 11272.323660580392, 11408.429578521042, 11417.31496110236, 11420.71448213793, 11427.314361138358, 10788.514516846682, 11288.548458061668, 11347.489362978686, 11388.0, 11479.713007174803, 9097.317701172373, 9470.668526601536, 9541.952290238505, 9581.952090239503, 9901.900980990169, 3092.845357732127, 3108.6425061118034, 3136.4197623439736, 3169.524571314298, 3188.1870123118456, 42744.0, 43299.0, 43323.350149747464, 43353.566464335585, 43398.349024764655, 8909.420887642282, 9125.45247285165, 9163.31275154366, 9235.07649235071, 9295.72112836616, 15392.384304627689, 15412.537623871302, 15423.228838558027, 15429.768553471707, 15451.304691288919, 5980.55145864062, 6112.205413296243, 6146.815595532141, 6184.783532576428, 6291.056341548804, 3587.515685382492, 3601.405768048295, 3641.5083963665097, 3648.5074514940675, 3713.034611001105, 2712.8372297662204, 2772.6672799264215, 2779.680336761258, 2780.3883145707914, 2783.053761721025, 490.31111288639516, 492.7831754028216, 496.87329730918384, 498.9052080104768, 499.2461383311226, 487.19369443570946, 561.9943800562024, 584.4126652713995, 596.2457491273542, 620.8758248350348, 7839.255270749384, 7942.569878140806, 7944.84078909971, 7945.404094692805, 8130.471519351223, 478.44022493682473, 583.2534356024296, 584.6316820403118, 591.9378465261171, 610.9122593357216, 3719.8326075326677, 3770.8868733938025, 3795.791231482295, 3802.296575133609, 3854.4411060396087, 49609.0, 50043.0, 50263.74868125636, 50331.49668503268, 50506.0, 42629.57370426318, 42649.0, 43287.783561082, 43439.782801086425, 45747.0, 40643.0, 40805.59194408077, 41994.58005419907, 42507.57492425036, 42810.143797123885, 8025.197480251928, 8132.512049277062, 8142.8778568322705, 8176.959115204386, 8213.835723285381, 31667.52498712475, 32256.838715806272, 32470.188245294055, 32563.18592035218, 32734.672653273163, 38055.0, 40579.1884162321, 40581.39127913024, 40995.590044099175, 41606.37590436085, 9701.126898579161, 9701.902980970382, 10114.544845481823, 10283.794324113625, 10308.226882983956, 10968.0, 11285.830712539482, 11332.093432525213, 11557.42212889369, 11629.825552616549, 10524.579016839241, 10894.237403381687, 11124.61063862761, 11203.663890083311, 11488.080953523866, 10207.438590877277, 10357.378557286587, 10687.625933092304, 10774.407407592658, 10827.296225745302, 10313.22650801208, 10320.277580569287, 10399.376037437778, 10680.73298167521, 10808.89191108079, 9182.770430739285, 9328.160465558132, 9371.718848434557, 9385.38994965325, 9658.0, 8632.877725895594, 9438.669646562337, 9463.0, 9475.57359918819, 9501.762455938657], "unit": "ms", "name": "yui.html", "value": 5732.900171755202}], "name": "dromaeo_css", "value": 6375.500454458072}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 106.0, 113.0, 113.0, 112.0, 101.0, 112.0, 118.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [152.0, 130.0, 159.0, 163.0, 136.0, 150.0, 149.0, 140.0, 175.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 161.0, 160.0, 160.0, 162.0, 160.0, 161.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 88.0, 93.0, 73.0, 74.0, 72.0, 98.0, 91.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 125.0, 90.0, 91.0, 91.0, 128.0, 91.0, 91.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 101.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 146.0, 147.0, 146.0, 148.0, 146.0, 147.0, 146.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 71.0, 69.0, 68.0, 69.0, 70.0, 70.0, 66.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 68.9}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 84.0, 83.0, 82.0, 83.0, 83.0, 90.0, 82.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [125.0, 132.0, 126.0, 119.0, 123.0, 127.0, 128.0, 128.0, 135.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.0}, {"lowerIsBetter": true, "replicates": [135.0, 135.0, 150.0, 149.0, 145.0, 142.0, 147.0, 138.0, 139.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 68.0, 71.0, 68.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1513.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.78691193228065], "unit": "score", "name": "Richards", "value": 216.86018600000003}, {"lowerIsBetter": false, "replicates": [191.49751053236307], "unit": "score", "name": "DeltaBlue", "value": 345.26819599999993}, {"lowerIsBetter": false, "replicates": [280.662363177098], "unit": "score", "name": "Encrypt", "value": 948.4029029999999}, {"lowerIsBetter": false, "replicates": [5055.555555555556], "unit": "score", "name": "Decrypt", "value": 52.65118681318681}, {"lowerIsBetter": false, "replicates": [1982.1782178217823], "unit": "score", "name": "RayTrace", "value": 373.32112387612375}, {"lowerIsBetter": false, "replicates": [796.8127490039841], "unit": "score", "name": "Earley", "value": 836.4110649999999}, {"lowerIsBetter": false, "replicates": [12060.240963855422], "unit": "score", "name": "Boyer", "value": 55.2611678321678}, {"lowerIsBetter": false, "replicates": [25974.358974358973], "unit": "score", "name": "RegExp", "value": 35.072472852912156}, {"lowerIsBetter": false, "replicates": [611.6207951070336], "unit": "score", "name": "Splay", "value": 133.23778500000006}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19878.68062046471}]} 12:37:07 INFO - RETURN: dromaeo_css: 6375.50 12:37:07 INFO - RETURN: kraken: 1513.70 12:37:07 INFO - RETURN: v8_7: 19878.68 12:37:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19878.68"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1513.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6375.50"}}} 12:37:07 INFO - Return code: 0 12:37:07 INFO - # TBPL SUCCESS # 12:37:07 INFO - Running post-action listener: _resource_record_post_action 12:37:07 INFO - Running post-run listener: _resource_record_post_run 12:37:08 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 510566400; Read time: 0; Write time: 600940 12:37:08 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 232304640; Read time: 0; Write time: 328480 12:37:08 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 276000768; Read time: 0; Write time: 258928 12:37:08 INFO - Running post-run listener: _upload_blobber_files 12:37:08 INFO - Blob upload gear active. 12:37:08 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:37:08 INFO - Copying logs to upload dir... 12:37:08 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1263.805091 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-23 12:37:08.043812) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:37:08.047418) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010005 build_url: 'https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:37:08.098864) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:37:08.099329) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1448309761.899094-1052112203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:37:08.149263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:37:08.149593) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:37:08.149891) ========= ========= Total master_lag: 0.22 =========