builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0032 starttime: 1448065073.05 results: success (0) buildid: 20151120132233 builduid: ae92f4d77e6b4fcc806d374a4fb8c0d7 revision: b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:53.053511) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:53.054055) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:53.054385) ========= 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.BOIinPyOh9/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.H3myhZDpad/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005529 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:53.075119) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:53.075514) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:53.090790) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:53.091484) ========= 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.BOIinPyOh9/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.H3myhZDpad/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005455 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:53.140941) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:53.141303) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:53.141740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:53.142073) ========= 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.BOIinPyOh9/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.H3myhZDpad/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 16:17:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-20 16:17:53 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176574 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:53.332553) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:53.332933) ========= 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.BOIinPyOh9/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.H3myhZDpad/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.019917 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:53.382073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 16:17:53.382497) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73 --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 b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BOIinPyOh9/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.H3myhZDpad/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 16:17:53,460 truncating revision to first 12 chars 2015-11-20 16:17:53,461 Setting DEBUG logging. 2015-11-20 16:17:53,461 attempt 1/10 2015-11-20 16:17:53,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b0bdf1bc3b61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 16:17:54,583 unpacking tar archive at: fx-team-b0bdf1bc3b61/testing/mozharness/ program finished with exit code 0 elapsedTime=1.361896 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 16:17:54.758782) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:54.759138) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:54.770839) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:54.771202) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 16:17:54.771697) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-20 16:17:54.772048) ========= /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.BOIinPyOh9/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.H3myhZDpad/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 16:17:54 INFO - MultiFileLogger online at 20151120 16:17:54 in /builds/slave/test 16:17:54 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 16:17:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:17:54 INFO - {'append_to_log': False, 16:17:54 INFO - 'base_work_dir': '/builds/slave/test', 16:17:54 INFO - 'blob_upload_branch': 'Fx-Team', 16:17:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:17:54 INFO - 'branch': 'Fx-Team', 16:17:54 INFO - 'buildbot_json_path': 'buildprops.json', 16:17:54 INFO - 'config_files': ('talos/mac_config.py',), 16:17:54 INFO - 'default_actions': ('clobber', 16:17:54 INFO - 'read-buildbot-config', 16:17:54 INFO - 'download-and-extract', 16:17:54 INFO - 'populate-webroot', 16:17:54 INFO - 'create-virtualenv', 16:17:54 INFO - 'install', 16:17:54 INFO - 'run-tests'), 16:17:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:17:54 INFO - 'download_minidump_stackwalk': True, 16:17:54 INFO - 'download_symbols': 'ondemand', 16:17:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:17:54 INFO - 'tooltool.py': '/tools/tooltool.py', 16:17:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:17:54 INFO - '/tools/misc-python/virtualenv.py')}, 16:17:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:17:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:17:54 INFO - 'installer_path': 'installer.exe', 16:17:54 INFO - 'log_level': 'info', 16:17:54 INFO - 'log_name': 'talos', 16:17:54 INFO - 'log_to_console': True, 16:17:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:17:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:17:54 INFO - 'opt_config_files': (), 16:17:54 INFO - 'pip_index': False, 16:17:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:17:54 INFO - 'cmd': ('bash', 16:17:54 INFO - '-c', 16:17:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:17:54 INFO - 'enabled': True, 16:17:54 INFO - 'halt_on_failure': False, 16:17:54 INFO - 'name': 'check_screen_resolution'},), 16:17:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:17:54 INFO - 'cmd': ('bash', 16:17:54 INFO - '-c', 16:17:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:17:54 INFO - 'enabled': True, 16:17:54 INFO - 'halt_on_failure': False, 16:17:54 INFO - 'name': 'check_screen_resolution'},), 16:17:54 INFO - 'run_cmd_checks_enabled': True, 16:17:54 INFO - 'sps_profile': False, 16:17:54 INFO - 'sps_profile_interval': 0, 16:17:54 INFO - 'suite': 'dromaeojs', 16:17:54 INFO - 'system_bits': '64', 16:17:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:17:54 INFO - 'title': 't-yosemite-r7-0032', 16:17:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:17:54 INFO - 'use_talos_json': True, 16:17:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:17:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:17:54 INFO - 'work_dir': 'build'} 16:17:54 INFO - ##### 16:17:54 INFO - ##### Running clobber step. 16:17:54 INFO - ##### 16:17:54 INFO - Running pre-action listener: _resource_record_pre_action 16:17:54 INFO - Running main action method: clobber 16:17:54 INFO - rmtree: /builds/slave/test/build 16:17:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:17:55 INFO - Running post-action listener: _resource_record_post_action 16:17:55 INFO - ##### 16:17:55 INFO - ##### Running read-buildbot-config step. 16:17:55 INFO - ##### 16:17:55 INFO - Running pre-action listener: _resource_record_pre_action 16:17:55 INFO - Running main action method: read_buildbot_config 16:17:55 INFO - Using buildbot properties: 16:17:55 INFO - { 16:17:55 INFO - "properties": { 16:17:55 INFO - "buildnumber": 9, 16:17:55 INFO - "product": "firefox", 16:17:55 INFO - "script_repo_revision": "production", 16:17:55 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 16:17:55 INFO - "repository": "", 16:17:55 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 16:17:55 INFO - "buildid": "20151120132233", 16:17:55 INFO - "slavename": "t-yosemite-r7-0032", 16:17:55 INFO - "pgo_build": "False", 16:17:55 INFO - "basedir": "/builds/slave/test", 16:17:55 INFO - "project": "", 16:17:55 INFO - "platform": "yosemite_r7", 16:17:55 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:17:55 INFO - "slavebuilddir": "test", 16:17:55 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:17:55 INFO - "branch": "fx-team", 16:17:55 INFO - "repo_path": "integration/fx-team", 16:17:55 INFO - "stage_platform": "macosx64", 16:17:55 INFO - "builduid": "ae92f4d77e6b4fcc806d374a4fb8c0d7", 16:17:55 INFO - "revision": "b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73" 16:17:55 INFO - }, 16:17:55 INFO - "sourcestamp": { 16:17:55 INFO - "repository": "", 16:17:55 INFO - "hasPatch": false, 16:17:55 INFO - "project": "", 16:17:55 INFO - "branch": "fx-team-macosx64-talos", 16:17:55 INFO - "changes": [ 16:17:55 INFO - { 16:17:55 INFO - "category": null, 16:17:55 INFO - "files": [ 16:17:55 INFO - { 16:17:55 INFO - "url": null, 16:17:55 INFO - "name": "https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 16:17:55 INFO - } 16:17:55 INFO - ], 16:17:55 INFO - "repository": "", 16:17:55 INFO - "rev": "b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73", 16:17:55 INFO - "who": "bgrinstead@mozilla.com", 16:17:55 INFO - "when": 1448060873, 16:17:55 INFO - "number": 6690915, 16:17:55 INFO - "comments": "Bug 1201962 - Enable service worker logging in web console by default;r=ejpbruel", 16:17:55 INFO - "project": "", 16:17:55 INFO - "at": "Fri 20 Nov 2015 15:07:53", 16:17:55 INFO - "branch": "fx-team-macosx64-talos", 16:17:55 INFO - "revlink": "", 16:17:55 INFO - "properties": [ 16:17:55 INFO - [ 16:17:55 INFO - "buildid", 16:17:55 INFO - "20151120132233", 16:17:55 INFO - "Change" 16:17:55 INFO - ], 16:17:55 INFO - [ 16:17:55 INFO - "builduid", 16:17:55 INFO - "ae92f4d77e6b4fcc806d374a4fb8c0d7", 16:17:55 INFO - "Change" 16:17:55 INFO - ], 16:17:55 INFO - [ 16:17:55 INFO - "pgo_build", 16:17:55 INFO - "False", 16:17:55 INFO - "Change" 16:17:55 INFO - ] 16:17:55 INFO - ], 16:17:55 INFO - "revision": "b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73" 16:17:55 INFO - } 16:17:55 INFO - ], 16:17:55 INFO - "revision": "b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73" 16:17:55 INFO - } 16:17:55 INFO - } 16:17:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 16:17:55 INFO - Running post-action listener: _resource_record_post_action 16:17:55 INFO - ##### 16:17:55 INFO - ##### Running download-and-extract step. 16:17:55 INFO - ##### 16:17:55 INFO - Running pre-action listener: _resource_record_pre_action 16:17:55 INFO - Running main action method: download_and_extract 16:17:55 INFO - mkdir: /builds/slave/test/build/tests 16:17:55 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')]} 16:17:55 INFO - https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:17:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/test_packages.json 16:17:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/test_packages.json 16:17:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:17:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:17:57 INFO - Downloaded 1149 bytes. 16:17:57 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:17:57 INFO - Using the following test package requirements: 16:17:57 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:17:57 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:17:57 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 16:17:57 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:17:57 INFO - u'jsshell-mac.zip'], 16:17:57 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:17:57 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 16:17:57 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:17:57 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:17:57 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 16:17:57 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:17:57 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 16:17:57 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:17:57 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 16:17:57 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:17:57 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:17:57 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 16:17:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:57 INFO - https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:17:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:17:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:17:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/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 16:17:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/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 16:17:58 INFO - Downloaded 17526882 bytes. 16:17:58 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 16:17:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:17:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:18:00 INFO - Return code: 0 16:18:00 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 16:18:00 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')]} 16:18:00 INFO - https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:18:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:18:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:18:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/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 16:18:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/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 16:18:02 INFO - Downloaded 17526882 bytes. 16:18:02 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 16:18:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:18:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:18:05 INFO - Return code: 0 16:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:05 INFO - https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:18:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:18:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:18:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/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 16:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/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 16:18:06 INFO - Downloaded 11130997 bytes. 16:18:06 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 16:18:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:18:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 16:18:06 INFO - Return code: 0 16:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:06 INFO - https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:18:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:18:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:18:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 16:18:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/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 16:18:09 INFO - Downloaded 109418709 bytes. 16:18:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:18:09 INFO - mkdir: /builds/slave/test/properties 16:18:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:18:09 INFO - Writing to file /builds/slave/test/properties/build_url 16:18:09 INFO - Contents: 16:18:09 INFO - build_url:https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:18:09 INFO - Running post-action listener: _resource_record_post_action 16:18:09 INFO - Running post-action listener: set_extra_try_arguments 16:18:09 INFO - ##### 16:18:09 INFO - ##### Running populate-webroot step. 16:18:09 INFO - ##### 16:18:09 INFO - Running pre-action listener: _resource_record_pre_action 16:18:09 INFO - Running main action method: populate_webroot 16:18:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:18:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:18:09 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:18:09 INFO - '../fennec_ids.txt'], 16:18:09 INFO - 'tests': ['tcheck2']}, 16:18:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:18:09 INFO - '--tppagecycles', 16:18:09 INFO - '7'], 16:18:09 INFO - 'tests': ['tsvgm']}}, 16:18:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:18:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:18:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:18:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:18:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:18:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:18:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:09 INFO - 'talos_options': ['--e10s'], 16:18:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:09 INFO - 'tests': ['damp', 'tps']}, 16:18:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:09 INFO - 'talos_options': ['--e10s'], 16:18:09 INFO - 'tests': ['damp', 'tps']}, 16:18:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:18:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:18:09 INFO - 'other': {'tests': ['a11yr', 16:18:09 INFO - 'ts_paint', 16:18:09 INFO - 'tpaint', 16:18:09 INFO - 'sessionrestore', 16:18:09 INFO - 'sessionrestore_no_auto_restore']}, 16:18:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:18:09 INFO - 'tests': ['a11yr', 16:18:09 INFO - 'ts_paint', 16:18:09 INFO - 'tpaint', 16:18:09 INFO - 'sessionrestore', 16:18:09 INFO - 'sessionrestore_no_auto_restore']}, 16:18:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:18:09 INFO - 'tests': ['a11yr', 16:18:09 INFO - 'ts_paint', 16:18:09 INFO - 'tpaint', 16:18:09 INFO - 'sessionrestore', 16:18:09 INFO - 'sessionrestore_no_auto_restore']}, 16:18:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:18:09 INFO - 'tests': ['a11yr', 16:18:09 INFO - 'ts_paint', 16:18:09 INFO - 'tpaint', 16:18:09 INFO - 'sessionrestore', 16:18:09 INFO - 'sessionrestore_no_auto_restore']}, 16:18:09 INFO - 'other_l64': {'tests': ['a11yr', 16:18:09 INFO - 'ts_paint', 16:18:09 INFO - 'tpaint', 16:18:09 INFO - 'sessionrestore', 16:18:09 INFO - 'sessionrestore_no_auto_restore']}, 16:18:09 INFO - 'other_nol64': {'tests': ['a11yr', 16:18:09 INFO - 'ts_paint', 16:18:09 INFO - 'tpaint', 16:18:09 INFO - 'sessionrestore', 16:18:09 INFO - 'sessionrestore_no_auto_restore']}, 16:18:09 INFO - 'svgr': {'tests': ['tsvgx', 16:18:09 INFO - 'tsvgr_opacity', 16:18:09 INFO - 'tart', 16:18:09 INFO - 'tscrollx', 16:18:09 INFO - 'cart']}, 16:18:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:18:09 INFO - 'tests': ['tsvgx', 16:18:09 INFO - 'tsvgr_opacity', 16:18:09 INFO - 'tart', 16:18:09 INFO - 'tscrollx', 16:18:09 INFO - 'cart']}, 16:18:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:09 INFO - 'tests': ['tp5o']}, 16:18:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:09 INFO - 'talos_options': ['--e10s'], 16:18:09 INFO - 'tests': ['tp5o']}, 16:18:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:09 INFO - 'talos_options': ['--xperf_path', 16:18:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:09 INFO - 'tests': ['tp5n']}, 16:18:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:09 INFO - 'talos_options': ['--e10s', 16:18:09 INFO - '--xperf_path', 16:18:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:09 INFO - 'tests': ['tp5n']}}, 16:18:09 INFO - 'talos.zip': {'path': '', 16:18:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:18:09 INFO - Running post-action listener: _resource_record_post_action 16:18:09 INFO - ##### 16:18:09 INFO - ##### Running create-virtualenv step. 16:18:09 INFO - ##### 16:18:09 INFO - Running pre-action listener: _resource_record_pre_action 16:18:09 INFO - Running main action method: create_virtualenv 16:18:09 INFO - Creating virtualenv /builds/slave/test/build/venv 16:18:09 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 16:18:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:18:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:18:09 INFO - Using real prefix '/tools/python27' 16:18:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:18:10 INFO - Installing distribute.............................................................................................................................................................................................done. 16:18:13 INFO - Installing pip.................done. 16:18:13 INFO - Return code: 0 16:18:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:13 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 0x108b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe571495e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a839f0>, '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 0x1087e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a768c8>, '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.BOIinPyOh9/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.H3myhZDpad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 16:18:13 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 16:18:13 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 16:18:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOIinPyOh9/Render', 16:18:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:13 INFO - 'HOME': '/Users/cltbld', 16:18:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:13 INFO - 'LOGNAME': 'cltbld', 16:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:13 INFO - 'MOZ_NO_REMOTE': '1', 16:18:13 INFO - 'NO_EM_RESTART': '1', 16:18:13 INFO - 'PAGER': '/bin/cat', 16:18:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:13 INFO - 'PWD': '/builds/slave/test', 16:18:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:13 INFO - 'SHELL': '/bin/bash', 16:18:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3myhZDpad/Listeners', 16:18:13 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 16:18:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:13 INFO - 'USER': 'cltbld', 16:18:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:13 INFO - 'XPC_FLAGS': '0x0', 16:18:13 INFO - 'XPC_SERVICE_NAME': '0', 16:18:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:13 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 16:18:13 INFO - Cleaning up... 16:18:13 INFO - Return code: 0 16:18:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:13 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 0x108b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe571495e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a839f0>, '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 0x1087e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a768c8>, '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.BOIinPyOh9/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.H3myhZDpad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 16:18:13 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 16:18:13 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 16:18:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOIinPyOh9/Render', 16:18:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:13 INFO - 'HOME': '/Users/cltbld', 16:18:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:13 INFO - 'LOGNAME': 'cltbld', 16:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:13 INFO - 'MOZ_NO_REMOTE': '1', 16:18:13 INFO - 'NO_EM_RESTART': '1', 16:18:13 INFO - 'PAGER': '/bin/cat', 16:18:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:13 INFO - 'PWD': '/builds/slave/test', 16:18:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:13 INFO - 'SHELL': '/bin/bash', 16:18:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3myhZDpad/Listeners', 16:18:13 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 16:18:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:13 INFO - 'USER': 'cltbld', 16:18:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:13 INFO - 'XPC_FLAGS': '0x0', 16:18:13 INFO - 'XPC_SERVICE_NAME': '0', 16:18:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:13 INFO - Downloading/unpacking psutil>=0.7.1 16:18:13 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 16:18:13 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 16:18:13 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 16:18:13 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 16:18:13 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 16:18:13 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 16:18:16 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:18:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:18:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:18:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:18:16 INFO - Installing collected packages: psutil 16:18:16 INFO - Running setup.py install for psutil 16:18:16 INFO - building 'psutil._psutil_osx' extension 16:18:16 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 16:18:16 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 16:18:16 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 16:18:16 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 16:18:16 INFO - building 'psutil._psutil_posix' extension 16:18:16 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 16:18:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:18:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:18:16 INFO - ^ 16:18:16 INFO - 1 warning generated. 16:18:16 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 16:18:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:18:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:18:17 INFO - Successfully installed psutil 16:18:17 INFO - Cleaning up... 16:18:17 INFO - Return code: 0 16:18:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe571495e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a839f0>, '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 0x1087e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a768c8>, '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.BOIinPyOh9/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.H3myhZDpad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 16:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:18:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOIinPyOh9/Render', 16:18:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:17 INFO - 'HOME': '/Users/cltbld', 16:18:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:17 INFO - 'LOGNAME': 'cltbld', 16:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:17 INFO - 'MOZ_NO_REMOTE': '1', 16:18:17 INFO - 'NO_EM_RESTART': '1', 16:18:17 INFO - 'PAGER': '/bin/cat', 16:18:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:17 INFO - 'PWD': '/builds/slave/test', 16:18:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:17 INFO - 'SHELL': '/bin/bash', 16:18:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3myhZDpad/Listeners', 16:18:17 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 16:18:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:17 INFO - 'USER': 'cltbld', 16:18:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:17 INFO - 'XPC_FLAGS': '0x0', 16:18:17 INFO - 'XPC_SERVICE_NAME': '0', 16:18:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:18:17 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 16:18:17 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 16:18:17 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 16:18:17 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 16:18:17 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 16:18:17 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 16:18:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:18:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:18:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:18:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:18:19 INFO - Installing collected packages: mozsystemmonitor 16:18:19 INFO - Running setup.py install for mozsystemmonitor 16:18:19 INFO - Successfully installed mozsystemmonitor 16:18:19 INFO - Cleaning up... 16:18:19 INFO - Return code: 0 16:18:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:19 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 0x108b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe571495e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a839f0>, '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 0x1087e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a768c8>, '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.BOIinPyOh9/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.H3myhZDpad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 16:18:19 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 16:18:19 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 16:18:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOIinPyOh9/Render', 16:18:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:19 INFO - 'HOME': '/Users/cltbld', 16:18:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:19 INFO - 'LOGNAME': 'cltbld', 16:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:19 INFO - 'MOZ_NO_REMOTE': '1', 16:18:19 INFO - 'NO_EM_RESTART': '1', 16:18:19 INFO - 'PAGER': '/bin/cat', 16:18:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:19 INFO - 'PWD': '/builds/slave/test', 16:18:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:19 INFO - 'SHELL': '/bin/bash', 16:18:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3myhZDpad/Listeners', 16:18:19 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 16:18:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:19 INFO - 'USER': 'cltbld', 16:18:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:19 INFO - 'XPC_FLAGS': '0x0', 16:18:19 INFO - 'XPC_SERVICE_NAME': '0', 16:18:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:20 INFO - Downloading/unpacking blobuploader==1.2.4 16:18: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 16:18: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 16:18: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 16:18: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 16:18: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 16:18: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 16:18:22 INFO - Downloading blobuploader-1.2.4.tar.gz 16:18:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:18:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:18:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:23 INFO - Downloading docopt-0.6.1.tar.gz 16:18:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:18:23 INFO - Installing collected packages: blobuploader, requests, docopt 16:18:23 INFO - Running setup.py install for blobuploader 16:18:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:18:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:18:23 INFO - Running setup.py install for requests 16:18:24 INFO - Running setup.py install for docopt 16:18:24 INFO - Successfully installed blobuploader requests docopt 16:18:24 INFO - Cleaning up... 16:18:24 INFO - Return code: 0 16:18:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:24 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 0x108b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe571495e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a839f0>, '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 0x1087e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a768c8>, '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.BOIinPyOh9/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.H3myhZDpad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 16:18:24 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 16:18:24 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 16:18:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOIinPyOh9/Render', 16:18:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:24 INFO - 'HOME': '/Users/cltbld', 16:18:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:24 INFO - 'LOGNAME': 'cltbld', 16:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:24 INFO - 'MOZ_NO_REMOTE': '1', 16:18:24 INFO - 'NO_EM_RESTART': '1', 16:18:24 INFO - 'PAGER': '/bin/cat', 16:18:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:24 INFO - 'PWD': '/builds/slave/test', 16:18:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:24 INFO - 'SHELL': '/bin/bash', 16:18:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3myhZDpad/Listeners', 16:18:24 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 16:18:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:24 INFO - 'USER': 'cltbld', 16:18:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:24 INFO - 'XPC_FLAGS': '0x0', 16:18:24 INFO - 'XPC_SERVICE_NAME': '0', 16:18:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:18:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-DRYyLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:18:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-UqSU2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:18:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-k6wV_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:18:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-BykEV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:18:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-IAoAXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:18:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-VoXcFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:18:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-28wcUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:18:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-zmfBEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:18:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-KEV419-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:18:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-CFbSDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:18:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-6KKuyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:18:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-fqFyNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:18:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-htycut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:18:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-hqk1Qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:26 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-cQncMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:18:26 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-BZX8dR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:18:26 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-pzy569-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:18:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:18:26 INFO - Running setup.py install for manifestparser 16:18:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:18:26 INFO - Running setup.py install for mozcrash 16:18:26 INFO - Running setup.py install for mozdebug 16:18:26 INFO - Running setup.py install for mozdevice 16:18:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:18:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:18:26 INFO - Running setup.py install for mozfile 16:18:27 INFO - Running setup.py install for mozhttpd 16:18:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:18:27 INFO - Running setup.py install for mozinfo 16:18:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:18:27 INFO - Running setup.py install for mozInstall 16:18:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:18:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:18:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:18:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:18:27 INFO - Running setup.py install for mozleak 16:18:27 INFO - Running setup.py install for mozlog 16:18:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:18:27 INFO - Running setup.py install for moznetwork 16:18:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:18:28 INFO - Running setup.py install for mozprocess 16:18:28 INFO - Running setup.py install for mozprofile 16:18:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:18:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:18:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:18:28 INFO - Running setup.py install for mozrunner 16:18:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:18:28 INFO - Running setup.py install for mozscreenshot 16:18:28 INFO - Running setup.py install for moztest 16:18:28 INFO - Running setup.py install for mozversion 16:18:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:18:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:18:28 INFO - Cleaning up... 16:18:28 INFO - Return code: 0 16:18:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe571495e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a839f0>, '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 0x1087e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a768c8>, '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.BOIinPyOh9/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.H3myhZDpad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 16:18:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:18:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOIinPyOh9/Render', 16:18:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:28 INFO - 'HOME': '/Users/cltbld', 16:18:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:28 INFO - 'LOGNAME': 'cltbld', 16:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:28 INFO - 'MOZ_NO_REMOTE': '1', 16:18:28 INFO - 'NO_EM_RESTART': '1', 16:18:28 INFO - 'PAGER': '/bin/cat', 16:18:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:28 INFO - 'PWD': '/builds/slave/test', 16:18:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:28 INFO - 'SHELL': '/bin/bash', 16:18:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3myhZDpad/Listeners', 16:18:28 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 16:18:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:28 INFO - 'USER': 'cltbld', 16:18:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:28 INFO - 'XPC_FLAGS': '0x0', 16:18:28 INFO - 'XPC_SERVICE_NAME': '0', 16:18:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:18:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-4JNvne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:18:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-1Eef9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:18:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-NRfkeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:18:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-pOWvzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:18:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-4qULTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:18:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-P_XZKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:18:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-TEutZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:18:29 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Psvlmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:18:30 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)) 16:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:18:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-PXOJKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:18:30 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)) 16:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:18:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-MPpgqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:18:30 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)) 16:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:18:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-oX5H6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:18:30 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)) 16:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:18:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-waUllG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:18:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Hb2zf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:18:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-JNMgvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-mbV3wY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:18:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-DLv2Km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:18:30 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-kP9zYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:18:31 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)) 16:18:31 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)) 16:18:31 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)) 16:18:31 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)) 16:18:31 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)) 16:18:31 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)) 16:18:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:33 INFO - Downloading blessings-1.5.1.tar.gz 16:18:33 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 16:18:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:18:33 INFO - Installing collected packages: blessings 16:18:33 INFO - Running setup.py install for blessings 16:18:33 INFO - Successfully installed blessings 16:18:33 INFO - Cleaning up... 16:18:33 INFO - Return code: 0 16:18:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:18:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:18:33 INFO - Reading from file tmpfile_stdout 16:18:33 INFO - Current package versions: 16:18:33 INFO - blessings == 1.5.1 16:18:33 INFO - blobuploader == 1.2.4 16:18:33 INFO - docopt == 0.6.1 16:18:33 INFO - manifestparser == 1.1 16:18:33 INFO - mozInstall == 1.12 16:18:33 INFO - mozcrash == 0.16 16:18:33 INFO - mozdebug == 0.1 16:18:33 INFO - mozdevice == 0.47 16:18:33 INFO - mozfile == 1.2 16:18:33 INFO - mozhttpd == 0.7 16:18:33 INFO - mozinfo == 0.9 16:18:33 INFO - mozleak == 0.1 16:18:33 INFO - mozlog == 3.0 16:18:33 INFO - moznetwork == 0.27 16:18:33 INFO - mozprocess == 0.22 16:18:33 INFO - mozprofile == 0.27 16:18:33 INFO - mozrunner == 6.11 16:18:33 INFO - mozscreenshot == 0.1 16:18:33 INFO - mozsystemmonitor == 0.0 16:18:33 INFO - moztest == 0.7 16:18:33 INFO - mozversion == 1.4 16:18:33 INFO - psutil == 3.1.1 16:18:33 INFO - requests == 1.2.3 16:18:33 INFO - wsgiref == 0.1.2 16:18:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:18:33 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')]} 16:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:33 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')]} 16:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:33 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 0x108b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b3c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe571495e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a839f0>, '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 0x1087e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a768c8>, '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.BOIinPyOh9/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.H3myhZDpad/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 16:18:33 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 16:18:33 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 16:18:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOIinPyOh9/Render', 16:18:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:33 INFO - 'HOME': '/Users/cltbld', 16:18:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:33 INFO - 'LOGNAME': 'cltbld', 16:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:33 INFO - 'MOZ_NO_REMOTE': '1', 16:18:33 INFO - 'NO_EM_RESTART': '1', 16:18:33 INFO - 'PAGER': '/bin/cat', 16:18:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:33 INFO - 'PWD': '/builds/slave/test', 16:18:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:33 INFO - 'SHELL': '/bin/bash', 16:18:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3myhZDpad/Listeners', 16:18:33 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 16:18:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:33 INFO - 'USER': 'cltbld', 16:18:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:33 INFO - 'XPC_FLAGS': '0x0', 16:18:33 INFO - 'XPC_SERVICE_NAME': '0', 16:18:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:34 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)) 16:18:34 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)) 16:18:34 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)) 16:18:34 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)) 16:18:34 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)) 16:18:34 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)) 16:18:34 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)) 16:18:34 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)) 16:18:34 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)) 16:18:34 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)) 16:18:34 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)) 16:18:34 INFO - Cleaning up... 16:18:34 INFO - Return code: 0 16:18:34 INFO - Running post-action listener: _resource_record_post_action 16:18:34 INFO - Running post-action listener: _start_resource_monitoring 16:18:34 INFO - Starting resource monitoring. 16:18:34 INFO - ##### 16:18:34 INFO - ##### Running install step. 16:18:34 INFO - ##### 16:18:34 INFO - Running pre-action listener: _resource_record_pre_action 16:18:34 INFO - Running main action method: install 16:18:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:18:34 INFO - Reading from file tmpfile_stdout 16:18:34 INFO - Detecting whether we're running mozinstall >=1.0... 16:18:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:18:34 INFO - Reading from file tmpfile_stdout 16:18:34 INFO - Output received: 16:18:34 INFO - Usage: mozinstall [options] installer 16:18:34 INFO - Options: 16:18:34 INFO - -h, --help show this help message and exit 16:18:34 INFO - -d DEST, --destination=DEST 16:18:34 INFO - Directory to install application into. [default: 16:18:34 INFO - "/builds/slave/test"] 16:18:34 INFO - --app=APP Application being installed. [default: firefox] 16:18:34 INFO - mkdir: /builds/slave/test/build/application 16:18:34 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'] 16:18:34 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 16:19:04 INFO - Reading from file tmpfile_stdout 16:19:04 INFO - Output received: 16:19:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:19:04 INFO - Running post-action listener: _resource_record_post_action 16:19:04 INFO - ##### 16:19:04 INFO - ##### Running run-tests step. 16:19:04 INFO - ##### 16:19:04 INFO - Running pre-action listener: _resource_record_pre_action 16:19:04 INFO - Running main action method: run_tests 16:19:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:19:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:19:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:19:04 INFO - 2015-11-20 16:19:04.856 screenresolution[2020:15408] starting screenresolution argv=screenresolution get 16:19:04 INFO - 2015-11-20 16:19:04.859 screenresolution[2020:15408] Display 0: 1600x1200x32@60 16:19:04 INFO - 2015-11-20 16:19:04.864 screenresolution[2021:15411] starting screenresolution argv=screenresolution list 16:19:04 INFO - Available Modes on Display 0 16:19:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:19:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:19:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:19:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:19:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:19:05 INFO - Intel Iris: 16:19:05 INFO - Chipset Model: Intel Iris 16:19:05 INFO - Type: GPU 16:19:05 INFO - Bus: Built-In 16:19:05 INFO - VRAM (Dynamic, Max): 1536 MB 16:19:05 INFO - Vendor: Intel (0x8086) 16:19:05 INFO - Device ID: 0x0a2e 16:19:05 INFO - Revision ID: 0x0009 16:19:05 INFO - Displays: 16:19:05 INFO - Display: 16:19:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:19:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:19:05 INFO - Display Serial Number: 1600x1200 60 16:19:05 INFO - Main Display: Yes 16:19:05 INFO - Mirror: Off 16:19:05 INFO - Online: Yes 16:19:05 INFO - Rotation: Supported 16:19:05 INFO - Return code: 0 16:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:19:05 INFO - Python 2.7.3 16:19:05 INFO - Return code: 0 16:19:05 INFO - grabbing minidump binary from tooltool 16:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:05 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 0x108a839f0>, '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 0x1087e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a768c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:19:05 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 16:19:05 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 16:19:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:19:05 INFO - Return code: 0 16:19:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:19:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:19:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:19:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:19:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:19:05 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/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--webServer', 'localhost'] in /builds/slave/test/build 16:19:05 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/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --webServer localhost 16:19:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOIinPyOh9/Render', 16:19:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:05 INFO - 'HOME': '/Users/cltbld', 16:19:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:05 INFO - 'LOGNAME': 'cltbld', 16:19:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:19:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:05 INFO - 'MOZ_NO_REMOTE': '1', 16:19:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:19:05 INFO - 'NO_EM_RESTART': '1', 16:19:05 INFO - 'PAGER': '/bin/cat', 16:19:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:05 INFO - 'PWD': '/builds/slave/test', 16:19:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:19:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:05 INFO - 'SHELL': '/bin/bash', 16:19:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H3myhZDpad/Listeners', 16:19:05 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 16:19:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:05 INFO - 'USER': 'cltbld', 16:19:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:05 INFO - 'XPC_FLAGS': '0x0', 16:19:05 INFO - 'XPC_SERVICE_NAME': '0', 16:19:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:05 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/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--webServer', 'localhost'] with output_timeout 3600 16:19:05 INFO - mozversion INFO | application_buildid: 20151120132233 16:19:05 INFO - mozversion INFO | application_changeset: b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73 16:19:05 INFO - mozversion INFO | application_display_name: Nightly 16:19:05 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:19:05 INFO - mozversion INFO | application_name: Firefox 16:19:05 INFO - mozversion INFO | application_remotingname: firefox 16:19:05 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:19:05 INFO - mozversion INFO | application_vendor: Mozilla 16:19:05 INFO - mozversion INFO | application_version: 45.0a1 16:19:05 INFO - mozversion INFO | platform_buildid: 20151120132233 16:19:05 INFO - mozversion INFO | platform_changeset: b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73 16:19:05 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:19:05 INFO - mozversion INFO | platform_version: 45.0a1 16:19:05 INFO - 2015-11-20 16:19:05,392 DEBUG : using testdate: 1448065145 16:19:05 INFO - 2015-11-20 16:19:05,393 DEBUG : actual date: 1448065145 16:19:05 INFO - 2015-11-20 16:19:05,875 INFO : starting webserver on 'localhost:50524' 16:19:05 INFO - 2015-11-20 16:19:05,876 INFO : Starting test suite t-yosemite-r7-0032 16:19:05 INFO - 2015-11-20 16:19:05,876 INFO : Starting test dromaeo_css 16:19:05 INFO - 2015-11-20 16:19:05,877 DEBUG : operating with platform_type : mac_ 16:19:05 INFO - 2015-11-20 16:19:05,878 INFO : Initialising browser for dromaeo_css test... 16:19:05 INFO - 2015-11-20 16:19:05,889 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpiUeeaj/profile http://localhost:50524/getInfo.html 16:19:07 INFO - 2015-11-20 16:19:07,776 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:19:07 INFO - 2015-11-20 16:19:07,776 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:19:07 INFO - 2015-11-20 16:19:07,777 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:19:07 INFO - 2015-11-20 16:19:07,777 DEBUG : BROWSER_OUTPUT: __metrics 16:19:07 INFO - 2015-11-20 16:19:07,792 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:19:08 INFO - 2015-11-20 16:19:08,442 INFO : Browser initialized. 16:19:08 INFO - 2015-11-20 16:19:08,443 INFO : Running cycle 1/1 for dromaeo_css test... 16:19:08 INFO - 2015-11-20 16:19:08,443 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpiUeeaj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:19:20 INFO - 2015-11-20 16:19:20,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 224301056 16:19:20 INFO - 2015-11-20 16:19:20,249 DEBUG : BROWSER_OUTPUT: 16:20:11 INFO - 2015-11-20 16:20:11,298 DEBUG : BROWSER_OUTPUT: 1448065211298 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] 16:22:22 INFO - 2015-11-20 16:22:22,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50524/tests/dromaeo/cssquery-ext.html) 16:22:23 INFO - 2015-11-20 16:22:23,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 363925504 16:22:23 INFO - 2015-11-20 16:22:23,854 DEBUG : BROWSER_OUTPUT: 16:25:26 INFO - 2015-11-20 16:25:26,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/dromaeo/cssquery-ext.html (next: http://localhost:50524/tests/dromaeo/cssquery-jquery.html) 16:25:27 INFO - 2015-11-20 16:25:27,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 361381888 16:25:27 INFO - 2015-11-20 16:25:27,367 DEBUG : BROWSER_OUTPUT: 16:28:29 INFO - 2015-11-20 16:28:29,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50524/tests/dromaeo/cssquery-mootools.html) 16:28:30 INFO - 2015-11-20 16:28:30,032 DEBUG : BROWSER_OUTPUT: RSS: Main: 336474112 16:28:30 INFO - 2015-11-20 16:28:30,033 DEBUG : BROWSER_OUTPUT: 16:31:32 INFO - 2015-11-20 16:31:32,118 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50524/tests/dromaeo/cssquery-prototype.html) 16:31:32 INFO - 2015-11-20 16:31:32,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 316612608 16:31:32 INFO - 2015-11-20 16:31:32,717 DEBUG : BROWSER_OUTPUT: 16:34:35 INFO - 2015-11-20 16:34:35,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50524/tests/dromaeo/cssquery-yui.html) 16:34:36 INFO - 2015-11-20 16:34:36,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 317562880 16:34:36 INFO - 2015-11-20 16:34:36,537 DEBUG : BROWSER_OUTPUT: 16:37:39 INFO - 2015-11-20 16:37:39,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/dromaeo/cssquery-yui.html (next: http://localhost:50524/tests/dromaeo/cssquery-dojo.html) 16:37:39 INFO - 2015-11-20 16:37:39,489 DEBUG : BROWSER_OUTPUT: RSS: Main: 364593152 16:37:39 INFO - 2015-11-20 16:37:39,489 DEBUG : BROWSER_OUTPUT: 16:37:39 INFO - 2015-11-20 16:37:39,489 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:37:39 INFO - 2015-11-20 16:37:39,489 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:37:39 INFO - 2015-11-20 16:37:39,490 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:37:39 INFO - 2015-11-20 16:37:39,490 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:37:39 INFO - 2015-11-20 16:37:39,490 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2728.372474330904;3472.218750781073;3473.6700013498707;3511.7015053720434;3547.0245682437344;5640.661560306385;5817.825465236049;5910.290765108188;5914.467697907187;5930.436608522195;5841.0362290222065;5858.1505681676135;5906.05503119501;6054.909176362358;6085.269767627879;5263.947360526384;5302.893942121155;5332.653377530468;5362.195670649395;5428.4842939920645;5395.271638328814;5420.322459692538;5422.403535611099;5431.21247419124;5469.535089517376;5159.432462429129;5265.76304066318;5291.656042357273;5377.139657654776;5395.81114660987;5195.402528709209;5272.998130355259;5290.444503327134;5296.496832800878;5303.363596368422;5242.711650859202;5267.9736601316745;5272.6836389816735;5298.655587386807;5318.574514038906;5750.6262092963825;5762.97118514409;5766.596338256324;5772.989726797794;5852.56105792063;6146.877062458726;6181.9690901545655;6277.87444251117;6311.147995020659;6343.080253363237;6328.841778955517;6339.429451349401;6360.0459931010255;6368.044793280998;6368.172137622126;5904.380040095728;6010.008348622472;6028.57799953999;6037.607555508834;6040.939590604082;6127.494965205055;6305.148804911279;6319.210098737658;6350.745970161234;6499.512536559777;6274.372562743781;6340.4927605792345;6349;6370.394812492806;6372.107904893319;6330.620162790247;6339.175907132136;6350.047492876106;6354.364563543609;6361.268454127835;6131.499004853489;6180.412860778219;6192.885280649526;6278.152449419361;6324.177856878577;6300.338464461165;6301.4328710416285;6307.463865571478;6309.589876658002;6317.399847014526;5077.669951453144;5088.872778180501;5091.981603679279;5093.541581257705;5100.897982040338;4400.669949753781;4420.823167073346;4487.6185524230805;4531.365608814768;4552.499225085238;6036.698165091816;6050.909236361458;6069.908951365733;6071.483923866433;6079.240094988127;6348.587341822767;6354.3010268870385;6356.555041147168;6358.141650877073;6360.395762402564;5755.9424405756245;5840.737166827503;5869.148973398833;5898.2332296802;5900.734466948998;4666.906661866744;5551.833444996657;5552.91670624941;5554.250176226238;5556.666600003932;6330.620162790247;6354.586951848115;6454.644994525346;6469.029645553204;6475.773347932894;6328.810135695937;6330.272018717907;6353.650549219838;6357;6372.36276372359;6244.188255526752;6538.313477085027;6547.9672601636685;6565.507586931095;6566.474682025522;6170.845728856635;6245.219347581552;6278.654673992792;6306.621602703853;6328.272248691459;6334.208223972004;6334.873302534015;6335.841603959938;6341;6341.968290158519;6323.272823625342;6338.461230795434;6343.55595108338;6348.968255158695;6357.046443033397;6058.394160583906;6137.836677219377;6139.171211886338;6153.84615384619;6315.5894866833505;5434.510894019557;6140.692965351625;6145.84635384119;6159.72281247336;6160.322364539987;6254.437100660963;6288.24541055058;6293.087502312231;6293.244810622755;6341.841453963688;5928.67392293428;6067;6072.271327440735;6093.634381937098;6163.568550201443 16:37:39 INFO - 2015-11-20 16:37:39,490 DEBUG : BROWSER_OUTPUT: |1;ext.html;551.0032417514908;554.8058179637128;564.3622706341833;634.4290138875012;637.7385272038463;32185.51721724173;32676.346473070553;34179.487307690404;41244.96887577812;41325.7602271932;44491.88770280745;44882.551174488246;44908.1018379633;45101.7744911275;45135;8962.86555701665;9840.311178217546;10006.449645269508;10027.799444011116;10035.448050357227;8927.732168034969;9034.593443295067;11972.341521216329;12101.334426606532;12125.696857578543;11919.165658403916;12013.879861201407;12024.278543287386;12032;12035.037197024218;8915.68795092175;11931;11990;11999.820002699966;12005.219660722025;8890.06654301302;11699;11910.166288359731;11918.582849600309;11964.581239656658;41253;41883.581164188276;41887;41907.161856763;41947.37078943818;3213.935721285561;3272.2473831018997;3309.2223327518013;3325.783824051453;3595.1731101846462;29912;30154.94457693992;30645;30867.845660771553;30953.690463095307;2231.6094683430497;2822.969616090133;2848.957265641017;2869.110575721533;2893.8697758600915;423424;498886;499549;500642.4967875174;605985;51379.743101285;57192.428075719545;70251.29748702448;70668.64665676639;71057.2894271061;69423;70146;70337.64831175811;70401.64799176074;70442.64778676073;14044.438222471192;16687.082210478296;16904.91547542279;16930.238139283763;16943.491695249162;12830.230186188859;13023.218606883618;13030.609081727564;13057.608271751862;13062.020348473903;20313.390598282076;20488.69266960997;20505.692414613794;20509.692354614694;20529.79470205309;7754.92245077542;7948.322004359426;8701.390902636882;9134.177923986874;9366.157045865768;948.374073111743;1004.7287232447198;1009.1220638044948;1026.225199974015;1089.2538611051455;29662.851685741432;29750;30168.24579385533;30519.69480305213;30558.388832223674;1059.9894001060045;1105.5301496863801;1116.6705821782593;1193.8746431624554;1272.0459655258555;15402.152881591395;15402.537923862077;15704.685906281811;15728.781139011631;15910.44313449047;547357;551016;552539;552792;553166;60526.39473605296;60904.39095608987;60974.695126524086;60990.08514872281;61264.69367653133;1361.8297712785902;1381.1851007905384;1389.3817251323064;1477.5050358130147;1631.959201019984;28471.715282847734;29505.704942950295;29659.555106673848;30138.54792178075;30223.9421620251;41227.58772412237;49953.75023124861;50333.74833125957;50454.2431863515;50456.74771626118;424282;514430;610658;613496;615129;30281.394372112874;30461.847690761406;30549.23626909345;30574.388512230074;30577;42909.57090429056;43229.351559726;43274.567254328314;43964.560354396046;44360.33459498046;32037.519437208928;36257.456138157424;36300.63699362973;36382;37345.813270933475;36049.459258110626;37411.99900423201;37456.063598410256;37852.621473786014;38257.4261386085;36621;37144.81427592953;37548.812255939636;37595.2480950374;37646.2470750578;31737.36525269528;33657.25836639984;34024;34160.31679366349;34603.13492162716;25051.373715656526;25159.622605661294;25384.492310153324;25448.618270726325;25683 16:37:39 INFO - 2015-11-20 16:37:39,493 DEBUG : BROWSER_OUTPUT: |2;jquery.html;311.5466995521516;365.7165696585148;365.72387847175395;366.23639711202145;366.6718287133015;16338.918305408457;16962.83037169628;20201.797982020176;21382.25162119326;22481.437964050907;22034;22085.668714969248;22462.55074898501;22469.887650561766;22479.438014049658;5521.972390138044;5642.661440313574;6416.647084410356;6594.934050659504;6614.305497922721;4560.749158796265;6522.152120224364;6951.409130223937;7346.118465784113;7351.595662238575;7241.782746517613;7252.7461538846155;7315.890261646079;7334.853302933938;7656.042994625672;7562.432817538679;7565.735199268;7577.507462014952;7581.999999999973;7597.354224890891;6908.447324214051;6981.82545436363;6988.266232045613;6991.021257024021;6991.860162796766;26710.732892671018;26805;27294.454110917868;27646.032388866493;28409.715902840915;2177.8475506714535;2306.9964565414098;2307.2501437033034;2418.7460316666848;2578.987105064463;12725.936370318183;15721.842781572152;15829.68340633181;15839.762403563956;15907.12510811905;1557.6417423992546;1807.972880406795;1827.0590645817415;1848.408509277032;1883.5573640194543;116609;119665.40167299195;121044.18433723412;121221.10728371078;121305;18444.538886527676;18912.52718682044;18918.90540547316;18975.33586324472;19016.334428294944;28060.43879122447;28062;28122.71877281242;28152.155435336565;28235.294117646812;10544.420056896945;10650.680479585624;10676.359418434919;10708.946455267675;10793.730156746144;9099.454032758056;9105.908940910638;9109.498977556166;9203.40177888435;9225;7191.6552152459735;8669.21977022071;8693.608787604573;8703.129687031245;8754.69358572447;3311.586051743532;3441.1397150712323;3446.483027545838;3468.9653103469145;3478.913027174341;731.6561216228364;892.5001998880648;946.1910066892846;1000.559753708366;1000.5697550053401;16559.17204139788;16686.666266674598;19734;20673.586528269352;21277.78722212758;869.4044579463088;917.857732051533;921.7188757428914;974.3812678948918;1033.6227277043824;9821.901780982098;10626.937306269312;11074.280171788809;11170.944145279222;11207.495662695199;776208;779465;780543.0972845213;802339;803015;60045.39954600485;88184;113619.31903404796;114735.85264147418;126448;958.9952050239843;1178.505027888289;1183.8875306845837;1184.242085065576;1199.3463562358536;18331.35840245585;18442.538936526693;18547.629047419246;18566.535836604195;18578.071096445394;39286.80356598199;50993.23510147425;52107.478925210264;52146.739266303426;52294;71895;72003.63998179976;72194.63902680454;73204.26795732188;74204.62897685477;9598.280128990493;9624.711258662252;9877.308588398742;9986.950065249628;9996.550155242887;18269.54326141857;18610.534736631693;18717.344892928682;19027.143778530277;19685;15347.386104556139;15657.843421565638;15684.607884802972;15980.280887359864;16100.275487602852;9521.2859035574;11480.827787583026;14774.18741969202;15342.849286303795;15635.140067296408;16138.19309034567;16723.665526689154;16768.916155419145;16842.66314673675;17084.572885677957;9728.708138755848;9864.161546268648;9976.900230997597;10116.1401280889;10173.542190601293;10235.897641023494;10365.481725913523;12555.560555380518;15798.447054353042;16337.591560210614 16:37:39 INFO - 2015-11-20 16:37:39,493 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1551.6586351002782;1555.6655319106396;1701.3704929176206;1821.4353550399378;1853.9617814024143;7291.5260508067;7453.66458509367;8161.8775718364195;8282.792930176733;8309.376796740238;7978.840423191533;8137.552434616094;8154.673813047486;8180.795480113;8192.713255036075;2033.9288124915631;2129.031290762707;2346.495503466754;2376.702912135983;2378.048780487801;2033.5831154613343;2355.5995480768224;2378.500514891875;2385.6540801583847;2388.199953015733;2312.710911136108;2334.8949297281665;2339.543788961153;2359.4691194481275;2370.668106465096;1869.4391682495198;2151.419116838445;2155.6874253233195;2321.804270800539;2344.765523447659;2350.823688223373;2384.4396566806786;2384.7376788553247;2386.8567885926727;2390.8206884483734;8048.195180481964;8192.54940978246;8228.21831925966;8254.009518857716;8256.339492840558;5089.185730283174;5199.6360254782185;5210.791568337262;5218.634695571312;5219.191025391033;2867.6845546989816;3463.290025544757;3536.0806190390426;3537.0980399998093;3552.289542091592;1003.4079892863173;1006.4011912911806;1007.5919252702668;1041.0162396535202;1047.4553232319226;10723.35659860403;10738.261743255498;10739.62411315608;10762.569497220102;10770.29993050457;3812.8474861005247;4530.252508336088;4621.930671039937;4659.743714095757;4696.483386827446;9486.620535178516;9506.00186980371;9507;9528.714138575715;9547.856782148274;5206.245094461282;5220.903610241816;5221.295125158131;5240.135377662719;5256.106461901486;4779.569838714532;4788.329633851264;4800.73595952226;4805.783739731721;4809.831655892027;3201.855916483764;3738.887833365003;3865.7100717446306;3868.6905047596124;3875.302445559826;1079.881213066562;1253.718232816284;1255.1026016398318;1258.8552316483722;1272.1730874931368;1294.4239813283186;1299.6296055624102;1309.4173092973535;1330.221820235154;1333.919964802115;7658.961705191438;7682.769516914502;7742.6902923883545;7754.224577542313;7783.338416234684;496.83852747857094;505.9544640982329;509.69163655988336;511.8925025744561;512.0475914798471;5699;5780.971095144498;5799.101139323411;6099.939000610026;6260.311365749764;8255.834883302301;9654.372465789702;9800;9823.75440613976;9951.402915825074;9588.66439674608;9646.372985755903;9649.710508684751;9729.221662267002;9736.83158021042;7575.962120189474;7613.9238607614325;7723.53658780475;7762.379009679212;7771.106322772954;7729.768106956801;7763.2236776321915;7783.92216077832;7785.571793551409;7799.883001754864;8809;8822.735317940473;8855.645774168961;8972.28221742272;9006.144416280444;8974.326925480484;9165.587548560465;9230.169284764403;9252.074792520694;9330.393524420891;6825.35159159879;7248.60132692707;7253.274672532704;7254.419646428168;7255.383292420203;6669.166354205724;7746.535207887545;7794.571298578406;7818.257265559762;7837.49056311338;7075.858482830212;7135.393491553276;7308.415326773952;7394.55632662042;7427.517211381243;7144.3570078693165;7203.783886483414;7258.818529536804;7366.373858222111;7373.410127189919;7309.4152467803515;7340.632968351454;7372.815679608053;7372.852542949004;7392.778216653509;5661.348944871393;6688.866222675617;6714.3957043866285;6776.712424639303;6808.080909077211;6829.248782634006;6840.555363901331;6880.58716477013;6891;6893.138357705287 16:37:39 INFO - 2015-11-20 16:37:39,497 DEBUG : BROWSER_OUTPUT: |4;prototype.html;273.47083393633307;319.15583282218535;326.3179953896356;330.09060039590923;335.3778740436489;6776.457883369331;6844.212915514718;6945.444364450845;6966.198887127982;6970.721171153161;6587.176602924635;6697.765578204764;6730.96634516828;6754.290799466046;6857.588544687323;3756.943645845301;4944.1594928862;5018.2723505091835;5023.422306434752;5054.090263752523;5005.949940500603;5016.072026675077;5022.04581129586;5023.095842748304;5029.899402011957;4683.133620280242;4758.428988521382;4868.294097355882;4872.707637541741;4892.951070489303;4676.205045142334;4841.419029716457;4850.757462126897;4868.902621947576;4870.878228044292;4137.482814648169;4165.187788381267;4237.046664500463;4263.445752052245;4270.231358355495;6555.04951781989;6576.539642225046;6589.670516474157;6591.868162636768;6598.076269322299;5837.328707198684;5967.313758917737;6000.36996115406;6001.4298641628975;6037.396260373971;7371.557706537625;7374.815629609303;7376.852462950765;7384.113906331221;7385.372243359321;4824.469308376111;4835.5889749371345;4839;4841.2496063110275;4842.588379987706;7595.924040759633;7831.882521762178;7858.882116768253;7861.056673199196;7870.094939081964;4740.170470167707;4771.1888978872985;4779.474257831635;4779.808807647655;4786.210275304536;4855.95144048555;4864.416270047617;4869.63477739171;4873.634477414208;4873.853784386474;5057.494250574913;5612.989661860905;5877.706114694333;5877.941220587825;5889.234399528034;7217.025701530226;7350.375218106414;7394.5193562419345;7412.51818631798;7418.777436676908;1664.983350166507;1684.082175214511;1690.5013021158788;1694.212191331037;1696.847283744469;1052.3843551522293;1065.9946700266605;1066.7706443114769;1070.464767616192;1080.103514083309;6508.284088750233;6659.234188068337;6782.1861376635115;6891.965540172267;6899.724011039502;6615.834604134935;7773.222677732181;7774.028246469192;7788.649510772028;7809.921900781033;6019.5853974316;6855.417289530346;6954.374106330454;6997;7002.614856182959;3907.5506316773367;3977.065389633434;4088.7751173685733;4091;4107.322291821875;6868.965655171792;7982.600869956479;8107.878381824277;8113.066997295268;8118.75643730689;5454.754536045887;8011.599420029092;8023.398245131639;8029.59852007409;8039.7990050248045;8116.147804480563;8128.796780080427;8132.634031468599;8133.186681331819;8138.755837324889;7820.061592608923;7827.139014708491;7833.49082309648;7834.334081603128;7848.058233012075;7433.8141546461775;7638.388928885787;7646.120696120018;7683.154852966058;7685.346745526469;8075.5558444286125;8093.473924194908;8098.5545794981845;8101.149379315087;8102.7569172924905;4945.431275403231;5000.749962501933;5007.649464537448;5009.974950125226;5026.974865125651;7346.485745997943;7619.238076192337;7631;7638;7661.310482056641;6525.412712855866;6795.7961261162245;7357.889631655637;7361.30067643573;7387.261273872569;7117.1459424869345;7325.597092159983;7333.816654583678;7334.523255988343;7338.266173382833;7132.8930066048015;7133.82165445868;7141.785746427616;7165.534240274365;7169.892451613126;7097.858042839218;7217;7299.8540029200185;7319.890201646873;7333.1200255969625;7172.390346820579;7189.2810718927685;7258.891116633149;7270.927290727025;7280.745173918887 16:37:39 INFO - 2015-11-20 16:37:39,498 DEBUG : BROWSER_OUTPUT: |5;yui.html;747.8093086263004;802.113664400837;803.2008151888872;807.3783186946051;814.2712272516095;15119.092854428729;15497.38010479581;15497.767533487007;15504.767428488582;15508;14275.785863212033;14421;14422;14437;14452;743.1602289412956;749.449154871172;752.4093586534572;753.7927070055752;911.3301723233418;738.4350971506801;751.6805357722945;918.4672889723978;931.4644079654192;939.1266122506066;971.9854202186973;972.9854052189223;983.965561205358;987.3434166279416;988.293370240278;976.9985764591315;982.2633025231077;982.6020461712982;983.0415345038601;996.4768496539302;585.0405335250193;588.3498733899065;590.2385922160408;590.8404730722681;591.7721677154284;12490.43793029316;15124.243787810676;15358.846411535853;15380.92309538445;15385.307661155275;12607.873921260854;12663.430145643377;12940.417681204368;12956.870431295662;13167.078304518593;9917.553710083064;10259.846102308471;10290.125339346165;10318.793624127475;10966.451677416177;3487.9651203487892;3520.2959408118477;3563.6970857477145;3699.5930447650735;3716.535433070866;77396.61301693512;78696;79072.60463697702;79091.41817163625;79388;9426.528673566294;9427.76430589227;9468.053194680477;9570.47362395075;10020.198384129251;21314.36056918295;21564.46088847791;21578.028988695547;21612.351629451143;21633.459163521038;7367.926320736831;7413.258674132544;7646.885296720554;7683.039620047494;7720.806979825549;3982.2234664240195;4072.7963601819793;4084.857030003995;4107.0553772631865;4116.526599441103;3393.8472768725464;3441.397755392796;3442.8794992175654;3453.620101788801;3453.7582369233915;616.5437576193584;635.0696230023038;638.1544453599;643.4305639508974;646.0761111610349;493.64950884872144;514.8095204774257;515.5437437867439;523.9083160446907;552.1469329885336;8856.778580535409;9304.25565954722;9311.627534898527;9369.531523423802;9635.807283854423;448.70833957926953;584.260909948915;589.8731772668897;601.6432943711901;651.5406638319973;3843.673287770515;3911.5110611173604;3967.384811437267;4166.83332666696;4225.422144434051;89074.55462722774;99777.00222997823;104497;105843.4707826456;107823;68587.65706171437;87080;87932;88400.5579972096;89462.65806012785;77813.61093194498;79360.6031969848;79804;80029;80693.19306806974;8263.421560490948;8294.419390642597;8403.663853445794;8593.870016600957;8686.565671716515;52925.735371322895;53203.733981329846;53241.4675853252;53506.19740703815;53625.463745362045;76731;77789.2221077782;77820.2217977813;78855;79993;11022.834657479983;11185.993260606585;11341.4896329667;11414.48634811419;11722.70693232676;11984.700382490508;12157.209781364536;12162.93918530437;12177.33024683651;12201.877981220074;11437.485313161094;11580.594679186524;11583.826242606536;11597.362145082101;11621.709457263636;11467.197296189186;11478.713032174262;11507.884921151017;11541;11556.94221528887;11034.337939723642;11144.33134011962;11153.219274650697;11156.888431115585;11162.386068766296;9703.272254580794;10187.032231937954;10241.74395640115;10260.486975651336;10297.12474439681;9829.557669904729;10101.393916365041;10122.59509619607;10131.44277064739;10153.187744980236 16:37:39 INFO - 2015-11-20 16:37:39,499 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:37:39 INFO - 2015-11-20 16:37:39,499 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:37:39 INFO - 2015-11-20 16:37:39,499 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1109 16:37:39 INFO - 2015-11-20 16:37:39,499 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:37:39 INFO - 2015-11-20 16:37:39,499 DEBUG : BROWSER_OUTPUT: __startTimestamp1448066259484__endTimestamp 16:37:39 INFO - 2015-11-20 16:37:39,499 DEBUG : BROWSER_OUTPUT: 16:37:39 INFO - 2015-11-20 16:37:39,499 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:37:39 INFO - 2015-11-20 16:37:39,499 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:37:39 INFO - 2015-11-20 16:37:39,499 DEBUG : BROWSER_OUTPUT: 16:37:39 INFO - 2015-11-20 16:37:39,499 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5867.57 Median:6131.50 stddev:666.43 (10.9%) stddev-sans-first:621.31 16:37:39 INFO - 2015-11-20 16:37:39,500 DEBUG : BROWSER_OUTPUT: Values: 2728.4 3472.2 3473.7 3511.7 3547.0 5640.7 5817.8 5910.3 5914.5 5930.4 5841.0 5858.2 5906.1 6054.9 6085.3 5263.9 5302.9 5332.7 5362.2 5428.5 5395.3 5420.3 5422.4 5431.2 5469.5 5159.4 5265.8 5291.7 5377.1 5395.8 5195.4 5273.0 5290.4 5296.5 5303.4 5242.7 5268.0 5272.7 5298.7 5318.6 5750.6 5763.0 5766.6 5773.0 5852.6 6146.9 6182.0 6277.9 6311.1 6343.1 6328.8 6339.4 6360.0 6368.0 6368.2 5904.4 6010.0 6028.6 6037.6 6040.9 6127.5 6305.1 6319.2 6350.7 6499.5 6274.4 6340.5 6349.0 6370.4 6372.1 6330.6 6339.2 6350.0 6354.4 6361.3 6131.5 6180.4 6192.9 6278.2 6324.2 6300.3 6301.4 6307.5 6309.6 6317.4 5077.7 5088.9 5092.0 5093.5 5100.9 4400.7 4420.8 4487.6 4531.4 4552.5 6036.7 6050.9 6069.9 6071.5 6079.2 6348.6 6354.3 6356.6 6358.1 6360.4 5755.9 5840.7 5869.1 5898.2 5900.7 4666.9 5551.8 5552.9 5554.3 5556.7 6330.6 6354.6 6454.6 6469.0 6475.8 6328.8 6330.3 6353.7 6357.0 6372.4 6244.2 6538.3 6548.0 6565.5 6566.5 6170.8 6245.2 6278.7 6306.6 6328.3 6334.2 6334.9 6335.8 6341.0 6342.0 6323.3 6338.5 6343.6 6349.0 6357.0 6058.4 6137.8 6139.2 6153.8 6315.6 5434.5 6140.7 6145.8 6159.7 6160.3 6254.4 6288.2 6293.1 6293.2 6341.8 5928.7 6067.0 6072.3 6093.6 6163.6 16:37:39 INFO - 2015-11-20 16:37:39,500 DEBUG : BROWSER_OUTPUT: 16:37:39 INFO - 2015-11-20 16:37:39,501 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:68125.16 Median:18491.52 stddev:144159.53 (779.6%) stddev-sans-first:144474.65 16:37:39 INFO - 2015-11-20 16:37:39,501 DEBUG : BROWSER_OUTPUT: Values: 551.0 554.8 564.4 634.4 637.7 32185.5 32676.3 34179.5 41245.0 41325.8 44491.9 44882.6 44908.1 45101.8 45135.0 8962.9 9840.3 10006.4 10027.8 10035.4 8927.7 9034.6 11972.3 12101.3 12125.7 11919.2 12013.9 12024.3 12032.0 12035.0 8915.7 11931.0 11990.0 11999.8 12005.2 8890.1 11699.0 11910.2 11918.6 11964.6 41253.0 41883.6 41887.0 41907.2 41947.4 3213.9 3272.2 3309.2 3325.8 3595.2 29912.0 30154.9 30645.0 30867.8 30953.7 2231.6 2823.0 2849.0 2869.1 2893.9 423424.0 498886.0 499549.0 500642.5 605985.0 51379.7 57192.4 70251.3 70668.6 71057.3 69423.0 70146.0 70337.6 70401.6 70442.6 14044.4 16687.1 16904.9 16930.2 16943.5 12830.2 13023.2 13030.6 13057.6 13062.0 20313.4 20488.7 20505.7 20509.7 20529.8 7754.9 7948.3 8701.4 9134.2 9366.2 948.4 1004.7 1009.1 1026.2 1089.3 29662.9 29750.0 30168.2 30519.7 30558.4 1060.0 1105.5 1116.7 1193.9 1272.0 15402.2 15402.5 15704.7 15728.8 15910.4 547357.0 551016.0 552539.0 552792.0 553166.0 60526.4 60904.4 60974.7 60990.1 61264.7 1361.8 1381.2 1389.4 1477.5 1632.0 28471.7 29505.7 29659.6 30138.5 30223.9 41227.6 49953.8 50333.7 50454.2 50456.7 424282.0 514430.0 610658.0 613496.0 615129.0 30281.4 30461.8 30549.2 30574.4 30577.0 42909.6 43229.4 43274.6 43964.6 44360.3 32037.5 36257.5 36300.6 36382.0 37345.8 36049.5 37412.0 37456.1 37852.6 38257.4 36621.0 37144.8 37548.8 37595.2 37646.2 31737.4 33657.3 34024.0 34160.3 34603.1 25051.4 25159.6 25384.5 25448.6 25683.0 16:37:39 INFO - 2015-11-20 16:37:39,501 DEBUG : BROWSER_OUTPUT: 16:37:39 INFO - 2015-11-20 16:37:39,501 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:41162.36 Median:26757.87 stddev:129376.02 (483.5%) stddev-sans-first:129702.59 16:37:39 INFO - 2015-11-20 16:37:39,503 DEBUG : BROWSER_OUTPUT: Values: 311.5 365.7 365.7 366.2 366.7 16338.9 16962.8 20201.8 21382.3 22481.4 22034.0 22085.7 22462.6 22469.9 22479.4 5522.0 5642.7 6416.6 6594.9 6614.3 4560.7 6522.2 6951.4 7346.1 7351.6 7241.8 7252.7 7315.9 7334.9 7656.0 7562.4 7565.7 7577.5 7582.0 7597.4 6908.4 6981.8 6988.3 6991.0 6991.9 26710.7 26805.0 27294.5 27646.0 28409.7 2177.8 2307.0 2307.3 2418.7 2579.0 12725.9 15721.8 15829.7 15839.8 15907.1 1557.6 1808.0 1827.1 1848.4 1883.6 116609.0 119665.4 121044.2 121221.1 121305.0 18444.5 18912.5 18918.9 18975.3 19016.3 28060.4 28062.0 28122.7 28152.2 28235.3 10544.4 10650.7 10676.4 10708.9 10793.7 9099.5 9105.9 9109.5 9203.4 9225.0 7191.7 8669.2 8693.6 8703.1 8754.7 3311.6 3441.1 3446.5 3469.0 3478.9 731.7 892.5 946.2 1000.6 1000.6 16559.2 16686.7 19734.0 20673.6 21277.8 869.4 917.9 921.7 974.4 1033.6 9821.9 10626.9 11074.3 11170.9 11207.5 776208.0 779465.0 780543.1 802339.0 803015.0 60045.4 88184.0 113619.3 114735.9 126448.0 959.0 1178.5 1183.9 1184.2 1199.3 18331.4 18442.5 18547.6 18566.5 18578.1 39286.8 50993.2 52107.5 52146.7 52294.0 71895.0 72003.6 72194.6 73204.3 74204.6 9598.3 9624.7 9877.3 9987.0 9996.6 18269.5 18610.5 18717.3 19027.1 19685.0 15347.4 15657.8 15684.6 15980.3 16100.3 9521.3 11480.8 14774.2 15342.8 15635.1 16138.2 16723.7 16768.9 16842.7 17084.6 9728.7 9864.2 9976.9 10116.1 10173.5 10235.9 10365.5 12555.6 15798.4 16337.6 16:37:39 INFO - 2015-11-20 16:37:39,503 DEBUG : BROWSER_OUTPUT: 16:37:39 INFO - 2015-11-20 16:37:39,503 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5691.08 Median:6464.74 stddev:2957.95 (45.8%) stddev-sans-first:2949.89 16:37:39 INFO - 2015-11-20 16:37:39,504 DEBUG : BROWSER_OUTPUT: Values: 1551.7 1555.7 1701.4 1821.4 1854.0 7291.5 7453.7 8161.9 8282.8 8309.4 7978.8 8137.6 8154.7 8180.8 8192.7 2033.9 2129.0 2346.5 2376.7 2378.0 2033.6 2355.6 2378.5 2385.7 2388.2 2312.7 2334.9 2339.5 2359.5 2370.7 1869.4 2151.4 2155.7 2321.8 2344.8 2350.8 2384.4 2384.7 2386.9 2390.8 8048.2 8192.5 8228.2 8254.0 8256.3 5089.2 5199.6 5210.8 5218.6 5219.2 2867.7 3463.3 3536.1 3537.1 3552.3 1003.4 1006.4 1007.6 1041.0 1047.5 10723.4 10738.3 10739.6 10762.6 10770.3 3812.8 4530.3 4621.9 4659.7 4696.5 9486.6 9506.0 9507.0 9528.7 9547.9 5206.2 5220.9 5221.3 5240.1 5256.1 4779.6 4788.3 4800.7 4805.8 4809.8 3201.9 3738.9 3865.7 3868.7 3875.3 1079.9 1253.7 1255.1 1258.9 1272.2 1294.4 1299.6 1309.4 1330.2 1333.9 7659.0 7682.8 7742.7 7754.2 7783.3 496.8 506.0 509.7 511.9 512.0 5699.0 5781.0 5799.1 6099.9 6260.3 8255.8 9654.4 9800.0 9823.8 9951.4 9588.7 9646.4 9649.7 9729.2 9736.8 7576.0 7613.9 7723.5 7762.4 7771.1 7729.8 7763.2 7783.9 7785.6 7799.9 8809.0 8822.7 8855.6 8972.3 9006.1 8974.3 9165.6 9230.2 9252.1 9330.4 6825.4 7248.6 7253.3 7254.4 7255.4 6669.2 7746.5 7794.6 7818.3 7837.5 7075.9 7135.4 7308.4 7394.6 7427.5 7144.4 7203.8 7258.8 7366.4 7373.4 7309.4 7340.6 7372.8 7372.9 7392.8 5661.3 6688.9 6714.4 6776.7 6808.1 6829.2 6840.6 6880.6 6891.0 6893.1 16:37:39 INFO - 2015-11-20 16:37:39,504 DEBUG : BROWSER_OUTPUT: 16:37:39 INFO - 2015-11-20 16:37:39,504 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6007.54 Median:6779.32 stddev:1960.87 (28.9%) stddev-sans-first:1918.56 16:37:39 INFO - 2015-11-20 16:37:39,506 DEBUG : BROWSER_OUTPUT: Values: 273.5 319.2 326.3 330.1 335.4 6776.5 6844.2 6945.4 6966.2 6970.7 6587.2 6697.8 6731.0 6754.3 6857.6 3756.9 4944.2 5018.3 5023.4 5054.1 5005.9 5016.1 5022.0 5023.1 5029.9 4683.1 4758.4 4868.3 4872.7 4893.0 4676.2 4841.4 4850.8 4868.9 4870.9 4137.5 4165.2 4237.0 4263.4 4270.2 6555.0 6576.5 6589.7 6591.9 6598.1 5837.3 5967.3 6000.4 6001.4 6037.4 7371.6 7374.8 7376.9 7384.1 7385.4 4824.5 4835.6 4839.0 4841.2 4842.6 7595.9 7831.9 7858.9 7861.1 7870.1 4740.2 4771.2 4779.5 4779.8 4786.2 4856.0 4864.4 4869.6 4873.6 4873.9 5057.5 5613.0 5877.7 5877.9 5889.2 7217.0 7350.4 7394.5 7412.5 7418.8 1665.0 1684.1 1690.5 1694.2 1696.8 1052.4 1066.0 1066.8 1070.5 1080.1 6508.3 6659.2 6782.2 6892.0 6899.7 6615.8 7773.2 7774.0 7788.6 7809.9 6019.6 6855.4 6954.4 6997.0 7002.6 3907.6 3977.1 4088.8 4091.0 4107.3 6869.0 7982.6 8107.9 8113.1 8118.8 5454.8 8011.6 8023.4 8029.6 8039.8 8116.1 8128.8 8132.6 8133.2 8138.8 7820.1 7827.1 7833.5 7834.3 7848.1 7433.8 7638.4 7646.1 7683.2 7685.3 8075.6 8093.5 8098.6 8101.1 8102.8 4945.4 5000.7 5007.6 5010.0 5027.0 7346.5 7619.2 7631.0 7638.0 7661.3 6525.4 6795.8 7357.9 7361.3 7387.3 7117.1 7325.6 7333.8 7334.5 7338.3 7132.9 7133.8 7141.8 7165.5 7169.9 7097.9 7217.0 7299.9 7319.9 7333.1 7172.4 7189.3 7258.9 7270.9 7280.7 16:37:39 INFO - 2015-11-20 16:37:39,506 DEBUG : BROWSER_OUTPUT: 16:37:39 INFO - 2015-11-20 16:37:39,506 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19429.51 Median:26724.82 stddev:27984.25 (104.7%) stddev-sans-first:28027.59 16:37:39 INFO - 2015-11-20 16:37:39,507 DEBUG : BROWSER_OUTPUT: Values: 747.8 802.1 803.2 807.4 814.3 15119.1 15497.4 15497.8 15504.8 15508.0 14275.8 14421.0 14422.0 14437.0 14452.0 743.2 749.4 752.4 753.8 911.3 738.4 751.7 918.5 931.5 939.1 972.0 973.0 984.0 987.3 988.3 977.0 982.3 982.6 983.0 996.5 585.0 588.3 590.2 590.8 591.8 12490.4 15124.2 15358.8 15380.9 15385.3 12607.9 12663.4 12940.4 12956.9 13167.1 9917.6 10259.8 10290.1 10318.8 10966.5 3488.0 3520.3 3563.7 3699.6 3716.5 77396.6 78696.0 79072.6 79091.4 79388.0 9426.5 9427.8 9468.1 9570.5 10020.2 21314.4 21564.5 21578.0 21612.4 21633.5 7367.9 7413.3 7646.9 7683.0 7720.8 3982.2 4072.8 4084.9 4107.1 4116.5 3393.8 3441.4 3442.9 3453.6 3453.8 616.5 635.1 638.2 643.4 646.1 493.6 514.8 515.5 523.9 552.1 8856.8 9304.3 9311.6 9369.5 9635.8 448.7 584.3 589.9 601.6 651.5 3843.7 3911.5 3967.4 4166.8 4225.4 89074.6 99777.0 104497.0 105843.5 107823.0 68587.7 87080.0 87932.0 88400.6 89462.7 77813.6 79360.6 79804.0 80029.0 80693.2 8263.4 8294.4 8403.7 8593.9 8686.6 52925.7 53203.7 53241.5 53506.2 53625.5 76731.0 77789.2 77820.2 78855.0 79993.0 11022.8 11186.0 11341.5 11414.5 11722.7 11984.7 12157.2 12162.9 12177.3 12201.9 11437.5 11580.6 11583.8 11597.4 11621.7 11467.2 11478.7 11507.9 11541.0 11556.9 11034.3 11144.3 11153.2 11156.9 11162.4 9703.3 10187.0 10241.7 10260.5 10297.1 9829.6 10101.4 10122.6 10131.4 10153.2 16:37:39 INFO - 2015-11-20 16:37:39,507 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:37:39 INFO - 2015-11-20 16:37:39,507 DEBUG : BROWSER_OUTPUT: 16:37:39 INFO - 2015-11-20 16:37:39,964 INFO : Browser exited with error code: 0 16:37:39 INFO - 2015-11-20 16:37:39,988 INFO : Completed test dromaeo_css (00:18:34) 16:37:39 INFO - 2015-11-20 16:37:39,988 INFO : Starting test kraken 16:37:39 INFO - 2015-11-20 16:37:39,988 DEBUG : operating with platform_type : mac_ 16:37:39 INFO - 2015-11-20 16:37:39,988 INFO : Initialising browser for kraken test... 16:37:40 INFO - 2015-11-20 16:37:40,001 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpJMQZKX/profile http://localhost:50524/getInfo.html 16:37:42 INFO - 2015-11-20 16:37:42,019 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:37:42 INFO - 2015-11-20 16:37:42,020 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:37:42 INFO - 2015-11-20 16:37:42,020 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:37:42 INFO - 2015-11-20 16:37:42,020 DEBUG : BROWSER_OUTPUT: __metrics 16:37:42 INFO - 2015-11-20 16:37:42,028 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:37:42 INFO - 2015-11-20 16:37:42,697 INFO : Browser initialized. 16:37:42 INFO - 2015-11-20 16:37:42,697 INFO : Running cycle 1/1 for kraken test... 16:37:42 INFO - 2015-11-20 16:37:42,698 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpJMQZKX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:37:54 INFO - 2015-11-20 16:37:54,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 226066432 16:37:54 INFO - 2015-11-20 16:37:54,614 DEBUG : BROWSER_OUTPUT: 16:37:57 INFO - 2015-11-20 16:37:57,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50524/tests/kraken/driver.html?testName=audio-beat-detection) 16:37:57 INFO - 2015-11-20 16:37:57,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 274628608 16:37:57 INFO - 2015-11-20 16:37:57,704 DEBUG : BROWSER_OUTPUT: 16:38:00 INFO - 2015-11-20 16:38:00,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50524/tests/kraken/driver.html?testName=audio-dft) 16:38:00 INFO - 2015-11-20 16:38:00,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 288788480 16:38:00 INFO - 2015-11-20 16:38:00,826 DEBUG : BROWSER_OUTPUT: 16:38:04 INFO - 2015-11-20 16:38:04,022 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50524/tests/kraken/driver.html?testName=audio-fft) 16:38:04 INFO - 2015-11-20 16:38:04,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 276795392 16:38:04 INFO - 2015-11-20 16:38:04,607 DEBUG : BROWSER_OUTPUT: 16:38:06 INFO - 2015-11-20 16:38:06,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50524/tests/kraken/driver.html?testName=audio-oscillator) 16:38:07 INFO - 2015-11-20 16:38:07,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 279281664 16:38:07 INFO - 2015-11-20 16:38:07,125 DEBUG : BROWSER_OUTPUT: 16:38:09 INFO - 2015-11-20 16:38:09,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50524/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:38:09 INFO - 2015-11-20 16:38:09,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 279646208 16:38:09 INFO - 2015-11-20 16:38:09,706 DEBUG : BROWSER_OUTPUT: 16:38:12 INFO - 2015-11-20 16:38:12,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50524/tests/kraken/driver.html?testName=imaging-darkroom) 16:38:13 INFO - 2015-11-20 16:38:13,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 281157632 16:38:13 INFO - 2015-11-20 16:38:13,094 DEBUG : BROWSER_OUTPUT: 16:38:15 INFO - 2015-11-20 16:38:15,946 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50524/tests/kraken/driver.html?testName=imaging-desaturate) 16:38:16 INFO - 2015-11-20 16:38:16,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 280449024 16:38:16 INFO - 2015-11-20 16:38:16,548 DEBUG : BROWSER_OUTPUT: 16:38:19 INFO - 2015-11-20 16:38:19,498 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50524/tests/kraken/driver.html?testName=json-parse-financial) 16:38:20 INFO - 2015-11-20 16:38:20,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 281866240 16:38:20 INFO - 2015-11-20 16:38:20,098 DEBUG : BROWSER_OUTPUT: 16:38:21 INFO - 2015-11-20 16:38:21,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50524/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:38:22 INFO - 2015-11-20 16:38:22,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 313339904 16:38:22 INFO - 2015-11-20 16:38:22,192 DEBUG : BROWSER_OUTPUT: 16:38:23 INFO - 2015-11-20 16:38:23,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50524/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:38:24 INFO - 2015-11-20 16:38:24,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 316395520 16:38:24 INFO - 2015-11-20 16:38:24,591 DEBUG : BROWSER_OUTPUT: 16:38:26 INFO - 2015-11-20 16:38:26,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50524/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:38:27 INFO - 2015-11-20 16:38:27,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 321908736 16:38:27 INFO - 2015-11-20 16:38:27,357 DEBUG : BROWSER_OUTPUT: 16:38:29 INFO - 2015-11-20 16:38:29,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50524/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:38:30 INFO - 2015-11-20 16:38:30,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 322789376 16:38:30 INFO - 2015-11-20 16:38:30,518 DEBUG : BROWSER_OUTPUT: 16:38:32 INFO - 2015-11-20 16:38:32,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50524/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:38:33 INFO - 2015-11-20 16:38:33,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 322514944 16:38:33 INFO - 2015-11-20 16:38:33,516 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50524/tests/kraken/driver.html?testName=ai-astar) 16:38:35 INFO - 2015-11-20 16:38:35,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 381849600 16:38:35 INFO - 2015-11-20 16:38:35,420 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,420 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:38:35 INFO - 2015-11-20 16:38:35,420 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:38:35 INFO - 2015-11-20 16:38:35,420 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:38:35 INFO - 2015-11-20 16:38:35,420 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:38:35 INFO - 2015-11-20 16:38:35,420 DEBUG : BROWSER_OUTPUT: |0;ai-astar;103;108;108;110;109;109;109;110;110;117 16:38:35 INFO - 2015-11-20 16:38:35,420 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;119;145;155;115;143;140;115;153;118 16:38:35 INFO - 2015-11-20 16:38:35,420 DEBUG : BROWSER_OUTPUT: |2;audio-dft;181;183;181;180;182;182;183;184;186;182 16:38:35 INFO - 2015-11-20 16:38:35,420 DEBUG : BROWSER_OUTPUT: |3;audio-fft;61;71;70;72;55;58;63;101;100;48 16:38:35 INFO - 2015-11-20 16:38:35,421 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;84;82;119;76;75;74;112;74;74;114 16:38:35 INFO - 2015-11-20 16:38:35,421 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;85;85;99;132;121;85;87;86;84;87 16:38:35 INFO - 2015-11-20 16:38:35,421 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;94;94;93;93;94;97;94;95;132;93 16:38:35 INFO - 2015-11-20 16:38:35,421 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;88;84;85;85;84;100;136;120;131;145 16:38:35 INFO - 2015-11-20 16:38:35,421 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;55;54;53;54;55;54;63;52;53 16:38:35 INFO - 2015-11-20 16:38:35,421 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;65;65;64;67;67;67;67;67;66 16:38:35 INFO - 2015-11-20 16:38:35,421 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;81;82;81;95;103;104;104;81;83 16:38:35 INFO - 2015-11-20 16:38:35,421 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;123;126;126;127;123;127;118;130;121 16:38:35 INFO - 2015-11-20 16:38:35,421 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;133;136;135;134;134;122;133;135;132;120 16:38:35 INFO - 2015-11-20 16:38:35,421 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;63;65;65;66;63;64;64;65;64 16:38:35 INFO - 2015-11-20 16:38:35,421 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:38:35 INFO - 2015-11-20 16:38:35,421 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:38:35 INFO - 2015-11-20 16:38:35,421 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1045 16:38:35 INFO - 2015-11-20 16:38:35,421 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:38:35 INFO - 2015-11-20 16:38:35,422 DEBUG : BROWSER_OUTPUT: __startTimestamp1448066315414__endTimestamp 16:38:35 INFO - 2015-11-20 16:38:35,422 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,422 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:38:35 INFO - 2015-11-20 16:38:35,422 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:38:35 INFO - 2015-11-20 16:38:35,422 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,422 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.30 Median:109.50 stddev:3.40 (3.1%) stddev-sans-first:2.74 16:38:35 INFO - 2015-11-20 16:38:35,422 DEBUG : BROWSER_OUTPUT: Values: 103.0 108.0 108.0 110.0 109.0 109.0 109.0 110.0 110.0 117.0 16:38:35 INFO - 2015-11-20 16:38:35,422 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,422 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:135.40 Median:144.00 stddev:16.71 (11.6%) stddev-sans-first:16.74 16:38:35 INFO - 2015-11-20 16:38:35,422 DEBUG : BROWSER_OUTPUT: Values: 151.0 119.0 145.0 155.0 115.0 143.0 140.0 115.0 153.0 118.0 16:38:35 INFO - 2015-11-20 16:38:35,422 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,422 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:182.40 Median:182.50 stddev:1.71 (0.9%) stddev-sans-first:1.74 16:38:35 INFO - 2015-11-20 16:38:35,422 DEBUG : BROWSER_OUTPUT: Values: 181.0 183.0 181.0 180.0 182.0 182.0 183.0 184.0 186.0 182.0 16:38:35 INFO - 2015-11-20 16:38:35,422 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,423 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:69.90 Median:62.00 stddev:17.79 (28.7%) stddev-sans-first:18.58 16:38:35 INFO - 2015-11-20 16:38:35,423 DEBUG : BROWSER_OUTPUT: Values: 61.0 71.0 70.0 72.0 55.0 58.0 63.0 101.0 100.0 48.0 16:38:35 INFO - 2015-11-20 16:38:35,423 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,423 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.40 Median:74.50 stddev:18.75 (25.2%) stddev-sans-first:19.82 16:38:35 INFO - 2015-11-20 16:38:35,423 DEBUG : BROWSER_OUTPUT: Values: 84.0 82.0 119.0 76.0 75.0 74.0 112.0 74.0 74.0 114.0 16:38:35 INFO - 2015-11-20 16:38:35,423 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,423 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:95.10 Median:85.50 stddev:17.29 (20.2%) stddev-sans-first:17.95 16:38:35 INFO - 2015-11-20 16:38:35,423 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 99.0 132.0 121.0 85.0 87.0 86.0 84.0 87.0 16:38:35 INFO - 2015-11-20 16:38:35,423 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,423 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:97.90 Median:94.00 stddev:12.04 (12.8%) stddev-sans-first:12.69 16:38:35 INFO - 2015-11-20 16:38:35,423 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 93.0 93.0 94.0 97.0 94.0 95.0 132.0 93.0 16:38:35 INFO - 2015-11-20 16:38:35,423 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,423 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:105.80 Median:84.00 stddev:24.61 (29.3%) stddev-sans-first:25.25 16:38:35 INFO - 2015-11-20 16:38:35,423 DEBUG : BROWSER_OUTPUT: Values: 88.0 84.0 85.0 85.0 84.0 100.0 136.0 120.0 131.0 145.0 16:38:35 INFO - 2015-11-20 16:38:35,423 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,424 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:3.05 (5.6%) stddev-sans-first:3.23 16:38:35 INFO - 2015-11-20 16:38:35,424 DEBUG : BROWSER_OUTPUT: Values: 55.0 55.0 54.0 53.0 54.0 55.0 54.0 63.0 52.0 53.0 16:38:35 INFO - 2015-11-20 16:38:35,424 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,424 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:67.00 stddev:1.15 (1.7%) stddev-sans-first:1.17 16:38:35 INFO - 2015-11-20 16:38:35,424 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 65.0 64.0 67.0 67.0 67.0 67.0 67.0 66.0 16:38:35 INFO - 2015-11-20 16:38:35,424 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,424 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:81.00 stddev:10.74 (13.3%) stddev-sans-first:10.84 16:38:35 INFO - 2015-11-20 16:38:35,424 DEBUG : BROWSER_OUTPUT: Values: 80.0 81.0 82.0 81.0 95.0 103.0 104.0 104.0 81.0 83.0 16:38:35 INFO - 2015-11-20 16:38:35,424 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,424 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:126.00 stddev:3.47 (2.8%) stddev-sans-first:3.64 16:38:35 INFO - 2015-11-20 16:38:35,424 DEBUG : BROWSER_OUTPUT: Values: 123.0 123.0 126.0 126.0 127.0 123.0 127.0 118.0 130.0 121.0 16:38:35 INFO - 2015-11-20 16:38:35,424 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,424 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.40 Median:134.00 stddev:5.62 (4.2%) stddev-sans-first:5.93 16:38:35 INFO - 2015-11-20 16:38:35,424 DEBUG : BROWSER_OUTPUT: Values: 133.0 136.0 135.0 134.0 134.0 122.0 133.0 135.0 132.0 120.0 16:38:35 INFO - 2015-11-20 16:38:35,425 DEBUG : BROWSER_OUTPUT: 16:38:35 INFO - 2015-11-20 16:38:35,425 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.00 16:38:35 INFO - 2015-11-20 16:38:35,425 DEBUG : BROWSER_OUTPUT: Values: 65.0 63.0 65.0 65.0 66.0 63.0 64.0 64.0 65.0 64.0 16:38:35 INFO - 2015-11-20 16:38:35,425 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:38:35 INFO - 2015-11-20 16:38:35,425 DEBUG : BROWSER_OUTPUT: 16:38:36 INFO - 2015-11-20 16:38:36,056 INFO : Browser exited with error code: 0 16:38:36 INFO - 2015-11-20 16:38:36,101 INFO : Completed test kraken (00:00:56) 16:38:36 INFO - 2015-11-20 16:38:36,101 INFO : Starting test v8_7 16:38:36 INFO - 2015-11-20 16:38:36,101 DEBUG : operating with platform_type : mac_ 16:38:36 INFO - 2015-11-20 16:38:36,101 INFO : Initialising browser for v8_7 test... 16:38:36 INFO - 2015-11-20 16:38:36,114 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpwsAc8x/profile http://localhost:50524/getInfo.html 16:38:38 INFO - 2015-11-20 16:38:38,326 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:38:38 INFO - 2015-11-20 16:38:38,327 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:38:38 INFO - 2015-11-20 16:38:38,327 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:38:38 INFO - 2015-11-20 16:38:38,327 DEBUG : BROWSER_OUTPUT: __metrics 16:38:38 INFO - 2015-11-20 16:38:38,343 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:38:38 INFO - 2015-11-20 16:38:38,960 INFO : Browser initialized. 16:38:38 INFO - 2015-11-20 16:38:38,960 INFO : Running cycle 1/1 for v8_7 test... 16:38:38 INFO - 2015-11-20 16:38:38,960 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpwsAc8x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:38:50 INFO - 2015-11-20 16:38:50,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 223965184 16:38:50 INFO - 2015-11-20 16:38:50,913 DEBUG : BROWSER_OUTPUT: 16:39:12 INFO - 2015-11-20 16:39:12,348 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50524/tests/v8_7/run.html (next: http://localhost:50524/tests/v8_7/run.html) 16:39:12 INFO - 2015-11-20 16:39:12,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 568168448 16:39:12 INFO - 2015-11-20 16:39:12,607 DEBUG : BROWSER_OUTPUT: 16:39:12 INFO - 2015-11-20 16:39:12,607 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:39:12 INFO - 2015-11-20 16:39:12,607 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:39:12 INFO - 2015-11-20 16:39:12,607 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:39:12 INFO - 2015-11-20 16:39:12,607 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:39:12 INFO - 2015-11-20 16:39:12,608 DEBUG : BROWSER_OUTPUT: |0;Richards;146.99397324709687 16:39:12 INFO - 2015-11-20 16:39:12,608 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;159.97440409534474 16:39:12 INFO - 2015-11-20 16:39:12,608 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.60748723766307 16:39:12 INFO - 2015-11-20 16:39:12,608 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4744.075829383886 16:39:12 INFO - 2015-11-20 16:39:12,608 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1703.5775127768313 16:39:12 INFO - 2015-11-20 16:39:12,608 DEBUG : BROWSER_OUTPUT: |5;Earley;787.4015748031496 16:39:12 INFO - 2015-11-20 16:39:12,608 DEBUG : BROWSER_OUTPUT: |6;Boyer;12500 16:39:12 INFO - 2015-11-20 16:39:12,608 DEBUG : BROWSER_OUTPUT: |7;RegExp;27189.18918918919 16:39:12 INFO - 2015-11-20 16:39:12,608 DEBUG : BROWSER_OUTPUT: |8;Splay;649.3506493506494 16:39:12 INFO - 2015-11-20 16:39:12,608 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4509.009009009009 16:39:12 INFO - 2015-11-20 16:39:12,608 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:39:12 INFO - 2015-11-20 16:39:12,608 DEBUG : BROWSER_OUTPUT: __startTimestamp1448066352600__endTimestamp 16:39:12 INFO - 2015-11-20 16:39:12,608 DEBUG : BROWSER_OUTPUT: 16:39:12 INFO - 2015-11-20 16:39:12,608 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:39:12 INFO - 2015-11-20 16:39:12,609 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:39:12 INFO - 2015-11-20 16:39:12,609 DEBUG : BROWSER_OUTPUT: 16:39:12 INFO - 2015-11-20 16:39:12,609 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:146.99 Median:146.99 stddev:0.00 (0.0%) 16:39:12 INFO - 2015-11-20 16:39:12,609 DEBUG : BROWSER_OUTPUT: Values: 147.0 16:39:12 INFO - 2015-11-20 16:39:12,609 DEBUG : BROWSER_OUTPUT: 16:39:12 INFO - 2015-11-20 16:39:12,609 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:159.97 Median:159.97 stddev:0.00 (0.0%) 16:39:12 INFO - 2015-11-20 16:39:12,609 DEBUG : BROWSER_OUTPUT: Values: 160.0 16:39:12 INFO - 2015-11-20 16:39:12,609 DEBUG : BROWSER_OUTPUT: 16:39:12 INFO - 2015-11-20 16:39:12,609 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.61 Median:283.61 stddev:0.00 (0.0%) 16:39:12 INFO - 2015-11-20 16:39:12,609 DEBUG : BROWSER_OUTPUT: Values: 283.6 16:39:12 INFO - 2015-11-20 16:39:12,609 DEBUG : BROWSER_OUTPUT: 16:39:12 INFO - 2015-11-20 16:39:12,609 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4744.08 Median:4744.08 stddev:0.00 (0.0%) 16:39:12 INFO - 2015-11-20 16:39:12,609 DEBUG : BROWSER_OUTPUT: Values: 4744.1 16:39:12 INFO - 2015-11-20 16:39:12,609 DEBUG : BROWSER_OUTPUT: 16:39:12 INFO - 2015-11-20 16:39:12,610 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1703.58 Median:1703.58 stddev:0.00 (0.0%) 16:39:12 INFO - 2015-11-20 16:39:12,610 DEBUG : BROWSER_OUTPUT: Values: 1703.6 16:39:12 INFO - 2015-11-20 16:39:12,610 DEBUG : BROWSER_OUTPUT: 16:39:12 INFO - 2015-11-20 16:39:12,610 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 16:39:12 INFO - 2015-11-20 16:39:12,610 DEBUG : BROWSER_OUTPUT: Values: 787.4 16:39:12 INFO - 2015-11-20 16:39:12,610 DEBUG : BROWSER_OUTPUT: 16:39:12 INFO - 2015-11-20 16:39:12,610 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12500.00 Median:12500.00 stddev:0.00 (0.0%) 16:39:12 INFO - 2015-11-20 16:39:12,610 DEBUG : BROWSER_OUTPUT: Values: 12500.0 16:39:12 INFO - 2015-11-20 16:39:12,610 DEBUG : BROWSER_OUTPUT: 16:39:12 INFO - 2015-11-20 16:39:12,610 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27189.19 Median:27189.19 stddev:0.00 (0.0%) 16:39:12 INFO - 2015-11-20 16:39:12,610 DEBUG : BROWSER_OUTPUT: Values: 27189.2 16:39:12 INFO - 2015-11-20 16:39:12,610 DEBUG : BROWSER_OUTPUT: 16:39:12 INFO - 2015-11-20 16:39:12,610 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:649.35 Median:649.35 stddev:0.00 (0.0%) 16:39:12 INFO - 2015-11-20 16:39:12,610 DEBUG : BROWSER_OUTPUT: Values: 649.4 16:39:12 INFO - 2015-11-20 16:39:12,610 DEBUG : BROWSER_OUTPUT: 16:39:12 INFO - 2015-11-20 16:39:12,611 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4509.01 Median:4509.01 stddev:0.00 (0.0%) 16:39:12 INFO - 2015-11-20 16:39:12,611 DEBUG : BROWSER_OUTPUT: Values: 4509.0 16:39:12 INFO - 2015-11-20 16:39:12,611 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:39:12 INFO - 2015-11-20 16:39:12,611 DEBUG : BROWSER_OUTPUT: 16:39:13 INFO - 2015-11-20 16:39:13,288 INFO : Browser exited with error code: 0 16:39:13 INFO - 2015-11-20 16:39:13,305 INFO : Completed test v8_7 (00:00:37) 16:39:13 INFO - 2015-11-20 16:39:13,662 INFO : Completed test suite (00:20:07) 16:39:13 INFO - 2015-11-20 16:39:13,662 DEBUG : Working with test: dromaeo_css 16:39:13 INFO - 2015-11-20 16:39:13,662 DEBUG : Generating results file: dromaeo_css 16:39:13 INFO - 2015-11-20 16:39:13,663 DEBUG : Working with test: kraken 16:39:13 INFO - 2015-11-20 16:39:13,663 DEBUG : Generating results file: kraken 16:39:13 INFO - 2015-11-20 16:39:13,664 INFO : javascript benchmark 16:39:13 INFO - 2015-11-20 16:39:13,664 DEBUG : Working with test: v8_7 16:39:13 INFO - 2015-11-20 16:39:13,664 DEBUG : Generating results file: v8_7 16:39:13 INFO - 2015-11-20 16:39:13,664 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:39:14 INFO - 2015-11-20 16:39:14,159 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 16:39:14 INFO - 2015-11-20 16:39:14,159 DEBUG : process_Request line: dromaeo_css 7837.66 graph.html#tests=[[72,64,59]] 16:39:14 INFO - 2015-11-20 16:39:14,159 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:39:14 INFO - 2015-11-20 16:39:14,186 DEBUG : process_Request line: kraken 1414.60 graph.html#tests=[[232,64,59]] 16:39:14 INFO - 2015-11-20 16:39:14,186 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:39:14 INFO - 2015-11-20 16:39:14,210 DEBUG : process_Request line: v8_7 20743.80 graph.html#tests=[[230,64,59]] 16:39:14 INFO - 2015-11-20 16:39:14,211 INFO : javascript benchmark 16:39:14 INFO - 2015-11-20 16:39:14,215 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2728.372474330904, 3472.218750781073, 3473.6700013498707, 3511.7015053720434, 3547.0245682437344, 5640.661560306385, 5817.825465236049, 5910.290765108188, 5914.467697907187, 5930.436608522195, 5841.0362290222065, 5858.1505681676135, 5906.05503119501, 6054.909176362358, 6085.269767627879, 5263.947360526384, 5302.893942121155, 5332.653377530468, 5362.195670649395, 5428.4842939920645, 5395.271638328814, 5420.322459692538, 5422.403535611099, 5431.21247419124, 5469.535089517376, 5159.432462429129, 5265.76304066318, 5291.656042357273, 5377.139657654776, 5395.81114660987, 5195.402528709209, 5272.998130355259, 5290.444503327134, 5296.496832800878, 5303.363596368422, 5242.711650859202, 5267.9736601316745, 5272.6836389816735, 5298.655587386807, 5318.574514038906, 5750.6262092963825, 5762.97118514409, 5766.596338256324, 5772.989726797794, 5852.56105792063, 6146.877062458726, 6181.9690901545655, 6277.87444251117, 6311.147995020659, 6343.080253363237, 6328.841778955517, 6339.429451349401, 6360.0459931010255, 6368.044793280998, 6368.172137622126, 5904.380040095728, 6010.008348622472, 6028.57799953999, 6037.607555508834, 6040.939590604082, 6127.494965205055, 6305.148804911279, 6319.210098737658, 6350.745970161234, 6499.512536559777, 6274.372562743781, 6340.4927605792345, 6349.0, 6370.394812492806, 6372.107904893319, 6330.620162790247, 6339.175907132136, 6350.047492876106, 6354.364563543609, 6361.268454127835, 6131.499004853489, 6180.412860778219, 6192.885280649526, 6278.152449419361, 6324.177856878577, 6300.338464461165, 6301.4328710416285, 6307.463865571478, 6309.589876658002, 6317.399847014526, 5077.669951453144, 5088.872778180501, 5091.981603679279, 5093.541581257705, 5100.897982040338, 4400.669949753781, 4420.823167073346, 4487.6185524230805, 4531.365608814768, 4552.499225085238, 6036.698165091816, 6050.909236361458, 6069.908951365733, 6071.483923866433, 6079.240094988127, 6348.587341822767, 6354.3010268870385, 6356.555041147168, 6358.141650877073, 6360.395762402564, 5755.9424405756245, 5840.737166827503, 5869.148973398833, 5898.2332296802, 5900.734466948998, 4666.906661866744, 5551.833444996657, 5552.91670624941, 5554.250176226238, 5556.666600003932, 6330.620162790247, 6354.586951848115, 6454.644994525346, 6469.029645553204, 6475.773347932894, 6328.810135695937, 6330.272018717907, 6353.650549219838, 6357.0, 6372.36276372359, 6244.188255526752, 6538.313477085027, 6547.9672601636685, 6565.507586931095, 6566.474682025522, 6170.845728856635, 6245.219347581552, 6278.654673992792, 6306.621602703853, 6328.272248691459, 6334.208223972004, 6334.873302534015, 6335.841603959938, 6341.0, 6341.968290158519, 6323.272823625342, 6338.461230795434, 6343.55595108338, 6348.968255158695, 6357.046443033397, 6058.394160583906, 6137.836677219377, 6139.171211886338, 6153.84615384619, 6315.5894866833505, 5434.510894019557, 6140.692965351625, 6145.84635384119, 6159.72281247336, 6160.322364539987, 6254.437100660963, 6288.24541055058, 6293.087502312231, 6293.244810622755, 6341.841453963688, 5928.67392293428, 6067.0, 6072.271327440735, 6093.634381937098, 6163.568550201443], "unit": "ms", "name": "dojo.html", "value": 5823.2120927524575}, {"lowerIsBetter": false, "replicates": [551.0032417514908, 554.8058179637128, 564.3622706341833, 634.4290138875012, 637.7385272038463, 32185.51721724173, 32676.346473070553, 34179.487307690404, 41244.96887577812, 41325.7602271932, 44491.88770280745, 44882.551174488246, 44908.1018379633, 45101.7744911275, 45135.0, 8962.86555701665, 9840.311178217546, 10006.449645269508, 10027.799444011116, 10035.448050357227, 8927.732168034969, 9034.593443295067, 11972.341521216329, 12101.334426606532, 12125.696857578543, 11919.165658403916, 12013.879861201407, 12024.278543287386, 12032.0, 12035.037197024218, 8915.68795092175, 11931.0, 11990.0, 11999.820002699966, 12005.219660722025, 8890.06654301302, 11699.0, 11910.166288359731, 11918.582849600309, 11964.581239656658, 41253.0, 41883.581164188276, 41887.0, 41907.161856763, 41947.37078943818, 3213.935721285561, 3272.2473831018997, 3309.2223327518013, 3325.783824051453, 3595.1731101846462, 29912.0, 30154.94457693992, 30645.0, 30867.845660771553, 30953.690463095307, 2231.6094683430497, 2822.969616090133, 2848.957265641017, 2869.110575721533, 2893.8697758600915, 423424.0, 498886.0, 499549.0, 500642.4967875174, 605985.0, 51379.743101285, 57192.428075719545, 70251.29748702448, 70668.64665676639, 71057.2894271061, 69423.0, 70146.0, 70337.64831175811, 70401.64799176074, 70442.64778676073, 14044.438222471192, 16687.082210478296, 16904.91547542279, 16930.238139283763, 16943.491695249162, 12830.230186188859, 13023.218606883618, 13030.609081727564, 13057.608271751862, 13062.020348473903, 20313.390598282076, 20488.69266960997, 20505.692414613794, 20509.692354614694, 20529.79470205309, 7754.92245077542, 7948.322004359426, 8701.390902636882, 9134.177923986874, 9366.157045865768, 948.374073111743, 1004.7287232447198, 1009.1220638044948, 1026.225199974015, 1089.2538611051455, 29662.851685741432, 29750.0, 30168.24579385533, 30519.69480305213, 30558.388832223674, 1059.9894001060045, 1105.5301496863801, 1116.6705821782593, 1193.8746431624554, 1272.0459655258555, 15402.152881591395, 15402.537923862077, 15704.685906281811, 15728.781139011631, 15910.44313449047, 547357.0, 551016.0, 552539.0, 552792.0, 553166.0, 60526.39473605296, 60904.39095608987, 60974.695126524086, 60990.08514872281, 61264.69367653133, 1361.8297712785902, 1381.1851007905384, 1389.3817251323064, 1477.5050358130147, 1631.959201019984, 28471.715282847734, 29505.704942950295, 29659.555106673848, 30138.54792178075, 30223.9421620251, 41227.58772412237, 49953.75023124861, 50333.74833125957, 50454.2431863515, 50456.74771626118, 424282.0, 514430.0, 610658.0, 613496.0, 615129.0, 30281.394372112874, 30461.847690761406, 30549.23626909345, 30574.388512230074, 30577.0, 42909.57090429056, 43229.351559726, 43274.567254328314, 43964.560354396046, 44360.33459498046, 32037.519437208928, 36257.456138157424, 36300.63699362973, 36382.0, 37345.813270933475, 36049.459258110626, 37411.99900423201, 37456.063598410256, 37852.621473786014, 38257.4261386085, 36621.0, 37144.81427592953, 37548.812255939636, 37595.2480950374, 37646.2470750578, 31737.36525269528, 33657.25836639984, 34024.0, 34160.31679366349, 34603.13492162716, 25051.373715656526, 25159.622605661294, 25384.492310153324, 25448.618270726325, 25683.0], "unit": "ms", "name": "ext.html", "value": 20561.43035625172}, {"lowerIsBetter": false, "replicates": [311.5466995521516, 365.7165696585148, 365.72387847175395, 366.23639711202145, 366.6718287133015, 16338.918305408457, 16962.83037169628, 20201.797982020176, 21382.25162119326, 22481.437964050907, 22034.0, 22085.668714969248, 22462.55074898501, 22469.887650561766, 22479.438014049658, 5521.972390138044, 5642.661440313574, 6416.647084410356, 6594.934050659504, 6614.305497922721, 4560.749158796265, 6522.152120224364, 6951.409130223937, 7346.118465784113, 7351.595662238575, 7241.782746517613, 7252.7461538846155, 7315.890261646079, 7334.853302933938, 7656.042994625672, 7562.432817538679, 7565.735199268, 7577.507462014952, 7581.999999999973, 7597.354224890891, 6908.447324214051, 6981.82545436363, 6988.266232045613, 6991.021257024021, 6991.860162796766, 26710.732892671018, 26805.0, 27294.454110917868, 27646.032388866493, 28409.715902840915, 2177.8475506714535, 2306.9964565414098, 2307.2501437033034, 2418.7460316666848, 2578.987105064463, 12725.936370318183, 15721.842781572152, 15829.68340633181, 15839.762403563956, 15907.12510811905, 1557.6417423992546, 1807.972880406795, 1827.0590645817415, 1848.408509277032, 1883.5573640194543, 116609.0, 119665.40167299195, 121044.18433723412, 121221.10728371078, 121305.0, 18444.538886527676, 18912.52718682044, 18918.90540547316, 18975.33586324472, 19016.334428294944, 28060.43879122447, 28062.0, 28122.71877281242, 28152.155435336565, 28235.294117646812, 10544.420056896945, 10650.680479585624, 10676.359418434919, 10708.946455267675, 10793.730156746144, 9099.454032758056, 9105.908940910638, 9109.498977556166, 9203.40177888435, 9225.0, 7191.6552152459735, 8669.21977022071, 8693.608787604573, 8703.129687031245, 8754.69358572447, 3311.586051743532, 3441.1397150712323, 3446.483027545838, 3468.9653103469145, 3478.913027174341, 731.6561216228364, 892.5001998880648, 946.1910066892846, 1000.559753708366, 1000.5697550053401, 16559.17204139788, 16686.666266674598, 19734.0, 20673.586528269352, 21277.78722212758, 869.4044579463088, 917.857732051533, 921.7188757428914, 974.3812678948918, 1033.6227277043824, 9821.901780982098, 10626.937306269312, 11074.280171788809, 11170.944145279222, 11207.495662695199, 776208.0, 779465.0, 780543.0972845213, 802339.0, 803015.0, 60045.39954600485, 88184.0, 113619.31903404796, 114735.85264147418, 126448.0, 958.9952050239843, 1178.505027888289, 1183.8875306845837, 1184.242085065576, 1199.3463562358536, 18331.35840245585, 18442.538936526693, 18547.629047419246, 18566.535836604195, 18578.071096445394, 39286.80356598199, 50993.23510147425, 52107.478925210264, 52146.739266303426, 52294.0, 71895.0, 72003.63998179976, 72194.63902680454, 73204.26795732188, 74204.62897685477, 9598.280128990493, 9624.711258662252, 9877.308588398742, 9986.950065249628, 9996.550155242887, 18269.54326141857, 18610.534736631693, 18717.344892928682, 19027.143778530277, 19685.0, 15347.386104556139, 15657.843421565638, 15684.607884802972, 15980.280887359864, 16100.275487602852, 9521.2859035574, 11480.827787583026, 14774.18741969202, 15342.849286303795, 15635.140067296408, 16138.19309034567, 16723.665526689154, 16768.916155419145, 16842.66314673675, 17084.572885677957, 9728.708138755848, 9864.161546268648, 9976.900230997597, 10116.1401280889, 10173.542190601293, 10235.897641023494, 10365.481725913523, 12555.560555380518, 15798.447054353042, 16337.591560210614], "unit": "ms", "name": "jquery.html", "value": 11246.140304587983}, {"lowerIsBetter": false, "replicates": [1551.6586351002782, 1555.6655319106396, 1701.3704929176206, 1821.4353550399378, 1853.9617814024143, 7291.5260508067, 7453.66458509367, 8161.8775718364195, 8282.792930176733, 8309.376796740238, 7978.840423191533, 8137.552434616094, 8154.673813047486, 8180.795480113, 8192.713255036075, 2033.9288124915631, 2129.031290762707, 2346.495503466754, 2376.702912135983, 2378.048780487801, 2033.5831154613343, 2355.5995480768224, 2378.500514891875, 2385.6540801583847, 2388.199953015733, 2312.710911136108, 2334.8949297281665, 2339.543788961153, 2359.4691194481275, 2370.668106465096, 1869.4391682495198, 2151.419116838445, 2155.6874253233195, 2321.804270800539, 2344.765523447659, 2350.823688223373, 2384.4396566806786, 2384.7376788553247, 2386.8567885926727, 2390.8206884483734, 8048.195180481964, 8192.54940978246, 8228.21831925966, 8254.009518857716, 8256.339492840558, 5089.185730283174, 5199.6360254782185, 5210.791568337262, 5218.634695571312, 5219.191025391033, 2867.6845546989816, 3463.290025544757, 3536.0806190390426, 3537.0980399998093, 3552.289542091592, 1003.4079892863173, 1006.4011912911806, 1007.5919252702668, 1041.0162396535202, 1047.4553232319226, 10723.35659860403, 10738.261743255498, 10739.62411315608, 10762.569497220102, 10770.29993050457, 3812.8474861005247, 4530.252508336088, 4621.930671039937, 4659.743714095757, 4696.483386827446, 9486.620535178516, 9506.00186980371, 9507.0, 9528.714138575715, 9547.856782148274, 5206.245094461282, 5220.903610241816, 5221.295125158131, 5240.135377662719, 5256.106461901486, 4779.569838714532, 4788.329633851264, 4800.73595952226, 4805.783739731721, 4809.831655892027, 3201.855916483764, 3738.887833365003, 3865.7100717446306, 3868.6905047596124, 3875.302445559826, 1079.881213066562, 1253.718232816284, 1255.1026016398318, 1258.8552316483722, 1272.1730874931368, 1294.4239813283186, 1299.6296055624102, 1309.4173092973535, 1330.221820235154, 1333.919964802115, 7658.961705191438, 7682.769516914502, 7742.6902923883545, 7754.224577542313, 7783.338416234684, 496.83852747857094, 505.9544640982329, 509.69163655988336, 511.8925025744561, 512.0475914798471, 5699.0, 5780.971095144498, 5799.101139323411, 6099.939000610026, 6260.311365749764, 8255.834883302301, 9654.372465789702, 9800.0, 9823.75440613976, 9951.402915825074, 9588.66439674608, 9646.372985755903, 9649.710508684751, 9729.221662267002, 9736.83158021042, 7575.962120189474, 7613.9238607614325, 7723.53658780475, 7762.379009679212, 7771.106322772954, 7729.768106956801, 7763.2236776321915, 7783.92216077832, 7785.571793551409, 7799.883001754864, 8809.0, 8822.735317940473, 8855.645774168961, 8972.28221742272, 9006.144416280444, 8974.326925480484, 9165.587548560465, 9230.169284764403, 9252.074792520694, 9330.393524420891, 6825.35159159879, 7248.60132692707, 7253.274672532704, 7254.419646428168, 7255.383292420203, 6669.166354205724, 7746.535207887545, 7794.571298578406, 7818.257265559762, 7837.49056311338, 7075.858482830212, 7135.393491553276, 7308.415326773952, 7394.55632662042, 7427.517211381243, 7144.3570078693165, 7203.783886483414, 7258.818529536804, 7366.373858222111, 7373.410127189919, 7309.4152467803515, 7340.632968351454, 7372.815679608053, 7372.852542949004, 7392.778216653509, 5661.348944871393, 6688.866222675617, 6714.3957043866285, 6776.712424639303, 6808.080909077211, 6829.248782634006, 6840.555363901331, 6880.58716477013, 6891.0, 6893.138357705287], "unit": "ms", "name": "mootools.html", "value": 4592.449185059963}, {"lowerIsBetter": false, "replicates": [273.47083393633307, 319.15583282218535, 326.3179953896356, 330.09060039590923, 335.3778740436489, 6776.457883369331, 6844.212915514718, 6945.444364450845, 6966.198887127982, 6970.721171153161, 6587.176602924635, 6697.765578204764, 6730.96634516828, 6754.290799466046, 6857.588544687323, 3756.943645845301, 4944.1594928862, 5018.2723505091835, 5023.422306434752, 5054.090263752523, 5005.949940500603, 5016.072026675077, 5022.04581129586, 5023.095842748304, 5029.899402011957, 4683.133620280242, 4758.428988521382, 4868.294097355882, 4872.707637541741, 4892.951070489303, 4676.205045142334, 4841.419029716457, 4850.757462126897, 4868.902621947576, 4870.878228044292, 4137.482814648169, 4165.187788381267, 4237.046664500463, 4263.445752052245, 4270.231358355495, 6555.04951781989, 6576.539642225046, 6589.670516474157, 6591.868162636768, 6598.076269322299, 5837.328707198684, 5967.313758917737, 6000.36996115406, 6001.4298641628975, 6037.396260373971, 7371.557706537625, 7374.815629609303, 7376.852462950765, 7384.113906331221, 7385.372243359321, 4824.469308376111, 4835.5889749371345, 4839.0, 4841.2496063110275, 4842.588379987706, 7595.924040759633, 7831.882521762178, 7858.882116768253, 7861.056673199196, 7870.094939081964, 4740.170470167707, 4771.1888978872985, 4779.474257831635, 4779.808807647655, 4786.210275304536, 4855.95144048555, 4864.416270047617, 4869.63477739171, 4873.634477414208, 4873.853784386474, 5057.494250574913, 5612.989661860905, 5877.706114694333, 5877.941220587825, 5889.234399528034, 7217.025701530226, 7350.375218106414, 7394.5193562419345, 7412.51818631798, 7418.777436676908, 1664.983350166507, 1684.082175214511, 1690.5013021158788, 1694.212191331037, 1696.847283744469, 1052.3843551522293, 1065.9946700266605, 1066.7706443114769, 1070.464767616192, 1080.103514083309, 6508.284088750233, 6659.234188068337, 6782.1861376635115, 6891.965540172267, 6899.724011039502, 6615.834604134935, 7773.222677732181, 7774.028246469192, 7788.649510772028, 7809.921900781033, 6019.5853974316, 6855.417289530346, 6954.374106330454, 6997.0, 7002.614856182959, 3907.5506316773367, 3977.065389633434, 4088.7751173685733, 4091.0, 4107.322291821875, 6868.965655171792, 7982.600869956479, 8107.878381824277, 8113.066997295268, 8118.75643730689, 5454.754536045887, 8011.599420029092, 8023.398245131639, 8029.59852007409, 8039.7990050248045, 8116.147804480563, 8128.796780080427, 8132.634031468599, 8133.186681331819, 8138.755837324889, 7820.061592608923, 7827.139014708491, 7833.49082309648, 7834.334081603128, 7848.058233012075, 7433.8141546461775, 7638.388928885787, 7646.120696120018, 7683.154852966058, 7685.346745526469, 8075.5558444286125, 8093.473924194908, 8098.5545794981845, 8101.149379315087, 8102.7569172924905, 4945.431275403231, 5000.749962501933, 5007.649464537448, 5009.974950125226, 5026.974865125651, 7346.485745997943, 7619.238076192337, 7631.0, 7638.0, 7661.310482056641, 6525.412712855866, 6795.7961261162245, 7357.889631655637, 7361.30067643573, 7387.261273872569, 7117.1459424869345, 7325.597092159983, 7333.816654583678, 7334.523255988343, 7338.266173382833, 7132.8930066048015, 7133.82165445868, 7141.785746427616, 7165.534240274365, 7169.892451613126, 7097.858042839218, 7217.0, 7299.8540029200185, 7319.890201646873, 7333.1200255969625, 7172.390346820579, 7189.2810718927685, 7258.891116633149, 7270.927290727025, 7280.745173918887], "unit": "ms", "name": "prototype.html", "value": 5339.731389362177}, {"lowerIsBetter": false, "replicates": [747.8093086263004, 802.113664400837, 803.2008151888872, 807.3783186946051, 814.2712272516095, 15119.092854428729, 15497.38010479581, 15497.767533487007, 15504.767428488582, 15508.0, 14275.785863212033, 14421.0, 14422.0, 14437.0, 14452.0, 743.1602289412956, 749.449154871172, 752.4093586534572, 753.7927070055752, 911.3301723233418, 738.4350971506801, 751.6805357722945, 918.4672889723978, 931.4644079654192, 939.1266122506066, 971.9854202186973, 972.9854052189223, 983.965561205358, 987.3434166279416, 988.293370240278, 976.9985764591315, 982.2633025231077, 982.6020461712982, 983.0415345038601, 996.4768496539302, 585.0405335250193, 588.3498733899065, 590.2385922160408, 590.8404730722681, 591.7721677154284, 12490.43793029316, 15124.243787810676, 15358.846411535853, 15380.92309538445, 15385.307661155275, 12607.873921260854, 12663.430145643377, 12940.417681204368, 12956.870431295662, 13167.078304518593, 9917.553710083064, 10259.846102308471, 10290.125339346165, 10318.793624127475, 10966.451677416177, 3487.9651203487892, 3520.2959408118477, 3563.6970857477145, 3699.5930447650735, 3716.535433070866, 77396.61301693512, 78696.0, 79072.60463697702, 79091.41817163625, 79388.0, 9426.528673566294, 9427.76430589227, 9468.053194680477, 9570.47362395075, 10020.198384129251, 21314.36056918295, 21564.46088847791, 21578.028988695547, 21612.351629451143, 21633.459163521038, 7367.926320736831, 7413.258674132544, 7646.885296720554, 7683.039620047494, 7720.806979825549, 3982.2234664240195, 4072.7963601819793, 4084.857030003995, 4107.0553772631865, 4116.526599441103, 3393.8472768725464, 3441.397755392796, 3442.8794992175654, 3453.620101788801, 3453.7582369233915, 616.5437576193584, 635.0696230023038, 638.1544453599, 643.4305639508974, 646.0761111610349, 493.64950884872144, 514.8095204774257, 515.5437437867439, 523.9083160446907, 552.1469329885336, 8856.778580535409, 9304.25565954722, 9311.627534898527, 9369.531523423802, 9635.807283854423, 448.70833957926953, 584.260909948915, 589.8731772668897, 601.6432943711901, 651.5406638319973, 3843.673287770515, 3911.5110611173604, 3967.384811437267, 4166.83332666696, 4225.422144434051, 89074.55462722774, 99777.00222997823, 104497.0, 105843.4707826456, 107823.0, 68587.65706171437, 87080.0, 87932.0, 88400.5579972096, 89462.65806012785, 77813.61093194498, 79360.6031969848, 79804.0, 80029.0, 80693.19306806974, 8263.421560490948, 8294.419390642597, 8403.663853445794, 8593.870016600957, 8686.565671716515, 52925.735371322895, 53203.733981329846, 53241.4675853252, 53506.19740703815, 53625.463745362045, 76731.0, 77789.2221077782, 77820.2217977813, 78855.0, 79993.0, 11022.834657479983, 11185.993260606585, 11341.4896329667, 11414.48634811419, 11722.70693232676, 11984.700382490508, 12157.209781364536, 12162.93918530437, 12177.33024683651, 12201.877981220074, 11437.485313161094, 11580.594679186524, 11583.826242606536, 11597.362145082101, 11621.709457263636, 11467.197296189186, 11478.713032174262, 11507.884921151017, 11541.0, 11556.94221528887, 11034.337939723642, 11144.33134011962, 11153.219274650697, 11156.888431115585, 11162.386068766296, 9703.272254580794, 10187.032231937954, 10241.74395640115, 10260.486975651336, 10297.12474439681, 9829.557669904729, 10101.393916365041, 10122.59509619607, 10131.44277064739, 10153.187744980236], "unit": "ms", "name": "yui.html", "value": 7019.343801883805}], "name": "dromaeo_css", "value": 7837.662429181166}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [103.0, 108.0, 108.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 117.0], "unit": "ms", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [151.0, 119.0, 145.0, 155.0, 115.0, 143.0, 140.0, 115.0, 153.0, 118.0], "unit": "ms", "name": "audio-beat-detection", "value": 135.4}, {"lowerIsBetter": true, "replicates": [181.0, 183.0, 181.0, 180.0, 182.0, 182.0, 183.0, 184.0, 186.0, 182.0], "unit": "ms", "name": "audio-dft", "value": 182.4}, {"lowerIsBetter": true, "replicates": [61.0, 71.0, 70.0, 72.0, 55.0, 58.0, 63.0, 101.0, 100.0, 48.0], "unit": "ms", "name": "audio-fft", "value": 69.9}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 119.0, 76.0, 75.0, 74.0, 112.0, 74.0, 74.0, 114.0], "unit": "ms", "name": "audio-oscillator", "value": 88.4}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 99.0, 132.0, 121.0, 85.0, 87.0, 86.0, 84.0, 87.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 95.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 93.0, 93.0, 94.0, 97.0, 94.0, 95.0, 132.0, 93.0], "unit": "ms", "name": "imaging-darkroom", "value": 97.9}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 85.0, 85.0, 84.0, 100.0, 136.0, 120.0, 131.0, 145.0], "unit": "ms", "name": "imaging-desaturate", "value": 105.8}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 54.0, 53.0, 54.0, 55.0, 54.0, 63.0, 52.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 64.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.0}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 82.0, 81.0, 95.0, 103.0, 104.0, 104.0, 81.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 89.4}, {"lowerIsBetter": true, "replicates": [123.0, 123.0, 126.0, 126.0, 127.0, 123.0, 127.0, 118.0, 130.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [133.0, 136.0, 135.0, 134.0, 134.0, 122.0, 133.0, 135.0, 132.0, 120.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 131.4}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 65.0, 65.0, 66.0, 63.0, 64.0, 64.0, 65.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.4}], "name": "kraken", "value": 1414.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [146.99397324709687], "unit": "score", "name": "Richards", "value": 240.1595059999999}, {"lowerIsBetter": false, "replicates": [159.97440409534474], "unit": "score", "name": "DeltaBlue", "value": 413.30361800000014}, {"lowerIsBetter": false, "replicates": [283.60748723766307], "unit": "score", "name": "Encrypt", "value": 938.5542060000004}, {"lowerIsBetter": false, "replicates": [4744.075829383886], "unit": "score", "name": "Decrypt", "value": 56.10808291708288}, {"lowerIsBetter": false, "replicates": [1703.5775127768313], "unit": "score", "name": "RayTrace", "value": 434.3735429999998}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [12500.0], "unit": "score", "name": "Boyer", "value": 53.31704}, {"lowerIsBetter": false, "replicates": [27189.18918918919], "unit": "score", "name": "RegExp", "value": 33.505412524850904}, {"lowerIsBetter": false, "replicates": [649.3506493506494], "unit": "score", "name": "Splay", "value": 125.49613999999997}, {"lowerIsBetter": false, "replicates": [4509.009009009009], "unit": "score", "name": "NavierStokes", "value": 329.11888111888123}], "name": "v8_7", "value": 20743.795756268933}]} 16:39:14 INFO - RETURN: dromaeo_css: 7837.66 16:39:14 INFO - RETURN: kraken: 1414.60 16:39:14 INFO - RETURN: v8_7: 20743.80 16:39:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20743.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1414.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7837.66"}}} 16:39:14 INFO - Return code: 0 16:39:14 INFO - # TBPL SUCCESS # 16:39:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:39:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:39:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:39:14 INFO - 2015-11-20 16:39:14.323 screenresolution[2046:17678] starting screenresolution argv=screenresolution get 16:39:14 INFO - 2015-11-20 16:39:14.325 screenresolution[2046:17678] Display 0: 1600x1200x32@60 16:39:14 INFO - 2015-11-20 16:39:14.332 screenresolution[2047:17681] starting screenresolution argv=screenresolution list 16:39:14 INFO - Available Modes on Display 0 16:39:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:39:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:39:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:39:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:39:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:39:14 INFO - Intel Iris: 16:39:14 INFO - Chipset Model: Intel Iris 16:39:14 INFO - Type: GPU 16:39:14 INFO - Bus: Built-In 16:39:14 INFO - VRAM (Dynamic, Max): 1536 MB 16:39:14 INFO - Vendor: Intel (0x8086) 16:39:14 INFO - Device ID: 0x0a2e 16:39:14 INFO - Revision ID: 0x0009 16:39:14 INFO - Displays: 16:39:14 INFO - Display: 16:39:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:39:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:39:14 INFO - Display Serial Number: 1600x1200 60 16:39:14 INFO - Main Display: Yes 16:39:14 INFO - Mirror: Off 16:39:14 INFO - Online: Yes 16:39:14 INFO - Rotation: Supported 16:39:14 INFO - Return code: 0 16:39:14 INFO - Running post-action listener: _resource_record_post_action 16:39:14 INFO - Running post-run listener: _resource_record_post_run 16:39:15 INFO - Total resource usage - Wall time: 1240s; CPU: 52.0%; Read bytes: 942592; Write bytes: 686224384; Read time: 14; Write time: 2217 16:39:15 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 336316928; Write bytes: 335476736; Read time: 26094; Write time: 669 16:39:15 INFO - run-tests - Wall time: 1210s; CPU: 52.0%; Read bytes: 942592; Write bytes: 340380672; Read time: 14; Write time: 1514 16:39:15 INFO - Running post-run listener: _upload_blobber_files 16:39:15 INFO - Blob upload gear active. 16:39:15 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:39:15 INFO - Copying logs to upload dir... 16:39:15 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.878208 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-20 16:39:15.682725) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:39:15.686300) ========= 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.BOIinPyOh9/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.H3myhZDpad/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009591 build_url: 'https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:39:15.709971) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:39:15.710380) ========= 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.BOIinPyOh9/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.H3myhZDpad/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005403 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:39:15.759736) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 16:39:15.760081) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 16:39:15.760463) ========= ========= Total master_lag: 0.21 =========