builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0047 starttime: 1448034475.53 results: success (0) buildid: 20151120061737 builduid: 4c6d16abb3f54c3086197b408569d7a0 revision: 9d449237638a706f53fa985bc4e3be16e170f220 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:55.527336) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:55.527778) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:55.528059) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bT1SmsdbA8/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005596 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:55.562445) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:55.562755) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:55.583741) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:55.584183) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bT1SmsdbA8/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005360 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:55.632735) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:55.633062) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:55.633440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:55.633730) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bT1SmsdbA8/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-20 07:47:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to 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% 1.41G=0s 2015-11-20 07:47:55 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.211556 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:55.858878) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:55.859268) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bT1SmsdbA8/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025770 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:55.909779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 07:47:55.910181) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9d449237638a706f53fa985bc4e3be16e170f220 --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 9d449237638a706f53fa985bc4e3be16e170f220 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bT1SmsdbA8/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-20 07:47:55,992 truncating revision to first 12 chars 2015-11-20 07:47:55,992 Setting DEBUG logging. 2015-11-20 07:47:55,992 attempt 1/10 2015-11-20 07:47:55,992 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9d449237638a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 07:47:56,943 unpacking tar archive at: fx-team-9d449237638a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.191218 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 07:47:57.118350) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:57.118737) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:57.131966) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:57.132339) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 07:47:57.132748) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-20 07:47:57.133033) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bT1SmsdbA8/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:47:57 INFO - MultiFileLogger online at 20151120 07:47:57 in /builds/slave/test 07:47:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:47:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:47:57 INFO - {'append_to_log': False, 07:47:57 INFO - 'base_work_dir': '/builds/slave/test', 07:47:57 INFO - 'blob_upload_branch': 'Fx-Team', 07:47:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:47:57 INFO - 'branch': 'Fx-Team', 07:47:57 INFO - 'buildbot_json_path': 'buildprops.json', 07:47:57 INFO - 'config_files': ('talos/mac_config.py',), 07:47:57 INFO - 'default_actions': ('clobber', 07:47:57 INFO - 'read-buildbot-config', 07:47:57 INFO - 'download-and-extract', 07:47:57 INFO - 'populate-webroot', 07:47:57 INFO - 'create-virtualenv', 07:47:57 INFO - 'install', 07:47:57 INFO - 'run-tests'), 07:47:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:47:57 INFO - 'download_minidump_stackwalk': True, 07:47:57 INFO - 'download_symbols': 'ondemand', 07:47:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:47:57 INFO - 'tooltool.py': '/tools/tooltool.py', 07:47:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:47:57 INFO - '/tools/misc-python/virtualenv.py')}, 07:47:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:47:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:47:57 INFO - 'installer_path': 'installer.exe', 07:47:57 INFO - 'log_level': 'info', 07:47:57 INFO - 'log_name': 'talos', 07:47:57 INFO - 'log_to_console': True, 07:47:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:47:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:47:57 INFO - 'opt_config_files': (), 07:47:57 INFO - 'pip_index': False, 07:47:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:47:57 INFO - 'cmd': ('bash', 07:47:57 INFO - '-c', 07:47:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:47:57 INFO - 'enabled': True, 07:47:57 INFO - 'halt_on_failure': False, 07:47:57 INFO - 'name': 'check_screen_resolution'},), 07:47:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:47:57 INFO - 'cmd': ('bash', 07:47:57 INFO - '-c', 07:47:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:47:57 INFO - 'enabled': True, 07:47:57 INFO - 'halt_on_failure': False, 07:47:57 INFO - 'name': 'check_screen_resolution'},), 07:47:57 INFO - 'run_cmd_checks_enabled': True, 07:47:57 INFO - 'sps_profile': False, 07:47:57 INFO - 'sps_profile_interval': 0, 07:47:57 INFO - 'suite': 'dromaeojs', 07:47:57 INFO - 'system_bits': '64', 07:47:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:47:57 INFO - 'title': 't-yosemite-r7-0047', 07:47:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:47:57 INFO - 'use_talos_json': True, 07:47:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:47:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:47:57 INFO - 'work_dir': 'build'} 07:47:57 INFO - ##### 07:47:57 INFO - ##### Running clobber step. 07:47:57 INFO - ##### 07:47:57 INFO - Running pre-action listener: _resource_record_pre_action 07:47:57 INFO - Running main action method: clobber 07:47:57 INFO - rmtree: /builds/slave/test/build 07:47:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:47:58 INFO - Running post-action listener: _resource_record_post_action 07:47:58 INFO - ##### 07:47:58 INFO - ##### Running read-buildbot-config step. 07:47:58 INFO - ##### 07:47:58 INFO - Running pre-action listener: _resource_record_pre_action 07:47:58 INFO - Running main action method: read_buildbot_config 07:47:58 INFO - Using buildbot properties: 07:47:58 INFO - { 07:47:58 INFO - "properties": { 07:47:58 INFO - "buildnumber": 9, 07:47:58 INFO - "product": "firefox", 07:47:58 INFO - "script_repo_revision": "production", 07:47:58 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:47:58 INFO - "repository": "", 07:47:58 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:47:58 INFO - "buildid": "20151120061737", 07:47:58 INFO - "slavename": "t-yosemite-r7-0047", 07:47:58 INFO - "pgo_build": "False", 07:47:58 INFO - "basedir": "/builds/slave/test", 07:47:58 INFO - "project": "", 07:47:58 INFO - "platform": "yosemite_r7", 07:47:58 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:47:58 INFO - "slavebuilddir": "test", 07:47:58 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:47:58 INFO - "branch": "fx-team", 07:47:58 INFO - "repo_path": "integration/fx-team", 07:47:58 INFO - "stage_platform": "macosx64", 07:47:58 INFO - "builduid": "4c6d16abb3f54c3086197b408569d7a0", 07:47:58 INFO - "revision": "9d449237638a706f53fa985bc4e3be16e170f220" 07:47:58 INFO - }, 07:47:58 INFO - "sourcestamp": { 07:47:58 INFO - "repository": "", 07:47:58 INFO - "hasPatch": false, 07:47:58 INFO - "project": "", 07:47:58 INFO - "branch": "fx-team-macosx64-talos", 07:47:58 INFO - "changes": [ 07:47:58 INFO - { 07:47:58 INFO - "category": null, 07:47:58 INFO - "files": [ 07:47:58 INFO - { 07:47:58 INFO - "url": null, 07:47:58 INFO - "name": "https://queue.taskcluster.net/v1/task/wGDaAqqcRMC1cn6pZvjJHg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 07:47:58 INFO - } 07:47:58 INFO - ], 07:47:58 INFO - "repository": "", 07:47:58 INFO - "rev": "0947ebd84feca011e3bce7c8f39a6389a83fe1fe", 07:47:58 INFO - "who": "cbook@mozilla.com", 07:47:58 INFO - "when": 1448032090, 07:47:58 INFO - "number": 6688730, 07:47:58 INFO - "comments": "Merge mozilla-central to fx-team", 07:47:58 INFO - "project": "", 07:47:58 INFO - "at": "Fri 20 Nov 2015 07:08:10", 07:47:58 INFO - "branch": "fx-team-macosx64-talos", 07:47:58 INFO - "revlink": "", 07:47:58 INFO - "properties": [ 07:47:58 INFO - [ 07:47:58 INFO - "buildid", 07:47:58 INFO - "20151120053535", 07:47:58 INFO - "Change" 07:47:58 INFO - ], 07:47:58 INFO - [ 07:47:58 INFO - "builduid", 07:47:58 INFO - "b4f5d1fcb70e4a34b685f209dd85c121", 07:47:58 INFO - "Change" 07:47:58 INFO - ], 07:47:58 INFO - [ 07:47:58 INFO - "pgo_build", 07:47:58 INFO - "False", 07:47:58 INFO - "Change" 07:47:58 INFO - ] 07:47:58 INFO - ], 07:47:58 INFO - "revision": "0947ebd84feca011e3bce7c8f39a6389a83fe1fe" 07:47:58 INFO - }, 07:47:58 INFO - { 07:47:58 INFO - "category": null, 07:47:58 INFO - "files": [ 07:47:58 INFO - { 07:47:58 INFO - "url": null, 07:47:58 INFO - "name": "https://queue.taskcluster.net/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 07:47:58 INFO - } 07:47:58 INFO - ], 07:47:58 INFO - "repository": "", 07:47:58 INFO - "rev": "9d449237638a706f53fa985bc4e3be16e170f220", 07:47:58 INFO - "who": "gijskruitbosch@gmail.com", 07:47:58 INFO - "when": 1448034034, 07:47:58 INFO - "number": 6688960, 07:47:58 INFO - "comments": "Bug 1222971 - don't let mouseover/mouseout remove the selectedButton that was set, r=florian", 07:47:58 INFO - "project": "", 07:47:58 INFO - "at": "Fri 20 Nov 2015 07:40:34", 07:47:58 INFO - "branch": "fx-team-macosx64-talos", 07:47:58 INFO - "revlink": "", 07:47:58 INFO - "properties": [ 07:47:58 INFO - [ 07:47:58 INFO - "buildid", 07:47:58 INFO - "20151120061737", 07:47:58 INFO - "Change" 07:47:58 INFO - ], 07:47:58 INFO - [ 07:47:58 INFO - "builduid", 07:47:58 INFO - "4c6d16abb3f54c3086197b408569d7a0", 07:47:58 INFO - "Change" 07:47:58 INFO - ], 07:47:58 INFO - [ 07:47:58 INFO - "pgo_build", 07:47:58 INFO - "False", 07:47:58 INFO - "Change" 07:47:58 INFO - ] 07:47:58 INFO - ], 07:47:58 INFO - "revision": "9d449237638a706f53fa985bc4e3be16e170f220" 07:47:58 INFO - } 07:47:58 INFO - ], 07:47:58 INFO - "revision": "9d449237638a706f53fa985bc4e3be16e170f220" 07:47:58 INFO - } 07:47:58 INFO - } 07:47:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 07:47:58 INFO - Running post-action listener: _resource_record_post_action 07:47:58 INFO - ##### 07:47:58 INFO - ##### Running download-and-extract step. 07:47:58 INFO - ##### 07:47:58 INFO - Running pre-action listener: _resource_record_pre_action 07:47:58 INFO - Running main action method: download_and_extract 07:47:58 INFO - mkdir: /builds/slave/test/build/tests 07:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:58 INFO - https://queue.taskcluster.net/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:47:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/test_packages.json 07:47:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/test_packages.json 07:47:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:47:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:47:59 INFO - Downloaded 1149 bytes. 07:47:59 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:47:59 INFO - Using the following test package requirements: 07:47:59 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:47:59 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:47:59 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 07:47:59 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:47:59 INFO - u'jsshell-mac.zip'], 07:47:59 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:47:59 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 07:47:59 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:47:59 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:47:59 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 07:47:59 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:47:59 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 07:47:59 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:47:59 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 07:47:59 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 07:47:59 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 07:47:59 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 07:47:59 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:59 INFO - https://queue.taskcluster.net/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:47:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:47:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:47:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:47:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:48:00 INFO - Downloaded 17526047 bytes. 07:48:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 07:48:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:48:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:48:03 INFO - Return code: 0 07:48:03 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:03 INFO - https://queue.taskcluster.net/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:48:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:48:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:48:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:48:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:48:04 INFO - Downloaded 17526047 bytes. 07:48:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 07:48:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 07:48:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 07:48:07 INFO - Return code: 0 07:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:07 INFO - https://queue.taskcluster.net/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:48:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:48:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:48:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:48:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:48:08 INFO - Downloaded 11130997 bytes. 07:48:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 07:48:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 07:48:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 07:48:09 INFO - Return code: 0 07:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:09 INFO - https://queue.taskcluster.net/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:48:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:48:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:48:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 07:48:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 07:48:11 INFO - Downloaded 109411996 bytes. 07:48:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:48:11 INFO - mkdir: /builds/slave/test/properties 07:48:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:48:11 INFO - Writing to file /builds/slave/test/properties/build_url 07:48:11 INFO - Contents: 07:48:11 INFO - build_url:https://queue.taskcluster.net/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 07:48:11 INFO - Running post-action listener: _resource_record_post_action 07:48:11 INFO - Running post-action listener: set_extra_try_arguments 07:48:11 INFO - ##### 07:48:11 INFO - ##### Running populate-webroot step. 07:48:11 INFO - ##### 07:48:11 INFO - Running pre-action listener: _resource_record_pre_action 07:48:11 INFO - Running main action method: populate_webroot 07:48:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:48:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:48:11 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:48:11 INFO - '../fennec_ids.txt'], 07:48:11 INFO - 'tests': ['tcheck2']}, 07:48:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:48:11 INFO - '--tppagecycles', 07:48:11 INFO - '7'], 07:48:11 INFO - 'tests': ['tsvgm']}}, 07:48:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:48:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:48:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:48:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:48:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:48:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:48:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:48:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:11 INFO - 'talos_options': ['--e10s'], 07:48:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:48:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:11 INFO - 'tests': ['damp', 'tps']}, 07:48:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:11 INFO - 'talos_options': ['--e10s'], 07:48:11 INFO - 'tests': ['damp', 'tps']}, 07:48:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:48:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:48:11 INFO - 'other': {'tests': ['a11yr', 07:48:11 INFO - 'ts_paint', 07:48:11 INFO - 'tpaint', 07:48:11 INFO - 'sessionrestore', 07:48:11 INFO - 'sessionrestore_no_auto_restore']}, 07:48:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:48:11 INFO - 'tests': ['a11yr', 07:48:11 INFO - 'ts_paint', 07:48:11 INFO - 'tpaint', 07:48:11 INFO - 'sessionrestore', 07:48:11 INFO - 'sessionrestore_no_auto_restore']}, 07:48:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:48:11 INFO - 'tests': ['a11yr', 07:48:11 INFO - 'ts_paint', 07:48:11 INFO - 'tpaint', 07:48:11 INFO - 'sessionrestore', 07:48:11 INFO - 'sessionrestore_no_auto_restore']}, 07:48:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:48:11 INFO - 'tests': ['a11yr', 07:48:11 INFO - 'ts_paint', 07:48:11 INFO - 'tpaint', 07:48:11 INFO - 'sessionrestore', 07:48:11 INFO - 'sessionrestore_no_auto_restore']}, 07:48:11 INFO - 'other_l64': {'tests': ['a11yr', 07:48:11 INFO - 'ts_paint', 07:48:11 INFO - 'tpaint', 07:48:11 INFO - 'sessionrestore', 07:48:11 INFO - 'sessionrestore_no_auto_restore']}, 07:48:11 INFO - 'other_nol64': {'tests': ['a11yr', 07:48:11 INFO - 'ts_paint', 07:48:11 INFO - 'tpaint', 07:48:11 INFO - 'sessionrestore', 07:48:11 INFO - 'sessionrestore_no_auto_restore']}, 07:48:11 INFO - 'svgr': {'tests': ['tsvgx', 07:48:11 INFO - 'tsvgr_opacity', 07:48:11 INFO - 'tart', 07:48:11 INFO - 'tscrollx', 07:48:11 INFO - 'cart']}, 07:48:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:48:11 INFO - 'tests': ['tsvgx', 07:48:11 INFO - 'tsvgr_opacity', 07:48:11 INFO - 'tart', 07:48:11 INFO - 'tscrollx', 07:48:11 INFO - 'cart']}, 07:48:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:11 INFO - 'tests': ['tp5o']}, 07:48:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:11 INFO - 'talos_options': ['--e10s'], 07:48:11 INFO - 'tests': ['tp5o']}, 07:48:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:11 INFO - 'talos_options': ['--xperf_path', 07:48:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:48:11 INFO - 'tests': ['tp5n']}, 07:48:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:11 INFO - 'talos_options': ['--e10s', 07:48:11 INFO - '--xperf_path', 07:48:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:48:11 INFO - 'tests': ['tp5n']}}, 07:48:11 INFO - 'talos.zip': {'path': '', 07:48:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:48:11 INFO - Running post-action listener: _resource_record_post_action 07:48:11 INFO - ##### 07:48:11 INFO - ##### Running create-virtualenv step. 07:48:11 INFO - ##### 07:48:11 INFO - Running pre-action listener: _resource_record_pre_action 07:48:11 INFO - Running main action method: create_virtualenv 07:48:11 INFO - Creating virtualenv /builds/slave/test/build/venv 07:48:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:48:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:48:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:48:12 INFO - Using real prefix '/tools/python27' 07:48:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:48:12 INFO - Installing distribute.............................................................................................................................................................................................done. 07:48:15 INFO - Installing pip.................done. 07:48:15 INFO - Return code: 0 07:48:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:15 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 0x100e40490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc22c77f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d649f0>, '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 0x100ac3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d578c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bT1SmsdbA8/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:48:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bT1SmsdbA8/Render', 07:48:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:15 INFO - 'HOME': '/Users/cltbld', 07:48:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:15 INFO - 'LOGNAME': 'cltbld', 07:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:15 INFO - 'MOZ_NO_REMOTE': '1', 07:48:15 INFO - 'NO_EM_RESTART': '1', 07:48:15 INFO - 'PAGER': '/bin/cat', 07:48:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:15 INFO - 'PWD': '/builds/slave/test', 07:48:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:15 INFO - 'SHELL': '/bin/bash', 07:48:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners', 07:48:15 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 07:48:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:15 INFO - 'USER': 'cltbld', 07:48:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:15 INFO - 'XPC_FLAGS': '0x0', 07:48:15 INFO - 'XPC_SERVICE_NAME': '0', 07:48:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:48:15 INFO - Cleaning up... 07:48:15 INFO - Return code: 0 07:48:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:15 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 0x100e40490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc22c77f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d649f0>, '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 0x100ac3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d578c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bT1SmsdbA8/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:48:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bT1SmsdbA8/Render', 07:48:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:15 INFO - 'HOME': '/Users/cltbld', 07:48:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:15 INFO - 'LOGNAME': 'cltbld', 07:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:15 INFO - 'MOZ_NO_REMOTE': '1', 07:48:15 INFO - 'NO_EM_RESTART': '1', 07:48:15 INFO - 'PAGER': '/bin/cat', 07:48:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:15 INFO - 'PWD': '/builds/slave/test', 07:48:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:15 INFO - 'SHELL': '/bin/bash', 07:48:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners', 07:48:15 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 07:48:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:15 INFO - 'USER': 'cltbld', 07:48:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:15 INFO - 'XPC_FLAGS': '0x0', 07:48:15 INFO - 'XPC_SERVICE_NAME': '0', 07:48:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:16 INFO - Downloading/unpacking psutil>=0.7.1 07:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:18 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:48:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:48:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:48:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:48:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:48:18 INFO - Installing collected packages: psutil 07:48:18 INFO - Running setup.py install for psutil 07:48:18 INFO - building 'psutil._psutil_osx' extension 07:48:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:48:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:48:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:48:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:48:19 INFO - building 'psutil._psutil_posix' extension 07:48:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:48:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:48:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:48:19 INFO - ^ 07:48:19 INFO - 1 warning generated. 07:48:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:48:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:48:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:48:20 INFO - Successfully installed psutil 07:48:20 INFO - Cleaning up... 07:48:20 INFO - Return code: 0 07:48:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48: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 0x100e40490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc22c77f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d649f0>, '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 0x100ac3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d578c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bT1SmsdbA8/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:48: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 07:48: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 07:48:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bT1SmsdbA8/Render', 07:48:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:20 INFO - 'HOME': '/Users/cltbld', 07:48:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:20 INFO - 'LOGNAME': 'cltbld', 07:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:20 INFO - 'MOZ_NO_REMOTE': '1', 07:48:20 INFO - 'NO_EM_RESTART': '1', 07:48:20 INFO - 'PAGER': '/bin/cat', 07:48:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:20 INFO - 'PWD': '/builds/slave/test', 07:48:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:20 INFO - 'SHELL': '/bin/bash', 07:48:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners', 07:48:20 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 07:48:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:20 INFO - 'USER': 'cltbld', 07:48:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:20 INFO - 'XPC_FLAGS': '0x0', 07:48:20 INFO - 'XPC_SERVICE_NAME': '0', 07:48:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:48: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 07:48: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 07:48: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 07:48: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 07:48: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 07:48: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 07:48:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:48:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:48:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:48: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) 07:48:22 INFO - Installing collected packages: mozsystemmonitor 07:48:22 INFO - Running setup.py install for mozsystemmonitor 07:48:22 INFO - Successfully installed mozsystemmonitor 07:48:22 INFO - Cleaning up... 07:48:22 INFO - Return code: 0 07:48:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:48: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')]} 07:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48: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')]} 07:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48: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 0x100e40490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc22c77f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d649f0>, '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 0x100ac3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d578c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bT1SmsdbA8/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:48: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 07:48: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 07:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bT1SmsdbA8/Render', 07:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:22 INFO - 'HOME': '/Users/cltbld', 07:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:22 INFO - 'LOGNAME': 'cltbld', 07:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:22 INFO - 'MOZ_NO_REMOTE': '1', 07:48:22 INFO - 'NO_EM_RESTART': '1', 07:48:22 INFO - 'PAGER': '/bin/cat', 07:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:22 INFO - 'PWD': '/builds/slave/test', 07:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:22 INFO - 'SHELL': '/bin/bash', 07:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners', 07:48:22 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 07:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:22 INFO - 'USER': 'cltbld', 07:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:22 INFO - 'XPC_FLAGS': '0x0', 07:48:22 INFO - 'XPC_SERVICE_NAME': '0', 07:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:23 INFO - Downloading/unpacking blobuploader==1.2.4 07:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:25 INFO - Downloading blobuploader-1.2.4.tar.gz 07:48:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:48:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:48:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:26 INFO - Downloading docopt-0.6.1.tar.gz 07:48:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:48:26 INFO - Installing collected packages: blobuploader, requests, docopt 07:48:26 INFO - Running setup.py install for blobuploader 07:48:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:48:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:48:26 INFO - Running setup.py install for requests 07:48:26 INFO - Running setup.py install for docopt 07:48:27 INFO - Successfully installed blobuploader requests docopt 07:48:27 INFO - Cleaning up... 07:48:27 INFO - Return code: 0 07:48:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:27 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 0x100e40490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc22c77f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d649f0>, '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 0x100ac3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d578c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bT1SmsdbA8/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:48:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bT1SmsdbA8/Render', 07:48:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:27 INFO - 'HOME': '/Users/cltbld', 07:48:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:27 INFO - 'LOGNAME': 'cltbld', 07:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:27 INFO - 'MOZ_NO_REMOTE': '1', 07:48:27 INFO - 'NO_EM_RESTART': '1', 07:48:27 INFO - 'PAGER': '/bin/cat', 07:48:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:27 INFO - 'PWD': '/builds/slave/test', 07:48:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:27 INFO - 'SHELL': '/bin/bash', 07:48:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners', 07:48:27 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 07:48:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:27 INFO - 'USER': 'cltbld', 07:48:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:27 INFO - 'XPC_FLAGS': '0x0', 07:48:27 INFO - 'XPC_SERVICE_NAME': '0', 07:48:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:27 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-KL62AV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:27 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-LLuCPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:27 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-8ZbsvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:27 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-xOXBMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:27 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-rB_VdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:27 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-nd7VqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:28 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-2dtqXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:28 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-ZO7I9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:28 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-2GeFZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:28 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-uoxki0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:28 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-9lrsf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:28 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-bjI_6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:28 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-GGFmR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:28 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-t0FAPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:28 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-M3H6_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:28 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-5vyR6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:29 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-MQY4ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:48:29 INFO - Running setup.py install for manifestparser 07:48:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:48:29 INFO - Running setup.py install for mozcrash 07:48:29 INFO - Running setup.py install for mozdebug 07:48:29 INFO - Running setup.py install for mozdevice 07:48:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:48:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:48:29 INFO - Running setup.py install for mozfile 07:48:29 INFO - Running setup.py install for mozhttpd 07:48:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:48:30 INFO - Running setup.py install for mozinfo 07:48:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:48:30 INFO - Running setup.py install for mozInstall 07:48:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:48:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:48:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:48:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:48:30 INFO - Running setup.py install for mozleak 07:48:30 INFO - Running setup.py install for mozlog 07:48:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:48:30 INFO - Running setup.py install for moznetwork 07:48:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:48:30 INFO - Running setup.py install for mozprocess 07:48:30 INFO - Running setup.py install for mozprofile 07:48:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:48:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:48:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:48:31 INFO - Running setup.py install for mozrunner 07:48:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:48:31 INFO - Running setup.py install for mozscreenshot 07:48:31 INFO - Running setup.py install for moztest 07:48:31 INFO - Running setup.py install for mozversion 07:48:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:48:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:48:31 INFO - Cleaning up... 07:48:31 INFO - Return code: 0 07:48:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:31 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 0x100e40490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc22c77f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d649f0>, '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 0x100ac3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d578c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bT1SmsdbA8/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:48:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:48:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bT1SmsdbA8/Render', 07:48:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:31 INFO - 'HOME': '/Users/cltbld', 07:48:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:31 INFO - 'LOGNAME': 'cltbld', 07:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:31 INFO - 'MOZ_NO_REMOTE': '1', 07:48:31 INFO - 'NO_EM_RESTART': '1', 07:48:31 INFO - 'PAGER': '/bin/cat', 07:48:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:31 INFO - 'PWD': '/builds/slave/test', 07:48:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:31 INFO - 'SHELL': '/bin/bash', 07:48:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners', 07:48:31 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 07:48:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:31 INFO - 'USER': 'cltbld', 07:48:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:31 INFO - 'XPC_FLAGS': '0x0', 07:48:31 INFO - 'XPC_SERVICE_NAME': '0', 07:48:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:32 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-gHLTvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:32 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-86Srk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:32 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-h8zdmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:32 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-wdJ484-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:32 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-YxDSz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:32 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-w8mzzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:32 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-kwh8HM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:32 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-W_R7oE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:32 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-dmsUGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:32 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-NKbLL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:33 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)) 07:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:33 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-AaYbOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:33 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-TDx0JW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:33 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-9AwpC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:33 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-z6nfvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:33 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-TldCVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:33 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-kB15Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:33 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-6l_PMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:48:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:35 INFO - Downloading blessings-1.5.1.tar.gz 07:48:35 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 07:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:48:36 INFO - Installing collected packages: blessings 07:48:36 INFO - Running setup.py install for blessings 07:48:36 INFO - Successfully installed blessings 07:48:36 INFO - Cleaning up... 07:48:36 INFO - Return code: 0 07:48:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:48:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:48:36 INFO - Reading from file tmpfile_stdout 07:48:36 INFO - Current package versions: 07:48:36 INFO - blessings == 1.5.1 07:48:36 INFO - blobuploader == 1.2.4 07:48:36 INFO - docopt == 0.6.1 07:48:36 INFO - manifestparser == 1.1 07:48:36 INFO - mozInstall == 1.12 07:48:36 INFO - mozcrash == 0.16 07:48:36 INFO - mozdebug == 0.1 07:48:36 INFO - mozdevice == 0.47 07:48:36 INFO - mozfile == 1.2 07:48:36 INFO - mozhttpd == 0.7 07:48:36 INFO - mozinfo == 0.9 07:48:36 INFO - mozleak == 0.1 07:48:36 INFO - mozlog == 3.0 07:48:36 INFO - moznetwork == 0.27 07:48:36 INFO - mozprocess == 0.22 07:48:36 INFO - mozprofile == 0.27 07:48:36 INFO - mozrunner == 6.11 07:48:36 INFO - mozscreenshot == 0.1 07:48:36 INFO - mozsystemmonitor == 0.0 07:48:36 INFO - moztest == 0.7 07:48:36 INFO - mozversion == 1.4 07:48:36 INFO - psutil == 3.1.1 07:48:36 INFO - requests == 1.2.3 07:48:36 INFO - wsgiref == 0.1.2 07:48:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:36 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 0x100e40490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc22c77f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d649f0>, '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 0x100ac3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d578c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bT1SmsdbA8/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:48:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:48:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bT1SmsdbA8/Render', 07:48:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:36 INFO - 'HOME': '/Users/cltbld', 07:48:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:36 INFO - 'LOGNAME': 'cltbld', 07:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:36 INFO - 'MOZ_NO_REMOTE': '1', 07:48:36 INFO - 'NO_EM_RESTART': '1', 07:48:36 INFO - 'PAGER': '/bin/cat', 07:48:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:36 INFO - 'PWD': '/builds/slave/test', 07:48:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:36 INFO - 'SHELL': '/bin/bash', 07:48:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners', 07:48:36 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 07:48:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:36 INFO - 'USER': 'cltbld', 07:48:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:36 INFO - 'XPC_FLAGS': '0x0', 07:48:36 INFO - 'XPC_SERVICE_NAME': '0', 07:48:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:48:36 INFO - Cleaning up... 07:48:36 INFO - Return code: 0 07:48:36 INFO - Running post-action listener: _resource_record_post_action 07:48:36 INFO - Running post-action listener: _start_resource_monitoring 07:48:36 INFO - Starting resource monitoring. 07:48:36 INFO - ##### 07:48:36 INFO - ##### Running install step. 07:48:36 INFO - ##### 07:48:36 INFO - Running pre-action listener: _resource_record_pre_action 07:48:36 INFO - Running main action method: install 07:48:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:48:37 INFO - Reading from file tmpfile_stdout 07:48:37 INFO - Detecting whether we're running mozinstall >=1.0... 07:48:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:48:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:48:37 INFO - Reading from file tmpfile_stdout 07:48:37 INFO - Output received: 07:48:37 INFO - Usage: mozinstall [options] installer 07:48:37 INFO - Options: 07:48:37 INFO - -h, --help show this help message and exit 07:48:37 INFO - -d DEST, --destination=DEST 07:48:37 INFO - Directory to install application into. [default: 07:48:37 INFO - "/builds/slave/test"] 07:48:37 INFO - --app=APP Application being installed. [default: firefox] 07:48:37 INFO - mkdir: /builds/slave/test/build/application 07:48:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:48:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:49:07 INFO - Reading from file tmpfile_stdout 07:49:07 INFO - Output received: 07:49:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:49:07 INFO - Running post-action listener: _resource_record_post_action 07:49:07 INFO - ##### 07:49:07 INFO - ##### Running run-tests step. 07:49:07 INFO - ##### 07:49:07 INFO - Running pre-action listener: _resource_record_pre_action 07:49:07 INFO - Running main action method: run_tests 07:49:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:49:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:49:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:49:07 INFO - 2015-11-20 07:49:07.704 screenresolution[1640:7914] starting screenresolution argv=screenresolution get 07:49:07 INFO - 2015-11-20 07:49:07.707 screenresolution[1640:7914] Display 0: 1600x1200x32@60 07:49:07 INFO - 2015-11-20 07:49:07.712 screenresolution[1641:7917] starting screenresolution argv=screenresolution list 07:49:07 INFO - Available Modes on Display 0 07:49:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:49:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:49:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:49:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:49:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:49:07 INFO - Intel Iris: 07:49:07 INFO - Chipset Model: Intel Iris 07:49:07 INFO - Type: GPU 07:49:07 INFO - Bus: Built-In 07:49:07 INFO - VRAM (Dynamic, Max): 1536 MB 07:49:07 INFO - Vendor: Intel (0x8086) 07:49:07 INFO - Device ID: 0x0a2e 07:49:07 INFO - Revision ID: 0x0009 07:49:07 INFO - Displays: 07:49:07 INFO - Display: 07:49:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:49:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:49:07 INFO - Display Serial Number: 1600x1200 60 07:49:07 INFO - Main Display: Yes 07:49:07 INFO - Mirror: Off 07:49:07 INFO - Online: Yes 07:49:07 INFO - Rotation: Supported 07:49:07 INFO - Return code: 0 07:49:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:49:07 INFO - Python 2.7.3 07:49:07 INFO - Return code: 0 07:49:07 INFO - grabbing minidump binary from tooltool 07:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:07 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d649f0>, '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 0x100ac3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100d578c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:49:07 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:49:07 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:49:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:49:08 INFO - Return code: 0 07:49:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:49:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:49:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:49:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:49:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:49:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0047', '--webServer', 'localhost'] in /builds/slave/test/build 07:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0047 --webServer localhost 07:49:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bT1SmsdbA8/Render', 07:49:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:08 INFO - 'HOME': '/Users/cltbld', 07:49:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:08 INFO - 'LOGNAME': 'cltbld', 07:49:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:49:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:08 INFO - 'MOZ_NO_REMOTE': '1', 07:49:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:49:08 INFO - 'NO_EM_RESTART': '1', 07:49:08 INFO - 'PAGER': '/bin/cat', 07:49:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:08 INFO - 'PWD': '/builds/slave/test', 07:49:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:49:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:08 INFO - 'SHELL': '/bin/bash', 07:49:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners', 07:49:08 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 07:49:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:08 INFO - 'USER': 'cltbld', 07:49:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:08 INFO - 'XPC_FLAGS': '0x0', 07:49:08 INFO - 'XPC_SERVICE_NAME': '0', 07:49:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0047', '--webServer', 'localhost'] with output_timeout 3600 07:49:08 INFO - mozversion INFO | application_buildid: 20151120061737 07:49:08 INFO - mozversion INFO | application_changeset: 9d449237638a706f53fa985bc4e3be16e170f220 07:49:08 INFO - mozversion INFO | application_display_name: Nightly 07:49:08 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:49:08 INFO - mozversion INFO | application_name: Firefox 07:49:08 INFO - mozversion INFO | application_remotingname: firefox 07:49:08 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:49:08 INFO - mozversion INFO | application_vendor: Mozilla 07:49:08 INFO - mozversion INFO | application_version: 45.0a1 07:49:08 INFO - mozversion INFO | platform_buildid: 20151120061737 07:49:08 INFO - mozversion INFO | platform_changeset: 9d449237638a706f53fa985bc4e3be16e170f220 07:49:08 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:49:08 INFO - mozversion INFO | platform_version: 45.0a1 07:49:08 INFO - 2015-11-20 07:49:08,260 DEBUG : using testdate: 1448034548 07:49:08 INFO - 2015-11-20 07:49:08,260 DEBUG : actual date: 1448034548 07:49:08 INFO - 2015-11-20 07:49:08,673 INFO : starting webserver on 'localhost:49274' 07:49:08 INFO - 2015-11-20 07:49:08,674 INFO : Starting test suite t-yosemite-r7-0047 07:49:08 INFO - 2015-11-20 07:49:08,674 INFO : Starting test dromaeo_css 07:49:08 INFO - 2015-11-20 07:49:08,674 DEBUG : operating with platform_type : mac_ 07:49:08 INFO - 2015-11-20 07:49:08,675 INFO : Initialising browser for dromaeo_css test... 07:49:08 INFO - 2015-11-20 07:49:08,688 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpW40GhK/profile http://localhost:49274/getInfo.html 07:49:10 INFO - 2015-11-20 07:49:10,925 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:49:10 INFO - 2015-11-20 07:49:10,925 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:49:10 INFO - 2015-11-20 07:49:10,925 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:49:10 INFO - 2015-11-20 07:49:10,925 DEBUG : BROWSER_OUTPUT: __metrics 07:49:10 INFO - 2015-11-20 07:49:10,941 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:49:11 INFO - 2015-11-20 07:49:11,606 INFO : Browser initialized. 07:49:11 INFO - 2015-11-20 07:49:11,606 INFO : Running cycle 1/1 for dromaeo_css test... 07:49:11 INFO - 2015-11-20 07:49:11,606 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpW40GhK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:49:23 INFO - 2015-11-20 07:49:23,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 224272384 07:49:23 INFO - 2015-11-20 07:49:23,363 DEBUG : BROWSER_OUTPUT: 07:50:14 INFO - 2015-11-20 07:50:14,379 DEBUG : BROWSER_OUTPUT: 1448034614378 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:52:26 INFO - 2015-11-20 07:52:26,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 07:52:27 INFO - 2015-11-20 07:52:27,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 372412416 07:52:27 INFO - 2015-11-20 07:52:27,855 DEBUG : BROWSER_OUTPUT: 07:55:30 INFO - 2015-11-20 07:55:30,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 07:55:31 INFO - 2015-11-20 07:55:31,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 367714304 07:55:31 INFO - 2015-11-20 07:55:31,199 DEBUG : BROWSER_OUTPUT: 07:58:33 INFO - 2015-11-20 07:58:33,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 07:58:33 INFO - 2015-11-20 07:58:33,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 341692416 07:58:33 INFO - 2015-11-20 07:58:33,705 DEBUG : BROWSER_OUTPUT: 08:01:35 INFO - 2015-11-20 08:01:35,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 08:01:36 INFO - 2015-11-20 08:01:36,289 DEBUG : BROWSER_OUTPUT: RSS: Main: 354807808 08:01:36 INFO - 2015-11-20 08:01:36,289 DEBUG : BROWSER_OUTPUT: 08:04:39 INFO - 2015-11-20 08:04:39,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 08:04:39 INFO - 2015-11-20 08:04:39,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 322945024 08:04:39 INFO - 2015-11-20 08:04:39,927 DEBUG : BROWSER_OUTPUT: 08:07:42 INFO - 2015-11-20 08:07:42,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 08:07:42 INFO - 2015-11-20 08:07:42,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 418091008 08:07:42 INFO - 2015-11-20 08:07:42,824 DEBUG : BROWSER_OUTPUT: 08:07:42 INFO - 2015-11-20 08:07:42,824 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:07:42 INFO - 2015-11-20 08:07:42,824 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:07:42 INFO - 2015-11-20 08:07:42,824 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:07:42 INFO - 2015-11-20 08:07:42,824 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:07:42 INFO - 2015-11-20 08:07:42,826 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3175.523671449282;3489.6859282664554;3502.1594817243863;3508.9122771930715;3543.8050907200095;4664.906701865961;5655.349634792;5796.913046304308;5920.970395148029;5958.553108516857;5830.416958304168;5919.230500035;5923.229980102591;5923.792667256647;5933.88132237355;5300.125479295921;5322.2814919985885;5371.5165635092835;5391.110466772997;5413.323334583177;5419.891602167954;5422.915416916613;5431.293931788862;5432.483914028161;5436.238926550286;5339.759710813003;5410.783568657249;5417.431169727181;5426.158945363475;5434.7826086956475;5384.596155288349;5412.025835349656;5418.458154184589;5421.783128674848;5427.972860135714;5236.7119808410525;5245.055889939809;5352.812651557177;5367.409584945653;5386.91919621206;5812.331581868097;5939.376365481606;5954.434328738763;5954.761809527657;5962.940370596282;6354.173957385557;6387.169667943184;6391.744330226786;6396.488280937514;6397.328280530523;6204.5967012144065;6216.564840461169;6303.716332765037;6304.148939893102;6333.429991300759;4443;6043.09353596964;6057.818265452043;6079.240094988127;6092.086187071886;6438.678066096676;6479.125318082093;6488.967555162289;6494.870102597922;6507.121538592324;6140.9030504681;6152.230971128609;6279.780207692709;6280.214973128359;6291.465225455888;6330.303666596671;6354.17395738551;6362.77730279438;6373.872522549523;6378.712957916905;6305.621662700252;6358.109864618957;6363.268224154189;6372.617642941438;6372.776952806722;6132.011916702835;6197.349278325801;6333.493320534346;6343.080253363329;6344.080108384258;5055.292259083732;5057.544820966131;5076.517730815566;5084.542391184737;5117.053345131163;4521.84173553924;4534.818607255673;4544.431946006749;4575.450945886449;4578.519255478127;5883.735231914574;5987.161797348374;6031.215941927521;6042.546808989343;6043.939560604338;6284.811455656338;6288.811335659938;6294.307626161119;6301.14934483848;6303;5955.196048533479;5999.730012149464;6007.879842403215;6017.969910150508;6029.155918171459;5560.388357280696;5566.025945459528;5573.331200255995;5577.609567330329;5578.9163162552595;5488.231647569343;6397.360263973565;6419.16550848396;6451.096846441502;6476;6386.425221730066;6398.744050238124;6404.071409645482;6406.071119687713;6416.935830641633;6552.410283074546;6569.9343006571235;6573.638449885111;6576.967115164393;6595.637239951849;6138.57030007913;6239.251289845248;6265.342139075331;6277.466415354564;6341.841453963503;6187;6363.490920726424;6363.713632886439;6365.52258580599;6378.585391949508;6339.461145802658;6348.682565871781;6366.80899572995;6368.904466432915;6373.075903993988;6111.236095488064;6181.598196117238;6194.163787888578;6201.255849298113;6342.778002769881;6195.349488303663;6202.193714817045;6212.937870621236;6223.533235007483;6243.188385510036;6358.872822543616;6360.459360954371;6367;6367.044943258548;6381.585196962183;5979.4917432018765;6044.667543285162;6087.914487330863;6098.237720284965;6263.185785847811 08:07:42 INFO - 2015-11-20 08:07:42,827 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.316960139029;567.7388401335387;586.691986706979;608.4219991008541;660.428729149286;32086;32523.837380813093;40073;41508.58491415085;41580.79209603955;43932.560674393244;44247;44349.33475997855;44410.777946110225;44503.77748111263;8881.73354799357;9751.609935602568;9965.900340996606;9967.401955882635;9980.900190998069;8874.86687699685;11762.353070581115;11919.40402979852;11950;11953.880461195364;11691.12316576256;11791.702912679599;11798.764024719501;11817.822732659017;11831.704207394798;8982.056884027214;9181.311401644904;11732.589359372423;11907.64277071685;11986.981106605948;10069.496525173785;11754.882451175465;11922.582709605122;11940.641780746591;11955.983741381993;33674.32651346984;41542.376864346756;41562.96092597679;41615.37576936348;41626.791866040476;3230.951535726966;3273.5089736539708;3502.1944952660774;3529.2588556403184;3676.9448458273146;23402.882985585133;29044.709552904413;30180.396392072034;30246.24384390386;30415.695843041507;2783.6937936826935;2825.9858700706573;2896.131160651817;2917.0519581136004;3010.3377257003426;517733;522476;522631;523334;524178;52854.471455284955;58485.70757146272;59266;72616.27383726095;72970;58673.70663146657;61838;67771.96684099485;69965.65017174881;70835;16719.582010449834;16920.57698557546;16943.576410589587;16970.660586788195;16993;12798.360081995863;12882.35588220604;12895.935520322526;12896.548620798227;12934.547290844775;17456.5635859102;21126.9436528173;21329.25347612857;21511.354659360244;21559.78440215578;9224.677136300197;9442.952785236168;9467;9507.809843803223;9572.61709531625;924.6347692661361;968.8885778135464;983.6753871222479;1028.218553899042;1115.8214685650419;28992.275193120342;29465.11604651864;29498.410031799245;29918.700812992025;30046.54930176049;961.1781926452783;1080.4921686807345;1084.9457527123611;1131.7510147767478;1156.4564654612318;13277.933610331887;15314.157721325435;16465;16587.91706041462;16799.91600041992;662343.0774076455;668956;669509;670877;673584;61531;61906.69046654738;61958.66289359792;62045;62075.37924620786;1458.649924018228;1476.0553245922833;1491.0531812299268;1494.9476768313057;1624.5370069530127;28222.435551288447;28277.71722282751;32116.67883321137;32273.677263227066;32608.34783304368;47382;48582.514174859214;51535;54334.45665543452;54463.455365445836;512670;514095;516080;516854;516984;27364.72635273622;27673;27767.30581735473;32570.185745355608;32984.175395615304;35677.286454271285;40724.59275407208;42709.086765681335;43442.565574343855;43486;34401.795937143084;35007.649923501456;35228;40377.596224038556;41565.584344156174;31368;37113.25773484569;37933;37974.62025379822;38507;27933.720662793112;36690.26619467649;37463.250734984606;37750.43374349332;38048.42927356147;26483.205503834917;31982.68017319797;32818.17954551155;32836.34327313488;32899.34201316008;23785.075462548484;24424.511509770062;24450.633240501764;24696.753032469445;25208.495830083662 08:07:42 INFO - 2015-11-20 08:07:42,828 DEBUG : BROWSER_OUTPUT: |2;jquery.html;363.965423284788;365.4919661670278;368.3756033523179;368.57981900633297;368.73082649665736;16133.515994520154;17784;19869.801301986976;20569.38291851245;21240.256591019297;19668.508287292825;19759.60480790387;19762.703559446585;19823.40529784105;19861.801381986177;4008.418779277003;5027.8240261590945;5187.6628019178825;5188.766505507261;5195.636305458619;4097.037196258877;4131.73143745657;5821.970890145543;6001.519878409738;6007.819765407023;5890.5582081343855;5967.970160149193;5968.641881487103;5989.401059894019;6509.088727578142;6396.328385519523;6399.168108145957;6433.131527243832;6438.903416448757;6465.676716164173;4689.226277664181;5492.203630473559;5613.382527921925;5667.943320566824;5668.234788303609;13291.401886915111;13297.069205155643;13300.467981280737;21076.15695372183;25719.61420578693;2177.9891100544555;2217.467807726134;2233.7877901599322;2252.583272094668;2611.5038142752815;9785.755356116082;9789.608415663364;10131.746706332327;10149.188064954786;11720.355380454072;1722.6726921884801;1726.5252055684662;1738.2699266308182;1750.3436211420717;1765.6428667728599;83426;104565;109361;110961.33557996637;112490;10522.526486308134;10941.015308622262;11044.668659940215;11072.778544429066;11141.108711303077;13161.53934612284;13254.602361929157;13256.469741210436;13266.933665331611;13302.667433314244;8552.102029286836;8552.486850788973;8559.186877246777;8610.483370997761;8619.655213791379;8740.519271440005;8764.649414023495;8778;8855.73432797017;8863.2466240369;3592.389293820057;4253.213155566168;4299.419578356944;4325.416068830667;4360.4331436913635;1611.58904479357;1659.5270347950775;1726.5942503511665;1763.9647207055787;1764.0826770079743;890.844102282111;943.8961714211431;970.0299700299701;1013.5911083593663;1087.1574529739514;18989.810101898805;19881.900590497244;19980.30068947609;20051.498712532302;20341.796582034287;882.4220135811054;993.4933184076028;993.8757655293089;1029.6756521695793;1042.7341028037802;10025.24810639205;10686.407264327525;10719.42158664216;10722.533817222082;10765.461726913623;759270;759875;760204;775005;778786;95501.5224923871;107736.69053237783;112364;117736.23395649072;120244;1069.0752499088233;1112.2158877990996;1126.245415571569;1130.8077626803463;1160.3328086350382;17665.823341766933;17666.205020774352;17775.555611109827;17810.554736131184;18235.088245587933;47850.04299914052;47954.76022619865;50392.8070018208;52916.73541632267;53473;69778.95331570132;70104.6494767523;70841.64579177072;70900.22749431306;71428;9538;9736.513174341397;9789.216862650828;9799.167070799062;10057.798844023226;16429.671406571564;19795.703064453755;19899.204031838563;20003.499912502302;20032.098555564742;15560.766588500956;15625.921870390575;15738.370465181722;16186.190690465664;16275.18624068768;15374.769378459556;15472.767908481606;15770.974886632332;15908.125053122189;16271.430499932445;16161.353545858034;16191.028538287741;16502.75245871337;16687;16688.499345019667;9615;9727.951360243154;9740.61037558518;9825.85261221068;9899.406035637885;12805.359732013549;15543.611409714395;15781.974171678805;15943.601409964844;16178.595535111717 08:07:42 INFO - 2015-11-20 08:07:42,832 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1558.5713928669616;1648.2006226979904;1683.6464342488077;1980.8514361422897;1983.7718662353834;7512.6243687815595;7910.723124690637;8212.343012558997;8540.871886921701;8542.145785421455;8353.415260931737;8501;8560.357973152008;8560.571971401436;8568.614412351444;2130.595186914489;2180.051677520276;2392.41385860464;2414.14297924237;2419.7822196002357;2166.7833216678287;2200;2209.5028618560855;2210.2264207527396;2339.695839540866;2352.2825538210923;2391.7608239176116;2396.6524853896176;2396.9880150599224;2398.832081754269;2404.290734233405;2422.624493203556;2426.078090325665;2429.708434987813;2431.465077682907;2163.8809865457392;2214.258223495131;2215.069670738294;2375.477394973103;2423.7455067217866;8410.03284622264;8554.05905350411;8554.443961142568;8555.23002929733;8562.443441176365;4402.2296098183015;4453.955460445386;5259.237410575445;5313.256144139824;5319.148936170194;3522.2427178156818;3569.660882216211;3613.6205698401814;3617.385044542434;3641.5448068991377;1042.1142029275131;1046.4296958157822;1052.58422922945;1080.1574771678104;1083.9078678312353;9704.369216001009;11315.377654229014;11332;11357.943210283978;11363.31820090789;3982.2433737589763;4643.466001409881;4671.95328046722;4732;4734.360861283752;9758.170555502862;9773.315867889321;9778.462184579916;9791.069848364394;9806.705798825904;5282.392524859613;5304.549113325411;5310.203469479532;5312.335958005249;5323.653962492425;4825.95174048262;4860.222364421676;4871.926921096187;4876.097921884392;4876.4879687633;3797.2785170817456;3895.14306852492;3905.3946638271113;3911.041794760245;3923.489946306962;1279.2836011833404;1294.3851670456645;1299.3762993763046;1304.2565737529517;1306.7778477658821;1063.824468962628;1081.4862940103387;1081.7566047639375;1260;1306.0661626936596;7282.599457029914;7865.859450379778;7955.045394552691;7966.083900351534;7967.282944534903;496.54318027414865;503.6424138861376;507.55588859747724;509.4625170445142;511.89250257446355;5684.403137670568;5796.043652797325;5811.070228763462;6192.318844927055;6222.968885155636;10025.348352357074;10334.018268264503;10344.948275258726;10348.275620706478;10374.22193335503;9955.950220248997;10238.744031399274;10284.971502849805;10307.381557106448;10320;6445.452136568444;7803.648835802403;7817.5309481431295;7847.607619618996;7983.8403231935035;6709.463242940651;7747.573883436465;7760.84478310442;7854.567998760123;7877.6455059523605;8223.835523289621;8832.602532885907;9171.495567743837;9183.311251656287;9308.348415610842;9173.036831132635;9378.577963991773;9381.577828997575;9390.389624674373;9530.904690953003;7187.9640601796655;7225.060742103493;7258.528195667264;7280;7288.927110728825;7975.920240797518;8024.358051355995;8029.397795165269;8035.477693949874;8059.355251579742;7288.781336559911;7496.100467943882;7575.962120189364;7580.030431140713;7594.354479869273;7279.963600181965;7374.188839227573;7469.626518673936;7494.925050749423;7551.207123251979;7502.624868756649;7536.057992750906;7538.585377804274;7541.509801862861;7543.585102819397;6717;6773;6792.524523283323;6793.864122717617;6855.143107111611;6880.208775990825;6936.895946560907;6937.445004399737;6938.965305173442;6949.895751563629 08:07:42 INFO - 2015-11-20 08:07:42,833 DEBUG : BROWSER_OUTPUT: |4;prototype.html;320.2074864709843;329.2920221523725;331.4845415379085;332.49294825391263;335.9798412095273;6790.253072162064;6811.6253606051705;6812.046313516099;6816.556923799956;6837.213720422153;5373.382061062979;6442.8067157985215;6574.671266436683;6607.636579988099;6621.139251897259;4069.613386728256;4382.320740285245;4537.729435757977;4791.736454495001;5009.549140577347;4620;5034;5036.6726162799305;5043.319151914499;5045.470225626312;4755.714657120567;4847.563719265266;4849.296851956464;4962.727050012248;4967.602591792648;4940.950590494085;4946.950530494721;4964;4994.475580064095;5009.524095210949;3560.3235385276716;4242.321228603409;4243.448351714257;4249.320108782611;4255.553111941955;6354.968225158845;6576.473882089469;6592.04415359775;6601.471882249457;6604.636744979024;4877.658563900528;5900.468957793819;5912.674802885839;5973.253343332083;5982.820515384546;5930.644161350289;7254.455915806336;7261.273872612749;7291.963540182318;7309.076369452262;4779.235322348408;4782.30656554801;4783.736894470802;4783.856484305476;4786.688865223749;6765.255821859591;7525.247475252431;7546.69813207471;7784.143744188134;7803;4855.708657480492;4911.656184067152;4929.531694489017;4933.481984391659;4937.40751109862;5008.248762685626;5008.5993120550265;5008.974955125201;5014.774335154927;5024.824131155392;5769.307683078057;5962.525551896001;5985.910211346833;5988.101784732238;5994;7352.264773522712;7369.29991650803;7372;7376.926230737624;7389.408847292204;1724.8275172482902;1742.2421246757701;1742.2943707798363;1743.651269746056;1747.519432156167;924.9398789078689;952.1906379577442;1118.6867677050438;1130.6721050895312;1146.587228597704;7038.542494737826;7040.823979400556;7065.505414620927;7072.71709131629;7074.115735533059;7419.740309089156;7674.577898215652;7689.154193038761;7703.691852325845;7705.113911900204;5743.798967036134;6930.410915072174;7017.157941047107;7129.073220481304;7159.3914517265575;4085.5710150433774;4090.6113919178224;4111.7944102794745;4112.300908845504;4115.238680844053;7883.684652613946;8001.15987821282;8072.475289106189;8078.676852925817;8103.392245581605;6444.645544495098;7999.88004678176;8006.559639219899;8017.198280171936;8022.3983201260135;8037.437379383504;8040.437169398203;8060.919390806017;8061.395395345373;8074.273315401525;7467.962660186664;7768.339691126317;7773.18381569927;7779.299863012356;7780.2219778021745;6590.275069742421;7587.544747315179;7587.924120758722;7588.658510367157;7598.772036838904;7742.7677169685;8014.799630009296;8028.956235689323;8034.638441270274;8056.033276006917;4953.801847926186;4956.330895329084;4958.752062396938;4961.652684312064;4962.5533701967;6586.8353291168105;7691.846163076595;7701.075870895528;7704.30661240491;7712.5758083305955;7101.4673899458785;7134.286571342825;7400.333969942731;7404.481686281909;7421.0723659542555;6052.515798736179;7380.704771809067;7382.187959324363;7393.223711510214;7404.481686281909;7193.568385896863;7201.891971620535;7202.279772022755;7215.2063273038875;7229.277072292729;7133.787256166568;7392.96303518479;7394.408447324094;7412.110546734426;7416.480846340704;6931;7102.3962963148715;7210.567365958059;7220.530665506725;7226.855462890608 08:07:42 INFO - 2015-11-20 08:07:42,834 DEBUG : BROWSER_OUTPUT: |5;yui.html;733.2557454184001;810.3193317613208;814.5397850214632;818.0714888601437;843.9239969039473;15133.470328538504;15212.54362369128;15523.844761552382;15556.688866222668;15563.533094007184;14569.417223311082;14658.340374683139;14677.119372837637;14691.55925322242;14708.852911470882;767.6200280860953;770.7148355108618;957.7174733453613;981.5730157381527;983.6852207293668;766.9808254793619;773.404478551515;967.8403063494515;972.5963725054129;973.0464145137769;944.2823454174842;992.4789485520088;1011.5195282240913;1013.9188864890828;1014.5738789708304;808.1675873849944;811.4482152136545;1007.8790545134594;1008.9293749437543;1014.9391036537794;601.897677394844;745.3776096959045;748.3863232149639;749.6027105634023;750.2722359311459;15264.694706105927;15374.538763837103;15425.922870385688;15437.996530225611;15452.845471545366;12633.052521060865;12664.4301006454;12883.098183127186;12915.031372646996;12976.740465190644;10254.179665626732;10339.741506462398;10343.637972670997;10344.32761870476;10472.057514823626;3541.3094446582927;3568.982155089234;3580.4092324766384;3588.5873124590744;3596.37063513884;82395.58802206011;82750.58624706898;83678.99999999939;84383.15616843876;84398.57800711019;7900.644470998819;9772.804543909082;9924.305298629026;10007;10411.323263987817;21969;22213.666794998087;22215.889205539657;22245.22141725032;22267.443313917283;7178.38983686382;7353.522021068614;7569;7632.122305934778;7655.387568994467;3639.5996440391536;3920.4315374270573;4014.3777714454304;4076.5515793262716;4098.446709694213;3533.840977156034;3556.7688100273917;3573.427691815593;3576.123849656851;3579.49887015818;649.6686689788243;657.7434800427837;658.1937127019363;658.8879890418544;661.0876989754108;481.279426051866;510.7471801458302;522.7464679630376;541.4666553444854;557.76016312985;8627.827443451222;9160.6793762218;9232.584533696;9261.629534818667;9607.991160928143;525.4587774592176;562.9978638024323;600.3876046432614;604.3473049106954;626.8564786759516;3900.941485877714;4043;4074.103697186614;4102.50769907613;4206.978965105155;101704;102232.48883755683;103528;103825;104178;84428.57785711155;84630.73053904196;85253;85317;86713;65676.34323656702;72628;75133.62433187908;75285.62357188179;75855.86216206761;7042.260562640849;8488.320934325362;8777.297816174563;8896.377253592187;9061.320400969822;43140.568594313656;53316.733416334224;54269.45730542644;56223;56668.43331566631;72938.63530682313;75408;75656.62171689326;76636.85044724222;77034.2296577027;11020.008199262105;11260.268082574607;11341.036011938748;11423.657290281304;11804.940975295069;11291.3789741565;11380.203385763249;11526.94236528812;11703.005244554308;12117.09121815885;9498.287628427757;11531.769364612828;11727.061835053004;11855.288682679067;12133.878661213628;11543.942280288546;11608.593699220486;11941.044716422492;11952.521899123938;12319;11541.884581154081;11632;11634.825477617673;11653.184277100521;12267.815982760445;9690.224782017282;9894.356866803635;9954.950225248827;10146.391216527032;10273.126784223425;8267.421280510307;8705.47767133974;8841.823163536565;9275.76810579741;10087.798244034931 08:07:42 INFO - 2015-11-20 08:07:42,834 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:07:42 INFO - 2015-11-20 08:07:42,834 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:07:42 INFO - 2015-11-20 08:07:42,835 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1124 08:07:42 INFO - 2015-11-20 08:07:42,835 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:07:42 INFO - 2015-11-20 08:07:42,835 DEBUG : BROWSER_OUTPUT: __startTimestamp1448035662822__endTimestamp 08:07:42 INFO - 2015-11-20 08:07:42,835 DEBUG : BROWSER_OUTPUT: 08:07:42 INFO - 2015-11-20 08:07:42,835 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:07:42 INFO - 2015-11-20 08:07:42,835 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:07:42 INFO - 2015-11-20 08:07:42,835 DEBUG : BROWSER_OUTPUT: 08:07:42 INFO - 2015-11-20 08:07:42,836 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5892.09 Median:6138.57 stddev:660.43 (10.8%) stddev-sans-first:627.13 08:07:42 INFO - 2015-11-20 08:07:42,836 DEBUG : BROWSER_OUTPUT: Values: 3175.5 3489.7 3502.2 3508.9 3543.8 4664.9 5655.3 5796.9 5921.0 5958.6 5830.4 5919.2 5923.2 5923.8 5933.9 5300.1 5322.3 5371.5 5391.1 5413.3 5419.9 5422.9 5431.3 5432.5 5436.2 5339.8 5410.8 5417.4 5426.2 5434.8 5384.6 5412.0 5418.5 5421.8 5428.0 5236.7 5245.1 5352.8 5367.4 5386.9 5812.3 5939.4 5954.4 5954.8 5962.9 6354.2 6387.2 6391.7 6396.5 6397.3 6204.6 6216.6 6303.7 6304.1 6333.4 4443.0 6043.1 6057.8 6079.2 6092.1 6438.7 6479.1 6489.0 6494.9 6507.1 6140.9 6152.2 6279.8 6280.2 6291.5 6330.3 6354.2 6362.8 6373.9 6378.7 6305.6 6358.1 6363.3 6372.6 6372.8 6132.0 6197.3 6333.5 6343.1 6344.1 5055.3 5057.5 5076.5 5084.5 5117.1 4521.8 4534.8 4544.4 4575.5 4578.5 5883.7 5987.2 6031.2 6042.5 6043.9 6284.8 6288.8 6294.3 6301.1 6303.0 5955.2 5999.7 6007.9 6018.0 6029.2 5560.4 5566.0 5573.3 5577.6 5578.9 5488.2 6397.4 6419.2 6451.1 6476.0 6386.4 6398.7 6404.1 6406.1 6416.9 6552.4 6569.9 6573.6 6577.0 6595.6 6138.6 6239.3 6265.3 6277.5 6341.8 6187.0 6363.5 6363.7 6365.5 6378.6 6339.5 6348.7 6366.8 6368.9 6373.1 6111.2 6181.6 6194.2 6201.3 6342.8 6195.3 6202.2 6212.9 6223.5 6243.2 6358.9 6360.5 6367.0 6367.0 6381.6 5979.5 6044.7 6087.9 6098.2 6263.2 08:07:42 INFO - 2015-11-20 08:07:42,836 DEBUG : BROWSER_OUTPUT: 08:07:42 INFO - 2015-11-20 08:07:42,838 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:70468.15 Median:34704.72 stddev:153144.29 (441.3%) stddev-sans-first:153483.94 08:07:42 INFO - 2015-11-20 08:07:42,838 DEBUG : BROWSER_OUTPUT: Values: 555.3 567.7 586.7 608.4 660.4 32086.0 32523.8 40073.0 41508.6 41580.8 43932.6 44247.0 44349.3 44410.8 44503.8 8881.7 9751.6 9965.9 9967.4 9980.9 8874.9 11762.4 11919.4 11950.0 11953.9 11691.1 11791.7 11798.8 11817.8 11831.7 8982.1 9181.3 11732.6 11907.6 11987.0 10069.5 11754.9 11922.6 11940.6 11956.0 33674.3 41542.4 41563.0 41615.4 41626.8 3231.0 3273.5 3502.2 3529.3 3676.9 23402.9 29044.7 30180.4 30246.2 30415.7 2783.7 2826.0 2896.1 2917.1 3010.3 517733.0 522476.0 522631.0 523334.0 524178.0 52854.5 58485.7 59266.0 72616.3 72970.0 58673.7 61838.0 67772.0 69965.7 70835.0 16719.6 16920.6 16943.6 16970.7 16993.0 12798.4 12882.4 12895.9 12896.5 12934.5 17456.6 21126.9 21329.3 21511.4 21559.8 9224.7 9443.0 9467.0 9507.8 9572.6 924.6 968.9 983.7 1028.2 1115.8 28992.3 29465.1 29498.4 29918.7 30046.5 961.2 1080.5 1084.9 1131.8 1156.5 13277.9 15314.2 16465.0 16587.9 16799.9 662343.1 668956.0 669509.0 670877.0 673584.0 61531.0 61906.7 61958.7 62045.0 62075.4 1458.6 1476.1 1491.1 1494.9 1624.5 28222.4 28277.7 32116.7 32273.7 32608.3 47382.0 48582.5 51535.0 54334.5 54463.5 512670.0 514095.0 516080.0 516854.0 516984.0 27364.7 27673.0 27767.3 32570.2 32984.2 35677.3 40724.6 42709.1 43442.6 43486.0 34401.8 35007.6 35228.0 40377.6 41565.6 31368.0 37113.3 37933.0 37974.6 38507.0 27933.7 36690.3 37463.3 37750.4 38048.4 26483.2 31982.7 32818.2 32836.3 32899.3 23785.1 24424.5 24450.6 24696.8 25208.5 08:07:42 INFO - 2015-11-20 08:07:42,838 DEBUG : BROWSER_OUTPUT: 08:07:42 INFO - 2015-11-20 08:07:42,838 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38959.61 Median:20196.65 stddev:125983.91 (623.8%) stddev-sans-first:126303.99 08:07:42 INFO - 2015-11-20 08:07:42,839 DEBUG : BROWSER_OUTPUT: Values: 364.0 365.5 368.4 368.6 368.7 16133.5 17784.0 19869.8 20569.4 21240.3 19668.5 19759.6 19762.7 19823.4 19861.8 4008.4 5027.8 5187.7 5188.8 5195.6 4097.0 4131.7 5822.0 6001.5 6007.8 5890.6 5968.0 5968.6 5989.4 6509.1 6396.3 6399.2 6433.1 6438.9 6465.7 4689.2 5492.2 5613.4 5667.9 5668.2 13291.4 13297.1 13300.5 21076.2 25719.6 2178.0 2217.5 2233.8 2252.6 2611.5 9785.8 9789.6 10131.7 10149.2 11720.4 1722.7 1726.5 1738.3 1750.3 1765.6 83426.0 104565.0 109361.0 110961.3 112490.0 10522.5 10941.0 11044.7 11072.8 11141.1 13161.5 13254.6 13256.5 13266.9 13302.7 8552.1 8552.5 8559.2 8610.5 8619.7 8740.5 8764.6 8778.0 8855.7 8863.2 3592.4 4253.2 4299.4 4325.4 4360.4 1611.6 1659.5 1726.6 1764.0 1764.1 890.8 943.9 970.0 1013.6 1087.2 18989.8 19881.9 19980.3 20051.5 20341.8 882.4 993.5 993.9 1029.7 1042.7 10025.2 10686.4 10719.4 10722.5 10765.5 759270.0 759875.0 760204.0 775005.0 778786.0 95501.5 107736.7 112364.0 117736.2 120244.0 1069.1 1112.2 1126.2 1130.8 1160.3 17665.8 17666.2 17775.6 17810.6 18235.1 47850.0 47954.8 50392.8 52916.7 53473.0 69779.0 70104.6 70841.6 70900.2 71428.0 9538.0 9736.5 9789.2 9799.2 10057.8 16429.7 19795.7 19899.2 20003.5 20032.1 15560.8 15625.9 15738.4 16186.2 16275.2 15374.8 15472.8 15771.0 15908.1 16271.4 16161.4 16191.0 16502.8 16687.0 16688.5 9615.0 9728.0 9740.6 9825.9 9899.4 12805.4 15543.6 15782.0 15943.6 16178.6 08:07:42 INFO - 2015-11-20 08:07:42,839 DEBUG : BROWSER_OUTPUT: 08:07:42 INFO - 2015-11-20 08:07:42,840 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5826.18 Median:5316.20 stddev:3066.32 (57.7%) stddev-sans-first:3058.15 08:07:42 INFO - 2015-11-20 08:07:42,841 DEBUG : BROWSER_OUTPUT: Values: 1558.6 1648.2 1683.6 1980.9 1983.8 7512.6 7910.7 8212.3 8540.9 8542.1 8353.4 8501.0 8560.4 8560.6 8568.6 2130.6 2180.1 2392.4 2414.1 2419.8 2166.8 2200.0 2209.5 2210.2 2339.7 2352.3 2391.8 2396.7 2397.0 2398.8 2404.3 2422.6 2426.1 2429.7 2431.5 2163.9 2214.3 2215.1 2375.5 2423.7 8410.0 8554.1 8554.4 8555.2 8562.4 4402.2 4454.0 5259.2 5313.3 5319.1 3522.2 3569.7 3613.6 3617.4 3641.5 1042.1 1046.4 1052.6 1080.2 1083.9 9704.4 11315.4 11332.0 11357.9 11363.3 3982.2 4643.5 4672.0 4732.0 4734.4 9758.2 9773.3 9778.5 9791.1 9806.7 5282.4 5304.5 5310.2 5312.3 5323.7 4826.0 4860.2 4871.9 4876.1 4876.5 3797.3 3895.1 3905.4 3911.0 3923.5 1279.3 1294.4 1299.4 1304.3 1306.8 1063.8 1081.5 1081.8 1260.0 1306.1 7282.6 7865.9 7955.0 7966.1 7967.3 496.5 503.6 507.6 509.5 511.9 5684.4 5796.0 5811.1 6192.3 6223.0 10025.3 10334.0 10344.9 10348.3 10374.2 9956.0 10238.7 10285.0 10307.4 10320.0 6445.5 7803.6 7817.5 7847.6 7983.8 6709.5 7747.6 7760.8 7854.6 7877.6 8223.8 8832.6 9171.5 9183.3 9308.3 9173.0 9378.6 9381.6 9390.4 9530.9 7188.0 7225.1 7258.5 7280.0 7288.9 7975.9 8024.4 8029.4 8035.5 8059.4 7288.8 7496.1 7576.0 7580.0 7594.4 7280.0 7374.2 7469.6 7494.9 7551.2 7502.6 7536.1 7538.6 7541.5 7543.6 6717.0 6773.0 6792.5 6793.9 6855.1 6880.2 6936.9 6937.4 6939.0 6949.9 08:07:42 INFO - 2015-11-20 08:07:42,841 DEBUG : BROWSER_OUTPUT: 08:07:42 INFO - 2015-11-20 08:07:42,841 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5986.99 Median:6800.94 stddev:1941.94 (28.6%) stddev-sans-first:1900.24 08:07:42 INFO - 2015-11-20 08:07:42,843 DEBUG : BROWSER_OUTPUT: Values: 320.2 329.3 331.5 332.5 336.0 6790.3 6811.6 6812.0 6816.6 6837.2 5373.4 6442.8 6574.7 6607.6 6621.1 4069.6 4382.3 4537.7 4791.7 5009.5 4620.0 5034.0 5036.7 5043.3 5045.5 4755.7 4847.6 4849.3 4962.7 4967.6 4941.0 4947.0 4964.0 4994.5 5009.5 3560.3 4242.3 4243.4 4249.3 4255.6 6355.0 6576.5 6592.0 6601.5 6604.6 4877.7 5900.5 5912.7 5973.3 5982.8 5930.6 7254.5 7261.3 7292.0 7309.1 4779.2 4782.3 4783.7 4783.9 4786.7 6765.3 7525.2 7546.7 7784.1 7803.0 4855.7 4911.7 4929.5 4933.5 4937.4 5008.2 5008.6 5009.0 5014.8 5024.8 5769.3 5962.5 5985.9 5988.1 5994.0 7352.3 7369.3 7372.0 7376.9 7389.4 1724.8 1742.2 1742.3 1743.7 1747.5 924.9 952.2 1118.7 1130.7 1146.6 7038.5 7040.8 7065.5 7072.7 7074.1 7419.7 7674.6 7689.2 7703.7 7705.1 5743.8 6930.4 7017.2 7129.1 7159.4 4085.6 4090.6 4111.8 4112.3 4115.2 7883.7 8001.2 8072.5 8078.7 8103.4 6444.6 7999.9 8006.6 8017.2 8022.4 8037.4 8040.4 8060.9 8061.4 8074.3 7468.0 7768.3 7773.2 7779.3 7780.2 6590.3 7587.5 7587.9 7588.7 7598.8 7742.8 8014.8 8029.0 8034.6 8056.0 4953.8 4956.3 4958.8 4961.7 4962.6 6586.8 7691.8 7701.1 7704.3 7712.6 7101.5 7134.3 7400.3 7404.5 7421.1 6052.5 7380.7 7382.2 7393.2 7404.5 7193.6 7201.9 7202.3 7215.2 7229.3 7133.8 7393.0 7394.4 7412.1 7416.5 6931.0 7102.4 7210.6 7220.5 7226.9 08:07:42 INFO - 2015-11-20 08:07:42,843 DEBUG : BROWSER_OUTPUT: 08:07:42 INFO - 2015-11-20 08:07:42,843 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19380.20 Median:21810.92 stddev:27903.66 (127.9%) stddev-sans-first:27946.80 08:07:42 INFO - 2015-11-20 08:07:42,843 DEBUG : BROWSER_OUTPUT: Values: 733.3 810.3 814.5 818.1 843.9 15133.5 15212.5 15523.8 15556.7 15563.5 14569.4 14658.3 14677.1 14691.6 14708.9 767.6 770.7 957.7 981.6 983.7 767.0 773.4 967.8 972.6 973.0 944.3 992.5 1011.5 1013.9 1014.6 808.2 811.4 1007.9 1008.9 1014.9 601.9 745.4 748.4 749.6 750.3 15264.7 15374.5 15425.9 15438.0 15452.8 12633.1 12664.4 12883.1 12915.0 12976.7 10254.2 10339.7 10343.6 10344.3 10472.1 3541.3 3569.0 3580.4 3588.6 3596.4 82395.6 82750.6 83679.0 84383.2 84398.6 7900.6 9772.8 9924.3 10007.0 10411.3 21969.0 22213.7 22215.9 22245.2 22267.4 7178.4 7353.5 7569.0 7632.1 7655.4 3639.6 3920.4 4014.4 4076.6 4098.4 3533.8 3556.8 3573.4 3576.1 3579.5 649.7 657.7 658.2 658.9 661.1 481.3 510.7 522.7 541.5 557.8 8627.8 9160.7 9232.6 9261.6 9608.0 525.5 563.0 600.4 604.3 626.9 3900.9 4043.0 4074.1 4102.5 4207.0 101704.0 102232.5 103528.0 103825.0 104178.0 84428.6 84630.7 85253.0 85317.0 86713.0 65676.3 72628.0 75133.6 75285.6 75855.9 7042.3 8488.3 8777.3 8896.4 9061.3 43140.6 53316.7 54269.5 56223.0 56668.4 72938.6 75408.0 75656.6 76636.9 77034.2 11020.0 11260.3 11341.0 11423.7 11804.9 11291.4 11380.2 11526.9 11703.0 12117.1 9498.3 11531.8 11727.1 11855.3 12133.9 11543.9 11608.6 11941.0 11952.5 12319.0 11541.9 11632.0 11634.8 11653.2 12267.8 9690.2 9894.4 9955.0 10146.4 10273.1 8267.4 8705.5 8841.8 9275.8 10087.8 08:07:42 INFO - 2015-11-20 08:07:42,843 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:07:42 INFO - 2015-11-20 08:07:42,843 DEBUG : BROWSER_OUTPUT: 08:07:43 INFO - 2015-11-20 08:07:43,370 INFO : Browser exited with error code: 0 08:07:43 INFO - 2015-11-20 08:07:43,394 INFO : Completed test dromaeo_css (00:18:34) 08:07:43 INFO - 2015-11-20 08:07:43,394 INFO : Starting test kraken 08:07:43 INFO - 2015-11-20 08:07:43,394 DEBUG : operating with platform_type : mac_ 08:07:43 INFO - 2015-11-20 08:07:43,394 INFO : Initialising browser for kraken test... 08:07:43 INFO - 2015-11-20 08:07:43,406 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmp6eP5Vz/profile http://localhost:49274/getInfo.html 08:07:45 INFO - 2015-11-20 08:07:45,462 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:07:45 INFO - 2015-11-20 08:07:45,462 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:07:45 INFO - 2015-11-20 08:07:45,462 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:07:45 INFO - 2015-11-20 08:07:45,463 DEBUG : BROWSER_OUTPUT: __metrics 08:07:45 INFO - 2015-11-20 08:07:45,481 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:07:46 INFO - 2015-11-20 08:07:46,136 INFO : Browser initialized. 08:07:46 INFO - 2015-11-20 08:07:46,137 INFO : Running cycle 1/1 for kraken test... 08:07:46 INFO - 2015-11-20 08:07:46,137 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmp6eP5Vz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:07:57 INFO - 2015-11-20 08:07:57,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 226074624 08:07:57 INFO - 2015-11-20 08:07:57,948 DEBUG : BROWSER_OUTPUT: 08:08:00 INFO - 2015-11-20 08:08:00,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 08:08:01 INFO - 2015-11-20 08:08:01,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 275398656 08:08:01 INFO - 2015-11-20 08:08:01,059 DEBUG : BROWSER_OUTPUT: 08:08:03 INFO - 2015-11-20 08:08:03,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 08:08:04 INFO - 2015-11-20 08:08:04,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 290594816 08:08:04 INFO - 2015-11-20 08:08:04,223 DEBUG : BROWSER_OUTPUT: 08:08:07 INFO - 2015-11-20 08:08:07,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 08:08:08 INFO - 2015-11-20 08:08:08,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 275202048 08:08:08 INFO - 2015-11-20 08:08:08,149 DEBUG : BROWSER_OUTPUT: 08:08:10 INFO - 2015-11-20 08:08:10,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 08:08:10 INFO - 2015-11-20 08:08:10,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 277843968 08:08:10 INFO - 2015-11-20 08:08:10,693 DEBUG : BROWSER_OUTPUT: 08:08:12 INFO - 2015-11-20 08:08:12,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:08:13 INFO - 2015-11-20 08:08:13,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 278872064 08:08:13 INFO - 2015-11-20 08:08:13,251 DEBUG : BROWSER_OUTPUT: 08:08:15 INFO - 2015-11-20 08:08:15,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 08:08:16 INFO - 2015-11-20 08:08:16,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 280461312 08:08:16 INFO - 2015-11-20 08:08:16,531 DEBUG : BROWSER_OUTPUT: 08:08:19 INFO - 2015-11-20 08:08:19,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 08:08:19 INFO - 2015-11-20 08:08:19,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 279982080 08:08:19 INFO - 2015-11-20 08:08:19,913 DEBUG : BROWSER_OUTPUT: 08:08:22 INFO - 2015-11-20 08:08:22,603 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 08:08:23 INFO - 2015-11-20 08:08:23,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 279932928 08:08:23 INFO - 2015-11-20 08:08:23,197 DEBUG : BROWSER_OUTPUT: 08:08:24 INFO - 2015-11-20 08:08:24,735 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:08:25 INFO - 2015-11-20 08:08:25,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 311717888 08:08:25 INFO - 2015-11-20 08:08:25,312 DEBUG : BROWSER_OUTPUT: 08:08:27 INFO - 2015-11-20 08:08:27,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:08:27 INFO - 2015-11-20 08:08:27,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 311922688 08:08:27 INFO - 2015-11-20 08:08:27,838 DEBUG : BROWSER_OUTPUT: 08:08:29 INFO - 2015-11-20 08:08:29,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:08:30 INFO - 2015-11-20 08:08:30,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 323022848 08:08:30 INFO - 2015-11-20 08:08:30,470 DEBUG : BROWSER_OUTPUT: 08:08:33 INFO - 2015-11-20 08:08:33,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:08:33 INFO - 2015-11-20 08:08:33,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 323940352 08:08:33 INFO - 2015-11-20 08:08:33,622 DEBUG : BROWSER_OUTPUT: 08:08:36 INFO - 2015-11-20 08:08:36,132 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:08:36 INFO - 2015-11-20 08:08:36,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 324579328 08:08:36 INFO - 2015-11-20 08:08:36,736 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,383 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 08:08:38 INFO - 2015-11-20 08:08:38,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 383094784 08:08:38 INFO - 2015-11-20 08:08:38,640 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,640 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:08:38 INFO - 2015-11-20 08:08:38,640 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:08:38 INFO - 2015-11-20 08:08:38,640 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:08:38 INFO - 2015-11-20 08:08:38,640 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:08:38 INFO - 2015-11-20 08:08:38,640 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;105;110;111;109;109;112;103;108 08:08:38 INFO - 2015-11-20 08:08:38,641 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;123;142;155;120;142;138;137;164;119 08:08:38 INFO - 2015-11-20 08:08:38,641 DEBUG : BROWSER_OUTPUT: |2;audio-dft;180;180;182;181;182;234;261;186;185;179 08:08:38 INFO - 2015-11-20 08:08:38,641 DEBUG : BROWSER_OUTPUT: |3;audio-fft;62;70;72;74;80;84;85;75;72;55 08:08:38 INFO - 2015-11-20 08:08:38,641 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;84;86;113;74;76;74;101;76;75;104 08:08:38 INFO - 2015-11-20 08:08:38,641 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;88;87;87;88;87;89;87;88;87;88 08:08:38 INFO - 2015-11-20 08:08:38,641 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;94;94;98;94;93;94;96;94;94;92 08:08:38 INFO - 2015-11-20 08:08:38,641 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;87;86;86;86;85;85;86;87;85;90 08:08:38 INFO - 2015-11-20 08:08:38,641 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;54;54;54;55;55;53;64;53;53 08:08:38 INFO - 2015-11-20 08:08:38,641 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;66;68;65;66;68;67;81;101;102 08:08:38 INFO - 2015-11-20 08:08:38,641 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;82;83;83;83;82;82;85;82 08:08:38 INFO - 2015-11-20 08:08:38,641 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;127;124;111;124;135;130;124;122;119 08:08:38 INFO - 2015-11-20 08:08:38,641 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;124;135;134;144;169;171;136;136;122 08:08:38 INFO - 2015-11-20 08:08:38,641 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;64;65;65;67;64;66;65;66;64 08:08:38 INFO - 2015-11-20 08:08:38,642 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:08:38 INFO - 2015-11-20 08:08:38,642 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:08:38 INFO - 2015-11-20 08:08:38,642 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1025 08:08:38 INFO - 2015-11-20 08:08:38,642 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:08:38 INFO - 2015-11-20 08:08:38,642 DEBUG : BROWSER_OUTPUT: __startTimestamp1448035718635__endTimestamp 08:08:38 INFO - 2015-11-20 08:08:38,642 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,642 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:08:38 INFO - 2015-11-20 08:08:38,642 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:08:38 INFO - 2015-11-20 08:08:38,642 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,642 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:2.75 (2.5%) stddev-sans-first:2.88 08:08:38 INFO - 2015-11-20 08:08:38,642 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 105.0 110.0 111.0 109.0 109.0 112.0 103.0 108.0 08:08:38 INFO - 2015-11-20 08:08:38,643 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,643 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:138.90 Median:142.00 stddev:14.98 (10.6%) stddev-sans-first:15.44 08:08:38 INFO - 2015-11-20 08:08:38,643 DEBUG : BROWSER_OUTPUT: Values: 149.0 123.0 142.0 155.0 120.0 142.0 138.0 137.0 164.0 119.0 08:08:38 INFO - 2015-11-20 08:08:38,643 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,643 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:195.00 Median:183.50 stddev:28.48 (15.5%) stddev-sans-first:29.68 08:08:38 INFO - 2015-11-20 08:08:38,643 DEBUG : BROWSER_OUTPUT: Values: 180.0 180.0 182.0 181.0 182.0 234.0 261.0 186.0 185.0 179.0 08:08:38 INFO - 2015-11-20 08:08:38,643 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,643 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:72.90 Median:74.50 stddev:9.28 (12.5%) stddev-sans-first:8.96 08:08:38 INFO - 2015-11-20 08:08:38,643 DEBUG : BROWSER_OUTPUT: Values: 62.0 70.0 72.0 74.0 80.0 84.0 85.0 75.0 72.0 55.0 08:08:38 INFO - 2015-11-20 08:08:38,643 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,643 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:86.30 Median:75.50 stddev:14.49 (19.2%) stddev-sans-first:15.35 08:08:38 INFO - 2015-11-20 08:08:38,643 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 113.0 74.0 76.0 74.0 101.0 76.0 75.0 104.0 08:08:38 INFO - 2015-11-20 08:08:38,643 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,643 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 08:08:38 INFO - 2015-11-20 08:08:38,644 DEBUG : BROWSER_OUTPUT: Values: 88.0 87.0 87.0 88.0 87.0 89.0 87.0 88.0 87.0 88.0 08:08:38 INFO - 2015-11-20 08:08:38,644 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,644 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:1.64 (1.7%) stddev-sans-first:1.73 08:08:38 INFO - 2015-11-20 08:08:38,644 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 98.0 94.0 93.0 94.0 96.0 94.0 94.0 92.0 08:08:38 INFO - 2015-11-20 08:08:38,644 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,644 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:86.30 Median:86.00 stddev:1.49 (1.7%) stddev-sans-first:1.56 08:08:38 INFO - 2015-11-20 08:08:38,644 DEBUG : BROWSER_OUTPUT: Values: 87.0 86.0 86.0 86.0 85.0 85.0 86.0 87.0 85.0 90.0 08:08:38 INFO - 2015-11-20 08:08:38,644 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,644 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.50 stddev:3.33 (6.1%) stddev-sans-first:3.46 08:08:38 INFO - 2015-11-20 08:08:38,644 DEBUG : BROWSER_OUTPUT: Values: 57.0 54.0 54.0 54.0 55.0 55.0 53.0 64.0 53.0 53.0 08:08:38 INFO - 2015-11-20 08:08:38,644 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,644 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:74.80 Median:66.50 stddev:14.85 (22.3%) stddev-sans-first:15.23 08:08:38 INFO - 2015-11-20 08:08:38,644 DEBUG : BROWSER_OUTPUT: Values: 64.0 66.0 68.0 65.0 66.0 68.0 67.0 81.0 101.0 102.0 08:08:38 INFO - 2015-11-20 08:08:38,644 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,644 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 08:08:38 INFO - 2015-11-20 08:08:38,645 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 82.0 83.0 83.0 83.0 82.0 82.0 85.0 82.0 08:08:38 INFO - 2015-11-20 08:08:38,645 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,645 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:125.50 stddev:6.55 (5.2%) stddev-sans-first:6.75 08:08:38 INFO - 2015-11-20 08:08:38,645 DEBUG : BROWSER_OUTPUT: Values: 129.0 127.0 124.0 111.0 124.0 135.0 130.0 124.0 122.0 119.0 08:08:38 INFO - 2015-11-20 08:08:38,645 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,645 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.50 Median:136.00 stddev:16.75 (12.3%) stddev-sans-first:17.60 08:08:38 INFO - 2015-11-20 08:08:38,645 DEBUG : BROWSER_OUTPUT: Values: 134.0 124.0 135.0 134.0 144.0 169.0 171.0 136.0 136.0 122.0 08:08:38 INFO - 2015-11-20 08:08:38,645 DEBUG : BROWSER_OUTPUT: 08:08:38 INFO - 2015-11-20 08:08:38,645 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.05 (1.6%) stddev-sans-first:1.05 08:08:38 INFO - 2015-11-20 08:08:38,645 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 65.0 65.0 67.0 64.0 66.0 65.0 66.0 64.0 08:08:38 INFO - 2015-11-20 08:08:38,645 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:08:38 INFO - 2015-11-20 08:08:38,645 DEBUG : BROWSER_OUTPUT: 08:08:39 INFO - 2015-11-20 08:08:39,261 INFO : Browser exited with error code: 0 08:08:39 INFO - 2015-11-20 08:08:39,307 INFO : Completed test kraken (00:00:55) 08:08:39 INFO - 2015-11-20 08:08:39,307 INFO : Starting test v8_7 08:08:39 INFO - 2015-11-20 08:08:39,307 DEBUG : operating with platform_type : mac_ 08:08:39 INFO - 2015-11-20 08:08:39,307 INFO : Initialising browser for v8_7 test... 08:08:39 INFO - 2015-11-20 08:08:39,319 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpoSfIA2/profile http://localhost:49274/getInfo.html 08:08:41 INFO - 2015-11-20 08:08:41,146 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:08:41 INFO - 2015-11-20 08:08:41,146 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:08:41 INFO - 2015-11-20 08:08:41,146 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:08:41 INFO - 2015-11-20 08:08:41,146 DEBUG : BROWSER_OUTPUT: __metrics 08:08:41 INFO - 2015-11-20 08:08:41,163 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:08:41 INFO - 2015-11-20 08:08:41,948 INFO : Browser initialized. 08:08:41 INFO - 2015-11-20 08:08:41,948 INFO : Running cycle 1/1 for v8_7 test... 08:08:41 INFO - 2015-11-20 08:08:41,948 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpoSfIA2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:08:53 INFO - 2015-11-20 08:08:53,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 225976320 08:08:53 INFO - 2015-11-20 08:08:53,855 DEBUG : BROWSER_OUTPUT: 08:09:15 INFO - 2015-11-20 08:09:15,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/v8_7/run.html (next: http://localhost:49274/tests/v8_7/run.html) 08:09:15 INFO - 2015-11-20 08:09:15,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 716341248 08:09:15 INFO - 2015-11-20 08:09:15,619 DEBUG : BROWSER_OUTPUT: 08:09:15 INFO - 2015-11-20 08:09:15,620 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:09:15 INFO - 2015-11-20 08:09:15,620 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:09:15 INFO - 2015-11-20 08:09:15,620 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:09:15 INFO - 2015-11-20 08:09:15,620 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:09:15 INFO - 2015-11-20 08:09:15,620 DEBUG : BROWSER_OUTPUT: |0;Richards;148.214021046391 08:09:15 INFO - 2015-11-20 08:09:15,620 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.16035455278 08:09:15 INFO - 2015-11-20 08:09:15,620 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.30670470756064 08:09:15 INFO - 2015-11-20 08:09:15,620 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4748.815165876777 08:09:15 INFO - 2015-11-20 08:09:15,620 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1699.490662139219 08:09:15 INFO - 2015-11-20 08:09:15,620 DEBUG : BROWSER_OUTPUT: |5;Earley;782.4726134585289 08:09:15 INFO - 2015-11-20 08:09:15,620 DEBUG : BROWSER_OUTPUT: |6;Boyer;12506.172839506173 08:09:15 INFO - 2015-11-20 08:09:15,621 DEBUG : BROWSER_OUTPUT: |7;RegExp;27648.64864864865 08:09:15 INFO - 2015-11-20 08:09:15,621 DEBUG : BROWSER_OUTPUT: |8;Splay;652.8228423101882 08:09:15 INFO - 2015-11-20 08:09:15,621 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4533.93665158371 08:09:15 INFO - 2015-11-20 08:09:15,621 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:09:15 INFO - 2015-11-20 08:09:15,621 DEBUG : BROWSER_OUTPUT: __startTimestamp1448035755615__endTimestamp 08:09:15 INFO - 2015-11-20 08:09:15,621 DEBUG : BROWSER_OUTPUT: 08:09:15 INFO - 2015-11-20 08:09:15,621 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:09:15 INFO - 2015-11-20 08:09:15,621 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:09:15 INFO - 2015-11-20 08:09:15,621 DEBUG : BROWSER_OUTPUT: 08:09:15 INFO - 2015-11-20 08:09:15,621 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:148.21 Median:148.21 stddev:0.00 (0.0%) 08:09:15 INFO - 2015-11-20 08:09:15,621 DEBUG : BROWSER_OUTPUT: Values: 148.2 08:09:15 INFO - 2015-11-20 08:09:15,621 DEBUG : BROWSER_OUTPUT: 08:09:15 INFO - 2015-11-20 08:09:15,621 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.16 Median:161.16 stddev:0.00 (0.0%) 08:09:15 INFO - 2015-11-20 08:09:15,621 DEBUG : BROWSER_OUTPUT: Values: 161.2 08:09:15 INFO - 2015-11-20 08:09:15,622 DEBUG : BROWSER_OUTPUT: 08:09:15 INFO - 2015-11-20 08:09:15,622 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.31 Median:285.31 stddev:0.00 (0.0%) 08:09:15 INFO - 2015-11-20 08:09:15,622 DEBUG : BROWSER_OUTPUT: Values: 285.3 08:09:15 INFO - 2015-11-20 08:09:15,622 DEBUG : BROWSER_OUTPUT: 08:09:15 INFO - 2015-11-20 08:09:15,622 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4748.82 Median:4748.82 stddev:0.00 (0.0%) 08:09:15 INFO - 2015-11-20 08:09:15,622 DEBUG : BROWSER_OUTPUT: Values: 4748.8 08:09:15 INFO - 2015-11-20 08:09:15,622 DEBUG : BROWSER_OUTPUT: 08:09:15 INFO - 2015-11-20 08:09:15,622 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1699.49 Median:1699.49 stddev:0.00 (0.0%) 08:09:15 INFO - 2015-11-20 08:09:15,622 DEBUG : BROWSER_OUTPUT: Values: 1699.5 08:09:15 INFO - 2015-11-20 08:09:15,622 DEBUG : BROWSER_OUTPUT: 08:09:15 INFO - 2015-11-20 08:09:15,622 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:782.47 Median:782.47 stddev:0.00 (0.0%) 08:09:15 INFO - 2015-11-20 08:09:15,622 DEBUG : BROWSER_OUTPUT: Values: 782.5 08:09:15 INFO - 2015-11-20 08:09:15,622 DEBUG : BROWSER_OUTPUT: 08:09:15 INFO - 2015-11-20 08:09:15,622 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12506.17 Median:12506.17 stddev:0.00 (0.0%) 08:09:15 INFO - 2015-11-20 08:09:15,622 DEBUG : BROWSER_OUTPUT: Values: 12506.2 08:09:15 INFO - 2015-11-20 08:09:15,623 DEBUG : BROWSER_OUTPUT: 08:09:15 INFO - 2015-11-20 08:09:15,623 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27648.65 Median:27648.65 stddev:0.00 (0.0%) 08:09:15 INFO - 2015-11-20 08:09:15,623 DEBUG : BROWSER_OUTPUT: Values: 27648.6 08:09:15 INFO - 2015-11-20 08:09:15,623 DEBUG : BROWSER_OUTPUT: 08:09:15 INFO - 2015-11-20 08:09:15,623 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:652.82 Median:652.82 stddev:0.00 (0.0%) 08:09:15 INFO - 2015-11-20 08:09:15,623 DEBUG : BROWSER_OUTPUT: Values: 652.8 08:09:15 INFO - 2015-11-20 08:09:15,623 DEBUG : BROWSER_OUTPUT: 08:09:15 INFO - 2015-11-20 08:09:15,623 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4533.94 Median:4533.94 stddev:0.00 (0.0%) 08:09:15 INFO - 2015-11-20 08:09:15,623 DEBUG : BROWSER_OUTPUT: Values: 4533.9 08:09:15 INFO - 2015-11-20 08:09:15,623 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:09:15 INFO - 2015-11-20 08:09:15,623 DEBUG : BROWSER_OUTPUT: 08:09:16 INFO - 2015-11-20 08:09:16,238 INFO : Browser exited with error code: 0 08:09:16 INFO - 2015-11-20 08:09:16,255 INFO : Completed test v8_7 (00:00:36) 08:09:16 INFO - 2015-11-20 08:09:16,604 INFO : Completed test suite (00:20:07) 08:09:16 INFO - 2015-11-20 08:09:16,604 DEBUG : Working with test: dromaeo_css 08:09:16 INFO - 2015-11-20 08:09:16,604 DEBUG : Generating results file: dromaeo_css 08:09:16 INFO - 2015-11-20 08:09:16,605 DEBUG : Working with test: kraken 08:09:16 INFO - 2015-11-20 08:09:16,605 DEBUG : Generating results file: kraken 08:09:16 INFO - 2015-11-20 08:09:16,605 INFO : javascript benchmark 08:09:16 INFO - 2015-11-20 08:09:16,606 DEBUG : Working with test: v8_7 08:09:16 INFO - 2015-11-20 08:09:16,606 DEBUG : Generating results file: v8_7 08:09:16 INFO - 2015-11-20 08:09:16,606 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:09:16 INFO - 2015-11-20 08:09:16,658 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 08:09:16 INFO - 2015-11-20 08:09:16,659 DEBUG : process_Request line: dromaeo_css 7710.99 graph.html#tests=[[72,64,59]] 08:09:16 INFO - 2015-11-20 08:09:16,659 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:09:16 INFO - 2015-11-20 08:09:16,683 DEBUG : process_Request line: kraken 1412.90 graph.html#tests=[[232,64,59]] 08:09:16 INFO - 2015-11-20 08:09:16,684 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:09:16 INFO - 2015-11-20 08:09:16,711 DEBUG : process_Request line: v8_7 20657.64 graph.html#tests=[[230,64,59]] 08:09:16 INFO - 2015-11-20 08:09:16,712 INFO : javascript benchmark 08:09:16 INFO - 2015-11-20 08:09:16,714 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3175.523671449282, 3489.6859282664554, 3502.1594817243863, 3508.9122771930715, 3543.8050907200095, 4664.906701865961, 5655.349634792, 5796.913046304308, 5920.970395148029, 5958.553108516857, 5830.416958304168, 5919.230500035, 5923.229980102591, 5923.792667256647, 5933.88132237355, 5300.125479295921, 5322.2814919985885, 5371.5165635092835, 5391.110466772997, 5413.323334583177, 5419.891602167954, 5422.915416916613, 5431.293931788862, 5432.483914028161, 5436.238926550286, 5339.759710813003, 5410.783568657249, 5417.431169727181, 5426.158945363475, 5434.7826086956475, 5384.596155288349, 5412.025835349656, 5418.458154184589, 5421.783128674848, 5427.972860135714, 5236.7119808410525, 5245.055889939809, 5352.812651557177, 5367.409584945653, 5386.91919621206, 5812.331581868097, 5939.376365481606, 5954.434328738763, 5954.761809527657, 5962.940370596282, 6354.173957385557, 6387.169667943184, 6391.744330226786, 6396.488280937514, 6397.328280530523, 6204.5967012144065, 6216.564840461169, 6303.716332765037, 6304.148939893102, 6333.429991300759, 4443.0, 6043.09353596964, 6057.818265452043, 6079.240094988127, 6092.086187071886, 6438.678066096676, 6479.125318082093, 6488.967555162289, 6494.870102597922, 6507.121538592324, 6140.9030504681, 6152.230971128609, 6279.780207692709, 6280.214973128359, 6291.465225455888, 6330.303666596671, 6354.17395738551, 6362.77730279438, 6373.872522549523, 6378.712957916905, 6305.621662700252, 6358.109864618957, 6363.268224154189, 6372.617642941438, 6372.776952806722, 6132.011916702835, 6197.349278325801, 6333.493320534346, 6343.080253363329, 6344.080108384258, 5055.292259083732, 5057.544820966131, 5076.517730815566, 5084.542391184737, 5117.053345131163, 4521.84173553924, 4534.818607255673, 4544.431946006749, 4575.450945886449, 4578.519255478127, 5883.735231914574, 5987.161797348374, 6031.215941927521, 6042.546808989343, 6043.939560604338, 6284.811455656338, 6288.811335659938, 6294.307626161119, 6301.14934483848, 6303.0, 5955.196048533479, 5999.730012149464, 6007.879842403215, 6017.969910150508, 6029.155918171459, 5560.388357280696, 5566.025945459528, 5573.331200255995, 5577.609567330329, 5578.9163162552595, 5488.231647569343, 6397.360263973565, 6419.16550848396, 6451.096846441502, 6476.0, 6386.425221730066, 6398.744050238124, 6404.071409645482, 6406.071119687713, 6416.935830641633, 6552.410283074546, 6569.9343006571235, 6573.638449885111, 6576.967115164393, 6595.637239951849, 6138.57030007913, 6239.251289845248, 6265.342139075331, 6277.466415354564, 6341.841453963503, 6187.0, 6363.490920726424, 6363.713632886439, 6365.52258580599, 6378.585391949508, 6339.461145802658, 6348.682565871781, 6366.80899572995, 6368.904466432915, 6373.075903993988, 6111.236095488064, 6181.598196117238, 6194.163787888578, 6201.255849298113, 6342.778002769881, 6195.349488303663, 6202.193714817045, 6212.937870621236, 6223.533235007483, 6243.188385510036, 6358.872822543616, 6360.459360954371, 6367.0, 6367.044943258548, 6381.585196962183, 5979.4917432018765, 6044.667543285162, 6087.914487330863, 6098.237720284965, 6263.185785847811], "unit": "ms", "name": "dojo.html", "value": 5850.6287278368545}, {"lowerIsBetter": false, "replicates": [555.316960139029, 567.7388401335387, 586.691986706979, 608.4219991008541, 660.428729149286, 32086.0, 32523.837380813093, 40073.0, 41508.58491415085, 41580.79209603955, 43932.560674393244, 44247.0, 44349.33475997855, 44410.777946110225, 44503.77748111263, 8881.73354799357, 9751.609935602568, 9965.900340996606, 9967.401955882635, 9980.900190998069, 8874.86687699685, 11762.353070581115, 11919.40402979852, 11950.0, 11953.880461195364, 11691.12316576256, 11791.702912679599, 11798.764024719501, 11817.822732659017, 11831.704207394798, 8982.056884027214, 9181.311401644904, 11732.589359372423, 11907.64277071685, 11986.981106605948, 10069.496525173785, 11754.882451175465, 11922.582709605122, 11940.641780746591, 11955.983741381993, 33674.32651346984, 41542.376864346756, 41562.96092597679, 41615.37576936348, 41626.791866040476, 3230.951535726966, 3273.5089736539708, 3502.1944952660774, 3529.2588556403184, 3676.9448458273146, 23402.882985585133, 29044.709552904413, 30180.396392072034, 30246.24384390386, 30415.695843041507, 2783.6937936826935, 2825.9858700706573, 2896.131160651817, 2917.0519581136004, 3010.3377257003426, 517733.0, 522476.0, 522631.0, 523334.0, 524178.0, 52854.471455284955, 58485.70757146272, 59266.0, 72616.27383726095, 72970.0, 58673.70663146657, 61838.0, 67771.96684099485, 69965.65017174881, 70835.0, 16719.582010449834, 16920.57698557546, 16943.576410589587, 16970.660586788195, 16993.0, 12798.360081995863, 12882.35588220604, 12895.935520322526, 12896.548620798227, 12934.547290844775, 17456.5635859102, 21126.9436528173, 21329.25347612857, 21511.354659360244, 21559.78440215578, 9224.677136300197, 9442.952785236168, 9467.0, 9507.809843803223, 9572.61709531625, 924.6347692661361, 968.8885778135464, 983.6753871222479, 1028.218553899042, 1115.8214685650419, 28992.275193120342, 29465.11604651864, 29498.410031799245, 29918.700812992025, 30046.54930176049, 961.1781926452783, 1080.4921686807345, 1084.9457527123611, 1131.7510147767478, 1156.4564654612318, 13277.933610331887, 15314.157721325435, 16465.0, 16587.91706041462, 16799.91600041992, 662343.0774076455, 668956.0, 669509.0, 670877.0, 673584.0, 61531.0, 61906.69046654738, 61958.66289359792, 62045.0, 62075.37924620786, 1458.649924018228, 1476.0553245922833, 1491.0531812299268, 1494.9476768313057, 1624.5370069530127, 28222.435551288447, 28277.71722282751, 32116.67883321137, 32273.677263227066, 32608.34783304368, 47382.0, 48582.514174859214, 51535.0, 54334.45665543452, 54463.455365445836, 512670.0, 514095.0, 516080.0, 516854.0, 516984.0, 27364.72635273622, 27673.0, 27767.30581735473, 32570.185745355608, 32984.175395615304, 35677.286454271285, 40724.59275407208, 42709.086765681335, 43442.565574343855, 43486.0, 34401.795937143084, 35007.649923501456, 35228.0, 40377.596224038556, 41565.584344156174, 31368.0, 37113.25773484569, 37933.0, 37974.62025379822, 38507.0, 27933.720662793112, 36690.26619467649, 37463.250734984606, 37750.43374349332, 38048.42927356147, 26483.205503834917, 31982.68017319797, 32818.17954551155, 32836.34327313488, 32899.34201316008, 23785.075462548484, 24424.511509770062, 24450.633240501764, 24696.753032469445, 25208.495830083662], "unit": "ms", "name": "ext.html", "value": 20589.78142516965}, {"lowerIsBetter": false, "replicates": [363.965423284788, 365.4919661670278, 368.3756033523179, 368.57981900633297, 368.73082649665736, 16133.515994520154, 17784.0, 19869.801301986976, 20569.38291851245, 21240.256591019297, 19668.508287292825, 19759.60480790387, 19762.703559446585, 19823.40529784105, 19861.801381986177, 4008.418779277003, 5027.8240261590945, 5187.6628019178825, 5188.766505507261, 5195.636305458619, 4097.037196258877, 4131.73143745657, 5821.970890145543, 6001.519878409738, 6007.819765407023, 5890.5582081343855, 5967.970160149193, 5968.641881487103, 5989.401059894019, 6509.088727578142, 6396.328385519523, 6399.168108145957, 6433.131527243832, 6438.903416448757, 6465.676716164173, 4689.226277664181, 5492.203630473559, 5613.382527921925, 5667.943320566824, 5668.234788303609, 13291.401886915111, 13297.069205155643, 13300.467981280737, 21076.15695372183, 25719.61420578693, 2177.9891100544555, 2217.467807726134, 2233.7877901599322, 2252.583272094668, 2611.5038142752815, 9785.755356116082, 9789.608415663364, 10131.746706332327, 10149.188064954786, 11720.355380454072, 1722.6726921884801, 1726.5252055684662, 1738.2699266308182, 1750.3436211420717, 1765.6428667728599, 83426.0, 104565.0, 109361.0, 110961.33557996637, 112490.0, 10522.526486308134, 10941.015308622262, 11044.668659940215, 11072.778544429066, 11141.108711303077, 13161.53934612284, 13254.602361929157, 13256.469741210436, 13266.933665331611, 13302.667433314244, 8552.102029286836, 8552.486850788973, 8559.186877246777, 8610.483370997761, 8619.655213791379, 8740.519271440005, 8764.649414023495, 8778.0, 8855.73432797017, 8863.2466240369, 3592.389293820057, 4253.213155566168, 4299.419578356944, 4325.416068830667, 4360.4331436913635, 1611.58904479357, 1659.5270347950775, 1726.5942503511665, 1763.9647207055787, 1764.0826770079743, 890.844102282111, 943.8961714211431, 970.0299700299701, 1013.5911083593663, 1087.1574529739514, 18989.810101898805, 19881.900590497244, 19980.30068947609, 20051.498712532302, 20341.796582034287, 882.4220135811054, 993.4933184076028, 993.8757655293089, 1029.6756521695793, 1042.7341028037802, 10025.24810639205, 10686.407264327525, 10719.42158664216, 10722.533817222082, 10765.461726913623, 759270.0, 759875.0, 760204.0, 775005.0, 778786.0, 95501.5224923871, 107736.69053237783, 112364.0, 117736.23395649072, 120244.0, 1069.0752499088233, 1112.2158877990996, 1126.245415571569, 1130.8077626803463, 1160.3328086350382, 17665.823341766933, 17666.205020774352, 17775.555611109827, 17810.554736131184, 18235.088245587933, 47850.04299914052, 47954.76022619865, 50392.8070018208, 52916.73541632267, 53473.0, 69778.95331570132, 70104.6494767523, 70841.64579177072, 70900.22749431306, 71428.0, 9538.0, 9736.513174341397, 9789.216862650828, 9799.167070799062, 10057.798844023226, 16429.671406571564, 19795.703064453755, 19899.204031838563, 20003.499912502302, 20032.098555564742, 15560.766588500956, 15625.921870390575, 15738.370465181722, 16186.190690465664, 16275.18624068768, 15374.769378459556, 15472.767908481606, 15770.974886632332, 15908.125053122189, 16271.430499932445, 16161.353545858034, 16191.028538287741, 16502.75245871337, 16687.0, 16688.499345019667, 9615.0, 9727.951360243154, 9740.61037558518, 9825.85261221068, 9899.406035637885, 12805.359732013549, 15543.611409714395, 15781.974171678805, 15943.601409964844, 16178.595535111717], "unit": "ms", "name": "jquery.html", "value": 9869.570141907081}, {"lowerIsBetter": false, "replicates": [1558.5713928669616, 1648.2006226979904, 1683.6464342488077, 1980.8514361422897, 1983.7718662353834, 7512.6243687815595, 7910.723124690637, 8212.343012558997, 8540.871886921701, 8542.145785421455, 8353.415260931737, 8501.0, 8560.357973152008, 8560.571971401436, 8568.614412351444, 2130.595186914489, 2180.051677520276, 2392.41385860464, 2414.14297924237, 2419.7822196002357, 2166.7833216678287, 2200.0, 2209.5028618560855, 2210.2264207527396, 2339.695839540866, 2352.2825538210923, 2391.7608239176116, 2396.6524853896176, 2396.9880150599224, 2398.832081754269, 2404.290734233405, 2422.624493203556, 2426.078090325665, 2429.708434987813, 2431.465077682907, 2163.8809865457392, 2214.258223495131, 2215.069670738294, 2375.477394973103, 2423.7455067217866, 8410.03284622264, 8554.05905350411, 8554.443961142568, 8555.23002929733, 8562.443441176365, 4402.2296098183015, 4453.955460445386, 5259.237410575445, 5313.256144139824, 5319.148936170194, 3522.2427178156818, 3569.660882216211, 3613.6205698401814, 3617.385044542434, 3641.5448068991377, 1042.1142029275131, 1046.4296958157822, 1052.58422922945, 1080.1574771678104, 1083.9078678312353, 9704.369216001009, 11315.377654229014, 11332.0, 11357.943210283978, 11363.31820090789, 3982.2433737589763, 4643.466001409881, 4671.95328046722, 4732.0, 4734.360861283752, 9758.170555502862, 9773.315867889321, 9778.462184579916, 9791.069848364394, 9806.705798825904, 5282.392524859613, 5304.549113325411, 5310.203469479532, 5312.335958005249, 5323.653962492425, 4825.95174048262, 4860.222364421676, 4871.926921096187, 4876.097921884392, 4876.4879687633, 3797.2785170817456, 3895.14306852492, 3905.3946638271113, 3911.041794760245, 3923.489946306962, 1279.2836011833404, 1294.3851670456645, 1299.3762993763046, 1304.2565737529517, 1306.7778477658821, 1063.824468962628, 1081.4862940103387, 1081.7566047639375, 1260.0, 1306.0661626936596, 7282.599457029914, 7865.859450379778, 7955.045394552691, 7966.083900351534, 7967.282944534903, 496.54318027414865, 503.6424138861376, 507.55588859747724, 509.4625170445142, 511.89250257446355, 5684.403137670568, 5796.043652797325, 5811.070228763462, 6192.318844927055, 6222.968885155636, 10025.348352357074, 10334.018268264503, 10344.948275258726, 10348.275620706478, 10374.22193335503, 9955.950220248997, 10238.744031399274, 10284.971502849805, 10307.381557106448, 10320.0, 6445.452136568444, 7803.648835802403, 7817.5309481431295, 7847.607619618996, 7983.8403231935035, 6709.463242940651, 7747.573883436465, 7760.84478310442, 7854.567998760123, 7877.6455059523605, 8223.835523289621, 8832.602532885907, 9171.495567743837, 9183.311251656287, 9308.348415610842, 9173.036831132635, 9378.577963991773, 9381.577828997575, 9390.389624674373, 9530.904690953003, 7187.9640601796655, 7225.060742103493, 7258.528195667264, 7280.0, 7288.927110728825, 7975.920240797518, 8024.358051355995, 8029.397795165269, 8035.477693949874, 8059.355251579742, 7288.781336559911, 7496.100467943882, 7575.962120189364, 7580.030431140713, 7594.354479869273, 7279.963600181965, 7374.188839227573, 7469.626518673936, 7494.925050749423, 7551.207123251979, 7502.624868756649, 7536.057992750906, 7538.585377804274, 7541.509801862861, 7543.585102819397, 6717.0, 6773.0, 6792.524523283323, 6793.864122717617, 6855.143107111611, 6880.208775990825, 6936.895946560907, 6937.445004399737, 6938.965305173442, 6949.895751563629], "unit": "ms", "name": "mootools.html", "value": 4680.910013090737}, {"lowerIsBetter": false, "replicates": [320.2074864709843, 329.2920221523725, 331.4845415379085, 332.49294825391263, 335.9798412095273, 6790.253072162064, 6811.6253606051705, 6812.046313516099, 6816.556923799956, 6837.213720422153, 5373.382061062979, 6442.8067157985215, 6574.671266436683, 6607.636579988099, 6621.139251897259, 4069.613386728256, 4382.320740285245, 4537.729435757977, 4791.736454495001, 5009.549140577347, 4620.0, 5034.0, 5036.6726162799305, 5043.319151914499, 5045.470225626312, 4755.714657120567, 4847.563719265266, 4849.296851956464, 4962.727050012248, 4967.602591792648, 4940.950590494085, 4946.950530494721, 4964.0, 4994.475580064095, 5009.524095210949, 3560.3235385276716, 4242.321228603409, 4243.448351714257, 4249.320108782611, 4255.553111941955, 6354.968225158845, 6576.473882089469, 6592.04415359775, 6601.471882249457, 6604.636744979024, 4877.658563900528, 5900.468957793819, 5912.674802885839, 5973.253343332083, 5982.820515384546, 5930.644161350289, 7254.455915806336, 7261.273872612749, 7291.963540182318, 7309.076369452262, 4779.235322348408, 4782.30656554801, 4783.736894470802, 4783.856484305476, 4786.688865223749, 6765.255821859591, 7525.247475252431, 7546.69813207471, 7784.143744188134, 7803.0, 4855.708657480492, 4911.656184067152, 4929.531694489017, 4933.481984391659, 4937.40751109862, 5008.248762685626, 5008.5993120550265, 5008.974955125201, 5014.774335154927, 5024.824131155392, 5769.307683078057, 5962.525551896001, 5985.910211346833, 5988.101784732238, 5994.0, 7352.264773522712, 7369.29991650803, 7372.0, 7376.926230737624, 7389.408847292204, 1724.8275172482902, 1742.2421246757701, 1742.2943707798363, 1743.651269746056, 1747.519432156167, 924.9398789078689, 952.1906379577442, 1118.6867677050438, 1130.6721050895312, 1146.587228597704, 7038.542494737826, 7040.823979400556, 7065.505414620927, 7072.71709131629, 7074.115735533059, 7419.740309089156, 7674.577898215652, 7689.154193038761, 7703.691852325845, 7705.113911900204, 5743.798967036134, 6930.410915072174, 7017.157941047107, 7129.073220481304, 7159.3914517265575, 4085.5710150433774, 4090.6113919178224, 4111.7944102794745, 4112.300908845504, 4115.238680844053, 7883.684652613946, 8001.15987821282, 8072.475289106189, 8078.676852925817, 8103.392245581605, 6444.645544495098, 7999.88004678176, 8006.559639219899, 8017.198280171936, 8022.3983201260135, 8037.437379383504, 8040.437169398203, 8060.919390806017, 8061.395395345373, 8074.273315401525, 7467.962660186664, 7768.339691126317, 7773.18381569927, 7779.299863012356, 7780.2219778021745, 6590.275069742421, 7587.544747315179, 7587.924120758722, 7588.658510367157, 7598.772036838904, 7742.7677169685, 8014.799630009296, 8028.956235689323, 8034.638441270274, 8056.033276006917, 4953.801847926186, 4956.330895329084, 4958.752062396938, 4961.652684312064, 4962.5533701967, 6586.8353291168105, 7691.846163076595, 7701.075870895528, 7704.30661240491, 7712.5758083305955, 7101.4673899458785, 7134.286571342825, 7400.333969942731, 7404.481686281909, 7421.0723659542555, 6052.515798736179, 7380.704771809067, 7382.187959324363, 7393.223711510214, 7404.481686281909, 7193.568385896863, 7201.891971620535, 7202.279772022755, 7215.2063273038875, 7229.277072292729, 7133.787256166568, 7392.96303518479, 7394.408447324094, 7412.110546734426, 7416.480846340704, 6931.0, 7102.3962963148715, 7210.567365958059, 7220.530665506725, 7226.855462890608], "unit": "ms", "name": "prototype.html", "value": 5332.9825130288245}, {"lowerIsBetter": false, "replicates": [733.2557454184001, 810.3193317613208, 814.5397850214632, 818.0714888601437, 843.9239969039473, 15133.470328538504, 15212.54362369128, 15523.844761552382, 15556.688866222668, 15563.533094007184, 14569.417223311082, 14658.340374683139, 14677.119372837637, 14691.55925322242, 14708.852911470882, 767.6200280860953, 770.7148355108618, 957.7174733453613, 981.5730157381527, 983.6852207293668, 766.9808254793619, 773.404478551515, 967.8403063494515, 972.5963725054129, 973.0464145137769, 944.2823454174842, 992.4789485520088, 1011.5195282240913, 1013.9188864890828, 1014.5738789708304, 808.1675873849944, 811.4482152136545, 1007.8790545134594, 1008.9293749437543, 1014.9391036537794, 601.897677394844, 745.3776096959045, 748.3863232149639, 749.6027105634023, 750.2722359311459, 15264.694706105927, 15374.538763837103, 15425.922870385688, 15437.996530225611, 15452.845471545366, 12633.052521060865, 12664.4301006454, 12883.098183127186, 12915.031372646996, 12976.740465190644, 10254.179665626732, 10339.741506462398, 10343.637972670997, 10344.32761870476, 10472.057514823626, 3541.3094446582927, 3568.982155089234, 3580.4092324766384, 3588.5873124590744, 3596.37063513884, 82395.58802206011, 82750.58624706898, 83678.99999999939, 84383.15616843876, 84398.57800711019, 7900.644470998819, 9772.804543909082, 9924.305298629026, 10007.0, 10411.323263987817, 21969.0, 22213.666794998087, 22215.889205539657, 22245.22141725032, 22267.443313917283, 7178.38983686382, 7353.522021068614, 7569.0, 7632.122305934778, 7655.387568994467, 3639.5996440391536, 3920.4315374270573, 4014.3777714454304, 4076.5515793262716, 4098.446709694213, 3533.840977156034, 3556.7688100273917, 3573.427691815593, 3576.123849656851, 3579.49887015818, 649.6686689788243, 657.7434800427837, 658.1937127019363, 658.8879890418544, 661.0876989754108, 481.279426051866, 510.7471801458302, 522.7464679630376, 541.4666553444854, 557.76016312985, 8627.827443451222, 9160.6793762218, 9232.584533696, 9261.629534818667, 9607.991160928143, 525.4587774592176, 562.9978638024323, 600.3876046432614, 604.3473049106954, 626.8564786759516, 3900.941485877714, 4043.0, 4074.103697186614, 4102.50769907613, 4206.978965105155, 101704.0, 102232.48883755683, 103528.0, 103825.0, 104178.0, 84428.57785711155, 84630.73053904196, 85253.0, 85317.0, 86713.0, 65676.34323656702, 72628.0, 75133.62433187908, 75285.62357188179, 75855.86216206761, 7042.260562640849, 8488.320934325362, 8777.297816174563, 8896.377253592187, 9061.320400969822, 43140.568594313656, 53316.733416334224, 54269.45730542644, 56223.0, 56668.43331566631, 72938.63530682313, 75408.0, 75656.62171689326, 76636.85044724222, 77034.2296577027, 11020.008199262105, 11260.268082574607, 11341.036011938748, 11423.657290281304, 11804.940975295069, 11291.3789741565, 11380.203385763249, 11526.94236528812, 11703.005244554308, 12117.09121815885, 9498.287628427757, 11531.769364612828, 11727.061835053004, 11855.288682679067, 12133.878661213628, 11543.942280288546, 11608.593699220486, 11941.044716422492, 11952.521899123938, 12319.0, 11541.884581154081, 11632.0, 11634.825477617673, 11653.184277100521, 12267.815982760445, 9690.224782017282, 9894.356866803635, 9954.950225248827, 10146.391216527032, 10273.126784223425, 8267.421280510307, 8705.47767133974, 8841.823163536565, 9275.76810579741, 10087.798244034931], "unit": "ms", "name": "yui.html", "value": 7082.237612715313}], "name": "dromaeo_css", "value": 7710.988653306055}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 110.0, 111.0, 109.0, 109.0, 112.0, 103.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [149.0, 123.0, 142.0, 155.0, 120.0, 142.0, 138.0, 137.0, 164.0, 119.0], "unit": "ms", "name": "audio-beat-detection", "value": 138.9}, {"lowerIsBetter": true, "replicates": [180.0, 180.0, 182.0, 181.0, 182.0, 234.0, 261.0, 186.0, 185.0, 179.0], "unit": "ms", "name": "audio-dft", "value": 195.0}, {"lowerIsBetter": true, "replicates": [62.0, 70.0, 72.0, 74.0, 80.0, 84.0, 85.0, 75.0, 72.0, 55.0], "unit": "ms", "name": "audio-fft", "value": 72.9}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 113.0, 74.0, 76.0, 74.0, 101.0, 76.0, 75.0, 104.0], "unit": "ms", "name": "audio-oscillator", "value": 86.3}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 87.0, 88.0, 87.0, 89.0, 87.0, 88.0, 87.0, 88.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 87.6}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 98.0, 94.0, 93.0, 94.0, 96.0, 94.0, 94.0, 92.0], "unit": "ms", "name": "imaging-darkroom", "value": 94.3}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 86.0, 86.0, 85.0, 85.0, 86.0, 87.0, 85.0, 90.0], "unit": "ms", "name": "imaging-desaturate", "value": 86.3}, {"lowerIsBetter": true, "replicates": [57.0, 54.0, 54.0, 54.0, 55.0, 55.0, 53.0, 64.0, 53.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 68.0, 65.0, 66.0, 68.0, 67.0, 81.0, 101.0, 102.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 74.8}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 82.0, 83.0, 83.0, 83.0, 82.0, 82.0, 85.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [129.0, 127.0, 124.0, 111.0, 124.0, 135.0, 130.0, 124.0, 122.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [134.0, 124.0, 135.0, 134.0, 144.0, 169.0, 171.0, 136.0, 136.0, 122.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.5}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 65.0, 67.0, 64.0, 66.0, 65.0, 66.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.0}], "name": "kraken", "value": 1412.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [148.214021046391], "unit": "score", "name": "Richards", "value": 238.18259399999994}, {"lowerIsBetter": false, "replicates": [161.16035455278], "unit": "score", "name": "DeltaBlue", "value": 410.26218999999986}, {"lowerIsBetter": false, "replicates": [285.30670470756064], "unit": "score", "name": "Encrypt", "value": 932.9644049999997}, {"lowerIsBetter": false, "replicates": [4748.815165876777], "unit": "score", "name": "Decrypt", "value": 56.052086826347306}, {"lowerIsBetter": false, "replicates": [1699.490662139219], "unit": "score", "name": "RayTrace", "value": 435.4181028971027}, {"lowerIsBetter": false, "replicates": [782.4726134585289], "unit": "score", "name": "Earley", "value": 851.7397139999999}, {"lowerIsBetter": false, "replicates": [12506.172839506173], "unit": "score", "name": "Boyer", "value": 53.29072359328728}, {"lowerIsBetter": false, "replicates": [27648.64864864865], "unit": "score", "name": "RegExp", "value": 32.94862658846528}, {"lowerIsBetter": false, "replicates": [652.8228423101882], "unit": "score", "name": "Splay", "value": 124.8286590457256}, {"lowerIsBetter": false, "replicates": [4533.93665158371], "unit": "score", "name": "NavierStokes", "value": 327.3093812375252}], "name": "v8_7", "value": 20657.641934023162}]} 08:09:16 INFO - RETURN: dromaeo_css: 7710.99 08:09:16 INFO - RETURN: kraken: 1412.90 08:09:16 INFO - RETURN: v8_7: 20657.64 08:09:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20657.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1412.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7710.99"}}} 08:09:16 INFO - Return code: 0 08:09:16 INFO - # TBPL SUCCESS # 08:09:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:09:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:09:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:09:16 INFO - 2015-11-20 08:09:16.814 screenresolution[1668:10417] starting screenresolution argv=screenresolution get 08:09:16 INFO - 2015-11-20 08:09:16.817 screenresolution[1668:10417] Display 0: 1600x1200x32@60 08:09:16 INFO - 2015-11-20 08:09:16.823 screenresolution[1669:10420] starting screenresolution argv=screenresolution list 08:09:16 INFO - Available Modes on Display 0 08:09:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:09:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:09:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:09:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:09:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:09:17 INFO - Intel Iris: 08:09:17 INFO - Chipset Model: Intel Iris 08:09:17 INFO - Type: GPU 08:09:17 INFO - Bus: Built-In 08:09:17 INFO - VRAM (Dynamic, Max): 1536 MB 08:09:17 INFO - Vendor: Intel (0x8086) 08:09:17 INFO - Device ID: 0x0a2e 08:09:17 INFO - Revision ID: 0x0009 08:09:17 INFO - Displays: 08:09:17 INFO - Display: 08:09:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:09:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:09:17 INFO - Display Serial Number: 1600x1200 60 08:09:17 INFO - Main Display: Yes 08:09:17 INFO - Mirror: Off 08:09:17 INFO - Online: Yes 08:09:17 INFO - Rotation: Supported 08:09:17 INFO - Return code: 0 08:09:17 INFO - Running post-action listener: _resource_record_post_action 08:09:17 INFO - Running post-run listener: _resource_record_post_run 08:09:18 INFO - Total resource usage - Wall time: 1239s; CPU: 52.0%; Read bytes: 33631744; Write bytes: 689900544; Read time: 350; Write time: 2236 08:09:18 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 336167424; Write bytes: 337581568; Read time: 25991; Write time: 668 08:09:18 INFO - run-tests - Wall time: 1209s; CPU: 52.0%; Read bytes: 32706048; Write bytes: 341952000; Read time: 337; Write time: 1535 08:09:18 INFO - Running post-run listener: _upload_blobber_files 08:09:18 INFO - Blob upload gear active. 08:09:18 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:09:18 INFO - Copying logs to upload dir... 08:09:18 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1281.009808 ========= master_lag: 3.90 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-20 08:09:22.042195) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 08:09:22.045749) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bT1SmsdbA8/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009354 build_url: 'https://queue.taskcluster.net/v1/task/QDlriozVTauSAMWJX4icSw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.18 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 08:09:22.231152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:09:22.231554) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bT1SmsdbA8/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Iu8Rw9jaq5/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005102 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 08:09:22.250855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 08:09:22.251189) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 08:09:22.251556) ========= ========= Total master_lag: 4.22 =========