builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0039 starttime: 1448394569.51 results: success (0) buildid: 20151124104631 builduid: 3454463e66bc4ce2872c9f273ce66ddd revision: 433f2e9c7239d2b706bf169f78e9921c38fc75c6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:29.509126) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:29.509572) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:29.509900) ========= 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.eMqNJrQ3Xu/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.Ujd85nbAUR/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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.005556 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:29.529920) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:29.533298) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:29.547661) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:29.547974) ========= 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.eMqNJrQ3Xu/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.Ujd85nbAUR/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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.005144 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:29.597177) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:29.597525) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:29.597903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:29.601260) ========= 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.eMqNJrQ3Xu/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.Ujd85nbAUR/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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-24 11:49:29-- 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% 8.67M=0.001s 2015-11-24 11:49:29 (8.67 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176412 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:29.794292) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:29.794647) ========= 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.eMqNJrQ3Xu/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.Ujd85nbAUR/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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.019381 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:29.845933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 11:49:29.846779) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 433f2e9c7239d2b706bf169f78e9921c38fc75c6 --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 433f2e9c7239d2b706bf169f78e9921c38fc75c6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eMqNJrQ3Xu/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.Ujd85nbAUR/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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-24 11:49:29,919 truncating revision to first 12 chars 2015-11-24 11:49:29,919 Setting DEBUG logging. 2015-11-24 11:49:29,919 attempt 1/10 2015-11-24 11:49:29,919 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/433f2e9c7239?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 11:49:30,739 unpacking tar archive at: fx-team-433f2e9c7239/testing/mozharness/ program finished with exit code 0 elapsedTime=1.065270 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 11:49:30.926809) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:30.927276) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:30.938921) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:30.939339) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 11:49:30.939824) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-11-24 11:49:30.940160) ========= /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.eMqNJrQ3Xu/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.Ujd85nbAUR/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 11:49:31 INFO - MultiFileLogger online at 20151124 11:49:31 in /builds/slave/test 11:49:31 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 11:49:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:49:31 INFO - {'append_to_log': False, 11:49:31 INFO - 'base_work_dir': '/builds/slave/test', 11:49:31 INFO - 'blob_upload_branch': 'Fx-Team', 11:49:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:49:31 INFO - 'branch': 'Fx-Team', 11:49:31 INFO - 'buildbot_json_path': 'buildprops.json', 11:49:31 INFO - 'config_files': ('talos/mac_config.py',), 11:49:31 INFO - 'default_actions': ('clobber', 11:49:31 INFO - 'read-buildbot-config', 11:49:31 INFO - 'download-and-extract', 11:49:31 INFO - 'populate-webroot', 11:49:31 INFO - 'create-virtualenv', 11:49:31 INFO - 'install', 11:49:31 INFO - 'run-tests'), 11:49:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:49:31 INFO - 'download_minidump_stackwalk': True, 11:49:31 INFO - 'download_symbols': 'ondemand', 11:49:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:49:31 INFO - 'tooltool.py': '/tools/tooltool.py', 11:49:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:49:31 INFO - '/tools/misc-python/virtualenv.py')}, 11:49:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:49:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:49:31 INFO - 'installer_path': 'installer.exe', 11:49:31 INFO - 'log_level': 'info', 11:49:31 INFO - 'log_name': 'talos', 11:49:31 INFO - 'log_to_console': True, 11:49:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:49:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:49:31 INFO - 'opt_config_files': (), 11:49:31 INFO - 'pip_index': False, 11:49:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:49:31 INFO - 'cmd': ('bash', 11:49:31 INFO - '-c', 11:49:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:49:31 INFO - 'enabled': True, 11:49:31 INFO - 'halt_on_failure': False, 11:49:31 INFO - 'name': 'check_screen_resolution'},), 11:49:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:49:31 INFO - 'cmd': ('bash', 11:49:31 INFO - '-c', 11:49:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:49:31 INFO - 'enabled': True, 11:49:31 INFO - 'halt_on_failure': False, 11:49:31 INFO - 'name': 'check_screen_resolution'},), 11:49:31 INFO - 'run_cmd_checks_enabled': True, 11:49:31 INFO - 'sps_profile': False, 11:49:31 INFO - 'sps_profile_interval': 0, 11:49:31 INFO - 'suite': 'dromaeojs', 11:49:31 INFO - 'system_bits': '64', 11:49:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:49:31 INFO - 'title': 't-yosemite-r7-0039', 11:49:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:49:31 INFO - 'use_talos_json': True, 11:49:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:49:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:49:31 INFO - 'work_dir': 'build'} 11:49:31 INFO - ##### 11:49:31 INFO - ##### Running clobber step. 11:49:31 INFO - ##### 11:49:31 INFO - Running pre-action listener: _resource_record_pre_action 11:49:31 INFO - Running main action method: clobber 11:49:31 INFO - rmtree: /builds/slave/test/build 11:49:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:49:32 INFO - Running post-action listener: _resource_record_post_action 11:49:32 INFO - ##### 11:49:32 INFO - ##### Running read-buildbot-config step. 11:49:32 INFO - ##### 11:49:32 INFO - Running pre-action listener: _resource_record_pre_action 11:49:32 INFO - Running main action method: read_buildbot_config 11:49:32 INFO - Using buildbot properties: 11:49:32 INFO - { 11:49:32 INFO - "properties": { 11:49:32 INFO - "buildnumber": 25, 11:49:32 INFO - "product": "firefox", 11:49:32 INFO - "script_repo_revision": "production", 11:49:32 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:49:32 INFO - "repository": "", 11:49:32 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:49:32 INFO - "buildid": "20151124104631", 11:49:32 INFO - "slavename": "t-yosemite-r7-0039", 11:49:32 INFO - "pgo_build": "False", 11:49:32 INFO - "basedir": "/builds/slave/test", 11:49:32 INFO - "project": "", 11:49:32 INFO - "platform": "yosemite_r7", 11:49:32 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:49:32 INFO - "slavebuilddir": "test", 11:49:32 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:49:32 INFO - "branch": "fx-team", 11:49:32 INFO - "repo_path": "integration/fx-team", 11:49:32 INFO - "stage_platform": "macosx64", 11:49:32 INFO - "builduid": "3454463e66bc4ce2872c9f273ce66ddd", 11:49:32 INFO - "revision": "433f2e9c7239d2b706bf169f78e9921c38fc75c6" 11:49:32 INFO - }, 11:49:32 INFO - "sourcestamp": { 11:49:32 INFO - "repository": "", 11:49:32 INFO - "hasPatch": false, 11:49:32 INFO - "project": "", 11:49:32 INFO - "branch": "fx-team-macosx64-talos", 11:49:32 INFO - "changes": [ 11:49:32 INFO - { 11:49:32 INFO - "category": null, 11:49:32 INFO - "files": [ 11:49:32 INFO - { 11:49:32 INFO - "url": null, 11:49:32 INFO - "name": "https://queue.taskcluster.net/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 11:49:32 INFO - } 11:49:32 INFO - ], 11:49:32 INFO - "repository": "", 11:49:32 INFO - "rev": "433f2e9c7239d2b706bf169f78e9921c38fc75c6", 11:49:32 INFO - "who": "mbanner@mozilla.com", 11:49:32 INFO - "when": 1448393567, 11:49:32 INFO - "number": 6701499, 11:49:32 INFO - "comments": "Bug 1225189 - Disable Hello for e10s windows. r=mikedeboer", 11:49:32 INFO - "project": "", 11:49:32 INFO - "at": "Tue 24 Nov 2015 11:32:47", 11:49:32 INFO - "branch": "fx-team-macosx64-talos", 11:49:32 INFO - "revlink": "", 11:49:32 INFO - "properties": [ 11:49:32 INFO - [ 11:49:32 INFO - "buildid", 11:49:32 INFO - "20151124104631", 11:49:32 INFO - "Change" 11:49:32 INFO - ], 11:49:32 INFO - [ 11:49:32 INFO - "builduid", 11:49:32 INFO - "3454463e66bc4ce2872c9f273ce66ddd", 11:49:32 INFO - "Change" 11:49:32 INFO - ], 11:49:32 INFO - [ 11:49:32 INFO - "pgo_build", 11:49:32 INFO - "False", 11:49:32 INFO - "Change" 11:49:32 INFO - ] 11:49:32 INFO - ], 11:49:32 INFO - "revision": "433f2e9c7239d2b706bf169f78e9921c38fc75c6" 11:49:32 INFO - } 11:49:32 INFO - ], 11:49:32 INFO - "revision": "433f2e9c7239d2b706bf169f78e9921c38fc75c6" 11:49:32 INFO - } 11:49:32 INFO - } 11:49:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 11:49:32 INFO - Running post-action listener: _resource_record_post_action 11:49:32 INFO - ##### 11:49:32 INFO - ##### Running download-and-extract step. 11:49:32 INFO - ##### 11:49:32 INFO - Running pre-action listener: _resource_record_pre_action 11:49:32 INFO - Running main action method: download_and_extract 11:49:32 INFO - mkdir: /builds/slave/test/build/tests 11:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:32 INFO - https://queue.taskcluster.net/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:49:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/test_packages.json 11:49:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/test_packages.json 11:49:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:49:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:49:33 INFO - Downloaded 1149 bytes. 11:49:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:49:33 INFO - Using the following test package requirements: 11:49:33 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:49:33 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:49:33 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 11:49:33 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:49:33 INFO - u'jsshell-mac.zip'], 11:49:33 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:49:33 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 11:49:33 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:49:33 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:49:33 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 11:49:33 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:49:33 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 11:49:33 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:49:33 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 11:49:33 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:49:33 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:49:33 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 11:49:33 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:49: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')]} 11:49:33 INFO - https://queue.taskcluster.net/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:49:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:49:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:49:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/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 11:49:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/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 11:49:34 INFO - Downloaded 17527653 bytes. 11:49:34 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 11:49:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:49:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:49:37 INFO - Return code: 0 11:49:37 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 11:49:37 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')]} 11:49:37 INFO - https://queue.taskcluster.net/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:49:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:49:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:49:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/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 11:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/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 11:49:38 INFO - Downloaded 17527653 bytes. 11:49:38 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 11:49:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:49:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:49:42 INFO - Return code: 0 11:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:42 INFO - https://queue.taskcluster.net/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:49:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:49:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:49:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/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 11:49:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/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 11:49:43 INFO - Downloaded 11130997 bytes. 11:49:43 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 11:49:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:49:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 11:49:43 INFO - Return code: 0 11:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:43 INFO - https://queue.taskcluster.net/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:49:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:49:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:49:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 11:49:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/z1zQHjPXQfe0q7_IcxNFkg/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 11:49:46 INFO - Downloaded 109907658 bytes. 11:49:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:49:46 INFO - mkdir: /builds/slave/test/properties 11:49:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:49:46 INFO - Writing to file /builds/slave/test/properties/build_url 11:49:46 INFO - Contents: 11:49:46 INFO - build_url:https://queue.taskcluster.net/v1/task/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:49:46 INFO - Running post-action listener: _resource_record_post_action 11:49:46 INFO - Running post-action listener: set_extra_try_arguments 11:49:46 INFO - ##### 11:49:46 INFO - ##### Running populate-webroot step. 11:49:46 INFO - ##### 11:49:46 INFO - Running pre-action listener: _resource_record_pre_action 11:49:46 INFO - Running main action method: populate_webroot 11:49:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:49:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:49:46 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:49:46 INFO - '../fennec_ids.txt'], 11:49:46 INFO - 'tests': ['tcheck2']}, 11:49:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:49:46 INFO - '--tppagecycles', 11:49:46 INFO - '7'], 11:49:46 INFO - 'tests': ['tsvgm']}}, 11:49:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:49:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:49:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:49:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:49:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:49:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:49:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:46 INFO - 'talos_options': ['--e10s'], 11:49:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:46 INFO - 'tests': ['damp', 'tps']}, 11:49:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:46 INFO - 'talos_options': ['--e10s'], 11:49:46 INFO - 'tests': ['damp', 'tps']}, 11:49:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:49:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:49:46 INFO - 'other': {'tests': ['a11yr', 11:49:46 INFO - 'ts_paint', 11:49:46 INFO - 'tpaint', 11:49:46 INFO - 'sessionrestore', 11:49:46 INFO - 'sessionrestore_no_auto_restore']}, 11:49:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:49:46 INFO - 'tests': ['a11yr', 11:49:46 INFO - 'ts_paint', 11:49:46 INFO - 'tpaint', 11:49:46 INFO - 'sessionrestore', 11:49:46 INFO - 'sessionrestore_no_auto_restore']}, 11:49:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:49:46 INFO - 'tests': ['a11yr', 11:49:46 INFO - 'ts_paint', 11:49:46 INFO - 'tpaint', 11:49:46 INFO - 'sessionrestore', 11:49:46 INFO - 'sessionrestore_no_auto_restore']}, 11:49:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:49:46 INFO - 'tests': ['a11yr', 11:49:46 INFO - 'ts_paint', 11:49:46 INFO - 'tpaint', 11:49:46 INFO - 'sessionrestore', 11:49:46 INFO - 'sessionrestore_no_auto_restore']}, 11:49:46 INFO - 'other_l64': {'tests': ['a11yr', 11:49:46 INFO - 'ts_paint', 11:49:46 INFO - 'tpaint', 11:49:46 INFO - 'sessionrestore', 11:49:46 INFO - 'sessionrestore_no_auto_restore']}, 11:49:46 INFO - 'other_nol64': {'tests': ['a11yr', 11:49:46 INFO - 'ts_paint', 11:49:46 INFO - 'tpaint', 11:49:46 INFO - 'sessionrestore', 11:49:46 INFO - 'sessionrestore_no_auto_restore']}, 11:49:46 INFO - 'svgr': {'tests': ['tsvgx', 11:49:46 INFO - 'tsvgr_opacity', 11:49:46 INFO - 'tart', 11:49:46 INFO - 'tscrollx', 11:49:46 INFO - 'cart']}, 11:49:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:49:46 INFO - 'tests': ['tsvgx', 11:49:46 INFO - 'tsvgr_opacity', 11:49:46 INFO - 'tart', 11:49:46 INFO - 'tscrollx', 11:49:46 INFO - 'cart']}, 11:49:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:46 INFO - 'tests': ['tp5o']}, 11:49:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:46 INFO - 'talos_options': ['--e10s'], 11:49:46 INFO - 'tests': ['tp5o']}, 11:49:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:46 INFO - 'talos_options': ['--xperf_path', 11:49:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:46 INFO - 'tests': ['tp5n']}, 11:49:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:46 INFO - 'talos_options': ['--e10s', 11:49:46 INFO - '--xperf_path', 11:49:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:46 INFO - 'tests': ['tp5n']}}, 11:49:46 INFO - 'talos.zip': {'path': '', 11:49:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:49:46 INFO - Running post-action listener: _resource_record_post_action 11:49:46 INFO - ##### 11:49:46 INFO - ##### Running create-virtualenv step. 11:49:46 INFO - ##### 11:49:46 INFO - Running pre-action listener: _resource_record_pre_action 11:49:46 INFO - Running main action method: create_virtualenv 11:49:46 INFO - Creating virtualenv /builds/slave/test/build/venv 11:49:46 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 11:49:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:49:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:49:46 INFO - Using real prefix '/tools/python27' 11:49:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:49:47 INFO - Installing distribute.............................................................................................................................................................................................done. 11:49:50 INFO - Installing pip.................done. 11:49:50 INFO - Return code: 0 11:49:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x109030490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10900d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab047c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f549f0>, '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 0x108cb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f478c8>, '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.eMqNJrQ3Xu/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.Ujd85nbAUR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 11:49:50 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 11:49:50 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 11:49:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMqNJrQ3Xu/Render', 11:49:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:50 INFO - 'HOME': '/Users/cltbld', 11:49:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:50 INFO - 'LOGNAME': 'cltbld', 11:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:50 INFO - 'MOZ_NO_REMOTE': '1', 11:49:50 INFO - 'NO_EM_RESTART': '1', 11:49:50 INFO - 'PAGER': '/bin/cat', 11:49:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:50 INFO - 'PWD': '/builds/slave/test', 11:49:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:50 INFO - 'SHELL': '/bin/bash', 11:49:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ujd85nbAUR/Listeners', 11:49:50 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 11:49:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:50 INFO - 'USER': 'cltbld', 11:49:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:50 INFO - 'XPC_FLAGS': '0x0', 11:49:50 INFO - 'XPC_SERVICE_NAME': '0', 11:49:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:50 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 11:49:50 INFO - Cleaning up... 11:49:50 INFO - Return code: 0 11:49:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x109030490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10900d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab047c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f549f0>, '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 0x108cb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f478c8>, '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.eMqNJrQ3Xu/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.Ujd85nbAUR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 11:49:50 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 11:49:50 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 11:49:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMqNJrQ3Xu/Render', 11:49:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:50 INFO - 'HOME': '/Users/cltbld', 11:49:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:50 INFO - 'LOGNAME': 'cltbld', 11:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:50 INFO - 'MOZ_NO_REMOTE': '1', 11:49:50 INFO - 'NO_EM_RESTART': '1', 11:49:50 INFO - 'PAGER': '/bin/cat', 11:49:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:50 INFO - 'PWD': '/builds/slave/test', 11:49:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:50 INFO - 'SHELL': '/bin/bash', 11:49:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ujd85nbAUR/Listeners', 11:49:50 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 11:49:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:50 INFO - 'USER': 'cltbld', 11:49:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:50 INFO - 'XPC_FLAGS': '0x0', 11:49:50 INFO - 'XPC_SERVICE_NAME': '0', 11:49:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:50 INFO - Downloading/unpacking psutil>=0.7.1 11:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:49:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:49:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:53 INFO - Installing collected packages: psutil 11:49:53 INFO - Running setup.py install for psutil 11:49:53 INFO - building 'psutil._psutil_osx' extension 11:49:53 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 11:49:54 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 11:49:54 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 11:49:54 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 11:49:54 INFO - building 'psutil._psutil_posix' extension 11:49:54 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 11:49:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:49:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:49:54 INFO - ^ 11:49:54 INFO - 1 warning generated. 11:49:54 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 11:49:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:54 INFO - Successfully installed psutil 11:49:54 INFO - Cleaning up... 11:49:54 INFO - Return code: 0 11:49:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x109030490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10900d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab047c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f549f0>, '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 0x108cb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f478c8>, '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.eMqNJrQ3Xu/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.Ujd85nbAUR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 11:49:54 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 11:49:54 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 11:49:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMqNJrQ3Xu/Render', 11:49:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:54 INFO - 'HOME': '/Users/cltbld', 11:49:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:54 INFO - 'LOGNAME': 'cltbld', 11:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:54 INFO - 'MOZ_NO_REMOTE': '1', 11:49:54 INFO - 'NO_EM_RESTART': '1', 11:49:54 INFO - 'PAGER': '/bin/cat', 11:49:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:54 INFO - 'PWD': '/builds/slave/test', 11:49:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:54 INFO - 'SHELL': '/bin/bash', 11:49:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ujd85nbAUR/Listeners', 11:49:54 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 11:49:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:54 INFO - 'USER': 'cltbld', 11:49:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:54 INFO - 'XPC_FLAGS': '0x0', 11:49:54 INFO - 'XPC_SERVICE_NAME': '0', 11:49:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:49:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:49:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:49:57 INFO - Installing collected packages: mozsystemmonitor 11:49:57 INFO - Running setup.py install for mozsystemmonitor 11:49:57 INFO - Successfully installed mozsystemmonitor 11:49:57 INFO - Cleaning up... 11:49:57 INFO - Return code: 0 11:49:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:49: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')]} 11:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49: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')]} 11:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x109030490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10900d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab047c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f549f0>, '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 0x108cb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f478c8>, '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.eMqNJrQ3Xu/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.Ujd85nbAUR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 11:49:57 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 11:49:57 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 11:49:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMqNJrQ3Xu/Render', 11:49:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:57 INFO - 'HOME': '/Users/cltbld', 11:49:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:57 INFO - 'LOGNAME': 'cltbld', 11:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:57 INFO - 'MOZ_NO_REMOTE': '1', 11:49:57 INFO - 'NO_EM_RESTART': '1', 11:49:57 INFO - 'PAGER': '/bin/cat', 11:49:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:57 INFO - 'PWD': '/builds/slave/test', 11:49:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:57 INFO - 'SHELL': '/bin/bash', 11:49:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ujd85nbAUR/Listeners', 11:49:57 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 11:49:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:57 INFO - 'USER': 'cltbld', 11:49:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:57 INFO - 'XPC_FLAGS': '0x0', 11:49:57 INFO - 'XPC_SERVICE_NAME': '0', 11:49:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:57 INFO - Downloading/unpacking blobuploader==1.2.4 11:49:57 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 11:49:57 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 11:49:57 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 11:49:57 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 11:49:57 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 11:49:57 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 11:49:59 INFO - Downloading blobuploader-1.2.4.tar.gz 11:49:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:49:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:49:59 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 11:49:59 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 11:49:59 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 11:49:59 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 11:49:59 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 11:49:59 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 11:50:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:50:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:50:00 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 11:50:00 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 11:50:00 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 11:50:00 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 11:50:00 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 11:50:00 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 11:50:00 INFO - Downloading docopt-0.6.1.tar.gz 11:50:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:50:01 INFO - Installing collected packages: blobuploader, requests, docopt 11:50:01 INFO - Running setup.py install for blobuploader 11:50:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:50:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:50:01 INFO - Running setup.py install for requests 11:50:01 INFO - Running setup.py install for docopt 11:50:01 INFO - Successfully installed blobuploader requests docopt 11:50:01 INFO - Cleaning up... 11:50:01 INFO - Return code: 0 11:50:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50:01 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')]} 11:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:01 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')]} 11:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:01 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 0x109030490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10900d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab047c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f549f0>, '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 0x108cb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f478c8>, '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.eMqNJrQ3Xu/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.Ujd85nbAUR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 11:50:01 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 11:50:01 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 11:50:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMqNJrQ3Xu/Render', 11:50:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:01 INFO - 'HOME': '/Users/cltbld', 11:50:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:01 INFO - 'LOGNAME': 'cltbld', 11:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:01 INFO - 'MOZ_NO_REMOTE': '1', 11:50:01 INFO - 'NO_EM_RESTART': '1', 11:50:01 INFO - 'PAGER': '/bin/cat', 11:50:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:01 INFO - 'PWD': '/builds/slave/test', 11:50:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:01 INFO - 'SHELL': '/bin/bash', 11:50:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ujd85nbAUR/Listeners', 11:50:01 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 11:50:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:01 INFO - 'USER': 'cltbld', 11:50:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:01 INFO - 'XPC_FLAGS': '0x0', 11:50:01 INFO - 'XPC_SERVICE_NAME': '0', 11:50:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:50:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-0_mX7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:50:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-1LpxIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:50:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-bUAXrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:50:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-P_of9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:50:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-fPwEtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:50:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-YHO71k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:50:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-XDjzPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:50:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-tGRKgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:50:02 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-qNPoez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:50:03 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-FwNvMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:50:03 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-yy6_wB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:50:03 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-nXE47F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:50:03 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-VUzgJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:50:03 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-iyXYQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:03 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-ruHap8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:50:03 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-znbjlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:50:03 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-LV8Yxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:50:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:50:03 INFO - Running setup.py install for manifestparser 11:50:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:50:04 INFO - Running setup.py install for mozcrash 11:50:04 INFO - Running setup.py install for mozdebug 11:50:04 INFO - Running setup.py install for mozdevice 11:50:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:50:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:50:04 INFO - Running setup.py install for mozfile 11:50:04 INFO - Running setup.py install for mozhttpd 11:50:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:50:04 INFO - Running setup.py install for mozinfo 11:50:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:50:04 INFO - Running setup.py install for mozInstall 11:50:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:50:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:50:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:50:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:50:05 INFO - Running setup.py install for mozleak 11:50:05 INFO - Running setup.py install for mozlog 11:50:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:50:05 INFO - Running setup.py install for moznetwork 11:50:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:50:05 INFO - Running setup.py install for mozprocess 11:50:05 INFO - Running setup.py install for mozprofile 11:50:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:50:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:50:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:50:05 INFO - Running setup.py install for mozrunner 11:50:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:50:06 INFO - Running setup.py install for mozscreenshot 11:50:06 INFO - Running setup.py install for moztest 11:50:06 INFO - Running setup.py install for mozversion 11:50:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:50:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:50:06 INFO - Cleaning up... 11:50:06 INFO - Return code: 0 11:50:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50: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')]} 11:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50: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')]} 11:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:06 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 0x109030490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10900d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab047c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f549f0>, '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 0x108cb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f478c8>, '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.eMqNJrQ3Xu/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.Ujd85nbAUR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 11:50:06 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 11:50:06 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 11:50:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMqNJrQ3Xu/Render', 11:50:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:06 INFO - 'HOME': '/Users/cltbld', 11:50:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:06 INFO - 'LOGNAME': 'cltbld', 11:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:06 INFO - 'MOZ_NO_REMOTE': '1', 11:50:06 INFO - 'NO_EM_RESTART': '1', 11:50:06 INFO - 'PAGER': '/bin/cat', 11:50:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:06 INFO - 'PWD': '/builds/slave/test', 11:50:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:06 INFO - 'SHELL': '/bin/bash', 11:50:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ujd85nbAUR/Listeners', 11:50:06 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 11:50:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:06 INFO - 'USER': 'cltbld', 11:50:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:06 INFO - 'XPC_FLAGS': '0x0', 11:50:06 INFO - 'XPC_SERVICE_NAME': '0', 11:50:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:50:06 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-3FseCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:50:06 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)) 11:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:50:06 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-cGrDaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:50:07 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)) 11:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:50:07 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-jA6m3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:50:07 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)) 11:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:50:07 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-g3h21A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:50:07 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)) 11:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:50:07 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-k9UK7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:50:07 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)) 11:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:50:07 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-riubC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:50:07 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)) 11:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:50:07 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-GA0HfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:50:07 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)) 11:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:50:07 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-UMBGjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:50:07 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)) 11:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:50:07 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-QczRau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:50:07 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)) 11:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:50:07 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-i3XMGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:50:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:50:07 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-HQa4zH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:50:07 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)) 11:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:50:07 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-2wwKdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:50:08 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)) 11:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:50:08 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-FNL7rC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:50:08 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)) 11:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:50:08 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-5r4bxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:50:08 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)) 11:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:08 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-EUndqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:08 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)) 11:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:50:08 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-NNZlWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:50:08 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)) 11:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:50:08 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-tpVy3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:50:08 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)) 11:50:08 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)) 11:50:08 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)) 11:50:08 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)) 11:50:08 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)) 11:50:08 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)) 11:50:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:50:08 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 11:50:08 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 11:50:08 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 11:50:08 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 11:50:08 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 11:50:08 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 11:50:10 INFO - Downloading blessings-1.5.1.tar.gz 11:50:10 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 11:50:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:50:10 INFO - Installing collected packages: blessings 11:50:10 INFO - Running setup.py install for blessings 11:50:11 INFO - Successfully installed blessings 11:50:11 INFO - Cleaning up... 11:50:11 INFO - Return code: 0 11:50:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:50:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:11 INFO - Reading from file tmpfile_stdout 11:50:11 INFO - Current package versions: 11:50:11 INFO - blessings == 1.5.1 11:50:11 INFO - blobuploader == 1.2.4 11:50:11 INFO - docopt == 0.6.1 11:50:11 INFO - manifestparser == 1.1 11:50:11 INFO - mozInstall == 1.12 11:50:11 INFO - mozcrash == 0.16 11:50:11 INFO - mozdebug == 0.1 11:50:11 INFO - mozdevice == 0.47 11:50:11 INFO - mozfile == 1.2 11:50:11 INFO - mozhttpd == 0.7 11:50:11 INFO - mozinfo == 0.9 11:50:11 INFO - mozleak == 0.1 11:50:11 INFO - mozlog == 3.1 11:50:11 INFO - moznetwork == 0.27 11:50:11 INFO - mozprocess == 0.22 11:50:11 INFO - mozprofile == 0.27 11:50:11 INFO - mozrunner == 6.11 11:50:11 INFO - mozscreenshot == 0.1 11:50:11 INFO - mozsystemmonitor == 0.0 11:50:11 INFO - moztest == 0.7 11:50:11 INFO - mozversion == 1.4 11:50:11 INFO - psutil == 3.1.1 11:50:11 INFO - requests == 1.2.3 11:50:11 INFO - wsgiref == 0.1.2 11:50:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:11 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 0x109030490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10900d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffab047c910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f549f0>, '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 0x108cb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f478c8>, '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.eMqNJrQ3Xu/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.Ujd85nbAUR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 11:50:11 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 11:50:11 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 11:50:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMqNJrQ3Xu/Render', 11:50:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:11 INFO - 'HOME': '/Users/cltbld', 11:50:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:11 INFO - 'LOGNAME': 'cltbld', 11:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:11 INFO - 'MOZ_NO_REMOTE': '1', 11:50:11 INFO - 'NO_EM_RESTART': '1', 11:50:11 INFO - 'PAGER': '/bin/cat', 11:50:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:11 INFO - 'PWD': '/builds/slave/test', 11:50:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:11 INFO - 'SHELL': '/bin/bash', 11:50:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ujd85nbAUR/Listeners', 11:50:11 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 11:50:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:11 INFO - 'USER': 'cltbld', 11:50:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:11 INFO - 'XPC_FLAGS': '0x0', 11:50:11 INFO - 'XPC_SERVICE_NAME': '0', 11:50:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:11 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)) 11:50:11 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)) 11:50:11 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)) 11:50:11 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)) 11:50:11 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)) 11:50:11 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)) 11:50:11 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)) 11:50:11 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)) 11:50:11 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)) 11:50:11 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)) 11:50:11 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)) 11:50:11 INFO - Cleaning up... 11:50:11 INFO - Return code: 0 11:50:11 INFO - Running post-action listener: _resource_record_post_action 11:50:11 INFO - Running post-action listener: _start_resource_monitoring 11:50:11 INFO - Starting resource monitoring. 11:50:11 INFO - ##### 11:50:11 INFO - ##### Running install step. 11:50:11 INFO - ##### 11:50:11 INFO - Running pre-action listener: _resource_record_pre_action 11:50:11 INFO - Running main action method: install 11:50:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:11 INFO - Reading from file tmpfile_stdout 11:50:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:50:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:50:12 INFO - Reading from file tmpfile_stdout 11:50:12 INFO - Output received: 11:50:12 INFO - Usage: mozinstall [options] installer 11:50:12 INFO - Options: 11:50:12 INFO - -h, --help show this help message and exit 11:50:12 INFO - -d DEST, --destination=DEST 11:50:12 INFO - Directory to install application into. [default: 11:50:12 INFO - "/builds/slave/test"] 11:50:12 INFO - --app=APP Application being installed. [default: firefox] 11:50:12 INFO - mkdir: /builds/slave/test/build/application 11:50:12 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'] 11:50:12 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 11:50:42 INFO - Reading from file tmpfile_stdout 11:50:42 INFO - Output received: 11:50:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:50:42 INFO - Running post-action listener: _resource_record_post_action 11:50:42 INFO - ##### 11:50:42 INFO - ##### Running run-tests step. 11:50:42 INFO - ##### 11:50:42 INFO - Running pre-action listener: _resource_record_pre_action 11:50:42 INFO - Running main action method: run_tests 11:50:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:50:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:50:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:50:42 INFO - 2015-11-24 11:50:42.479 screenresolution[2231:16557] starting screenresolution argv=screenresolution get 11:50:42 INFO - 2015-11-24 11:50:42.481 screenresolution[2231:16557] Display 0: 1600x1200x32@60 11:50:42 INFO - 2015-11-24 11:50:42.487 screenresolution[2232:16559] starting screenresolution argv=screenresolution list 11:50:42 INFO - Available Modes on Display 0 11:50:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:50:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:50:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:50:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:50:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:50:42 INFO - Intel Iris: 11:50:42 INFO - Chipset Model: Intel Iris 11:50:42 INFO - Type: GPU 11:50:42 INFO - Bus: Built-In 11:50:42 INFO - VRAM (Dynamic, Max): 1536 MB 11:50:42 INFO - Vendor: Intel (0x8086) 11:50:42 INFO - Device ID: 0x0a2e 11:50:42 INFO - Revision ID: 0x0009 11:50:42 INFO - Displays: 11:50:42 INFO - Display: 11:50:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:50:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:50:42 INFO - Display Serial Number: 1600x1200 60 11:50:42 INFO - Main Display: Yes 11:50:42 INFO - Mirror: Off 11:50:42 INFO - Online: Yes 11:50:42 INFO - Rotation: Supported 11:50:42 INFO - Return code: 0 11:50:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:50:42 INFO - Python 2.7.3 11:50:42 INFO - Return code: 0 11:50:42 INFO - grabbing minidump binary from tooltool 11:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:42 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 0x108f549f0>, '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 0x108cb3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f478c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:50:42 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 11:50:42 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 11:50:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:50:42 INFO - Return code: 0 11:50:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:50:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:50:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:50:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:50:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:50:42 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/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0039', '--webServer', 'localhost'] in /builds/slave/test/build 11:50:42 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/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0039 --webServer localhost 11:50:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eMqNJrQ3Xu/Render', 11:50:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:42 INFO - 'HOME': '/Users/cltbld', 11:50:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:42 INFO - 'LOGNAME': 'cltbld', 11:50:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:42 INFO - 'MOZ_NO_REMOTE': '1', 11:50:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:42 INFO - 'NO_EM_RESTART': '1', 11:50:42 INFO - 'PAGER': '/bin/cat', 11:50:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:42 INFO - 'PWD': '/builds/slave/test', 11:50:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:42 INFO - 'SHELL': '/bin/bash', 11:50:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ujd85nbAUR/Listeners', 11:50:42 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 11:50:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:42 INFO - 'USER': 'cltbld', 11:50:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:42 INFO - 'XPC_FLAGS': '0x0', 11:50:42 INFO - 'XPC_SERVICE_NAME': '0', 11:50:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:42 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/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0039', '--webServer', 'localhost'] with output_timeout 3600 11:50:43 INFO - mozversion INFO | application_buildid: 20151124104631 11:50:43 INFO - mozversion INFO | application_changeset: 433f2e9c7239d2b706bf169f78e9921c38fc75c6 11:50:43 INFO - mozversion INFO | application_display_name: Nightly 11:50:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:50:43 INFO - mozversion INFO | application_name: Firefox 11:50:43 INFO - mozversion INFO | application_remotingname: firefox 11:50:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:50:43 INFO - mozversion INFO | application_vendor: Mozilla 11:50:43 INFO - mozversion INFO | application_version: 45.0a1 11:50:43 INFO - mozversion INFO | platform_buildid: 20151124104631 11:50:43 INFO - mozversion INFO | platform_changeset: 433f2e9c7239d2b706bf169f78e9921c38fc75c6 11:50:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:50:43 INFO - mozversion INFO | platform_version: 45.0a1 11:50:43 INFO - 2015-11-24 11:50:43,030 DEBUG : using testdate: 1448394643 11:50:43 INFO - 2015-11-24 11:50:43,030 DEBUG : actual date: 1448394643 11:50:43 INFO - 2015-11-24 11:50:43,441 INFO : starting webserver on 'localhost:50109' 11:50:43 INFO - 2015-11-24 11:50:43,441 INFO : Starting test suite t-yosemite-r7-0039 11:50:43 INFO - 2015-11-24 11:50:43,442 INFO : Starting test dromaeo_css 11:50:43 INFO - 2015-11-24 11:50:43,442 DEBUG : operating with platform_type : mac_ 11:50:43 INFO - 2015-11-24 11:50:43,443 INFO : Initialising browser for dromaeo_css test... 11:50:43 INFO - 2015-11-24 11:50:43,455 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpYIGkU1/profile http://localhost:50109/getInfo.html 11:50:45 INFO - 2015-11-24 11:50:45,502 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:50:45 INFO - 2015-11-24 11:50:45,503 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:50:45 INFO - 2015-11-24 11:50:45,503 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:50:45 INFO - 2015-11-24 11:50:45,503 DEBUG : BROWSER_OUTPUT: __metrics 11:50:45 INFO - 2015-11-24 11:50:45,519 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:50:45 INFO - 2015-11-24 11:50:45,778 DEBUG : BROWSER_OUTPUT: console.error: 11:50:45 INFO - 2015-11-24 11:50:45,779 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 11:50:45 INFO - 2015-11-24 11:50:45,779 DEBUG : BROWSER_OUTPUT: Stack: 11:50:45 INFO - 2015-11-24 11:50:45,779 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 11:50:45 INFO - 2015-11-24 11:50:45,779 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 11:50:45 INFO - 2015-11-24 11:50:45,779 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 11:50:45 INFO - 2015-11-24 11:50:45,779 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 11:50:45 INFO - 2015-11-24 11:50:45,781 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 11:50:45 INFO - 2015-11-24 11:50:45,781 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 11:50:45 INFO - 2015-11-24 11:50:45,781 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 11:50:45 INFO - 2015-11-24 11:50:45,781 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 11:50:45 INFO - 2015-11-24 11:50:45,781 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 11:50:45 INFO - 2015-11-24 11:50:45,781 DEBUG : BROWSER_OUTPUT: 11:50:46 INFO - 2015-11-24 11:50:46,174 INFO : Browser initialized. 11:50:46 INFO - 2015-11-24 11:50:46,175 INFO : Running cycle 1/1 for dromaeo_css test... 11:50:46 INFO - 2015-11-24 11:50:46,175 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpYIGkU1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:50:58 INFO - 2015-11-24 11:50:58,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 226131968 11:50:58 INFO - 2015-11-24 11:50:58,014 DEBUG : BROWSER_OUTPUT: 11:51:48 INFO - 2015-11-24 11:51:48,993 DEBUG : BROWSER_OUTPUT: 1448394708992 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] 11:54:01 INFO - 2015-11-24 11:54:01,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50109/tests/dromaeo/cssquery-ext.html) 11:54:02 INFO - 2015-11-24 11:54:02,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 373239808 11:54:02 INFO - 2015-11-24 11:54:02,468 DEBUG : BROWSER_OUTPUT: 11:57:05 INFO - 2015-11-24 11:57:05,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/dromaeo/cssquery-ext.html (next: http://localhost:50109/tests/dromaeo/cssquery-jquery.html) 11:57:05 INFO - 2015-11-24 11:57:05,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 365957120 11:57:05 INFO - 2015-11-24 11:57:05,914 DEBUG : BROWSER_OUTPUT: 12:00:07 INFO - 2015-11-24 12:00:07,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50109/tests/dromaeo/cssquery-mootools.html) 12:00:08 INFO - 2015-11-24 12:00:08,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 354824192 12:00:08 INFO - 2015-11-24 12:00:08,433 DEBUG : BROWSER_OUTPUT: 12:03:10 INFO - 2015-11-24 12:03:10,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50109/tests/dromaeo/cssquery-prototype.html) 12:03:11 INFO - 2015-11-24 12:03:11,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 332652544 12:03:11 INFO - 2015-11-24 12:03:11,080 DEBUG : BROWSER_OUTPUT: 12:06:14 INFO - 2015-11-24 12:06:14,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50109/tests/dromaeo/cssquery-yui.html) 12:06:14 INFO - 2015-11-24 12:06:14,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 330420224 12:06:14 INFO - 2015-11-24 12:06:14,663 DEBUG : BROWSER_OUTPUT: 12:09:17 INFO - 2015-11-24 12:09:17,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/dromaeo/cssquery-yui.html (next: http://localhost:50109/tests/dromaeo/cssquery-dojo.html) 12:09:17 INFO - 2015-11-24 12:09:17,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 385880064 12:09:17 INFO - 2015-11-24 12:09:17,655 DEBUG : BROWSER_OUTPUT: 12:09:17 INFO - 2015-11-24 12:09:17,655 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:09:17 INFO - 2015-11-24 12:09:17,655 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:09:17 INFO - 2015-11-24 12:09:17,655 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:09:17 INFO - 2015-11-24 12:09:17,655 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:09:17 INFO - 2015-11-24 12:09:17,655 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3381;3420.7434442416825;3468.67047630475;3480.3735327641016;3509.789412635242;5594.356648985368;5662.546996240301;5742.138679198122;5910.793122240722;5914.053751399782;5753.252077229965;5819.418058194189;5828.650280983134;5830.183774271605;5831.212786273863;5195.03891780021;5226.033183860979;5253.159494480884;5288.814891478799;5308.575313974873;5302.840914772543;5308.150695888658;5311.840644780663;5312.442193569677;5324.600654950875;5289.312389389374;5295.152775555912;5304.3634763828395;5305.840824775263;5320.6275560710765;5282.128448805943;5288.867778305535;5295.391030031557;5303.761330740126;5305.495977882114;4445.51099379068;5141.305923700327;5162.845114646567;5246.081935661244;5287.576993840484;5700.600957932905;5821.417858214187;5841.941580584183;5870.178175055496;5883.294004719418;6215.1609532712955;6217.067439884008;6220.098085777537;6220.533459990519;6253.1245625612455;6098.3701427309925;6130.917941863022;6186.474149697281;6203.069539569101;6235.158253635792;5982.392460437646;6046.486048685823;6051.425114614105;6075.939240607538;6076.605020673642;5443.374011988592;5865.472107510259;6219.626822390671;6361.363863613602;6368;6042.6978651067275;6104.053871649812;6125.551374386395;6139.2325959255095;6171.321154672983;6239.06414037898;6240.157578726814;6242.313345531988;6243.43809057178;6246.500279977591;6182.598131121463;6227.346128656516;6231.501479881598;6232.345603711636;6242.500599951993;6093.421124993119;6120.843333897677;6159.414855588712;6173.41352571505;6176.135341052256;5024.397072351341;5025.748712564357;5031.195008798574;5033.672811267256;5055.721935293521;4507.459104907432;4514.164879497303;4522.163399771053;4540.273556230987;4543.954560454353;5660.320761508646;5750.367459579443;5804.535637149018;5811.360750317462;5881.264841894763;6203.906941395882;6218.005119181;6219.968900155471;6223.066540019034;6225.066240064027;5753.942460575341;5790.160426738099;5817.3019237690905;5818.21454103699;5823.88352232953;5444.8366549003595;5457.672539647634;5468.808591699271;5470.343558772893;5485.533729633026;6219.47134493564;6239.282482514569;6253.062040693932;6287.2769631492965;6290.370962903765;6222.875542489034;6225.937740622536;6228.968855155696;6237.438630523275;6246.593971391845;6292.2134733158355;6321.1782468278825;6326.4622507087415;6327.209098862642;6348.555601107878;5280.603954703336;6066.241719785027;6091.974537450126;6140.320203811546;6147.477464415396;6216.378362163748;6221.3156552778255;6239.812805615838;6241.875162496815;6244.875102497834;5375;6195.411435913581;6198.659073750807;6201.565890387629;6205.596636218631;5974;6099.634021958696;6130.816075517741;6140;6176.876462470816;6080.5824274458255;6099.695015249308;6117.724702388314;6126.129726867241;6131.019036954244;5880.970595146997;5968.104784282393;6184.828464538675;6220.346863579259;6233.438990490878;5883.0881213411985;5970.134330522137;5983.461488465885;6017.368176341596;6108.17539632144 12:09:17 INFO - 2015-11-24 12:09:17,655 DEBUG : BROWSER_OUTPUT: |1;ext.html;529.4705294705295;545.8471627944177;554.3486403475915;637.0317117980672;637.4549759955238;31702.524462133057;42450.57549424505;42960.570394296046;43086;43094.99999999996;44526;45054.99999999992;45083.549164508346;45092.774536127275;45119;8842.867356989651;8990.820183596325;9836.655717049905;10031.59873605055;10041.899581004169;8802.383833131684;12172.330521821295;12275.202111862745;12283.01735861129;12290.385480725972;12055.975242104432;12164.635060948185;12169.14815962883;12184.268943863352;12223.877761222408;8975.371723979324;9084.2732581394;9125.087491250888;12051.819222711667;12164.695882602917;12111;12254.877451225462;12262.386880655931;12280.631581052494;12290.446929888176;41903;42321.1535769286;42382.94042648927;42400.36399454011;42494.362584561255;3110.5178697301726;3116.1430606583144;3125;3126.656067832537;3202.823844688541;26751.866240668867;29045;29214.561781573295;29244;30410.84794576035;2646.020972240264;2838.3613686920485;2847;2864.3125649844096;2875.7699384049224;494149;494353;494637.9999999964;494930;495894.52052739507;62436.687816560625;62523.6873815628;63420.365796341444;67910;72518;70147;70711.64644176746;70815.2918470819;70995.64502177456;71070.28929710637;16425.1787410629;16568.75146872798;16585.25366358517;16594.83405165957;16665.750013749803;12496.062795290389;12558.68603284907;12563.371831408393;12570.748585028432;12758.48966041348;17668.204930778145;21015;21137.67485576616;21366.89316553407;21391.358259252247;8904.8664270036;9146.771330716652;9153.35926485153;9166.450012999241;9242.630294788134;918.3158546882615;935.9064093590587;1013.4983183324301;1078.8381742738495;1169.128998895828;29123.85438072796;29391.412171756874;29479;30049.849750751542;30155.396892062035;1065.2223876569992;1112.8330750387345;1144.6966553863233;1161.9593314233962;1207.758448310324;15151.772723409158;15612.92193539025;15939.760903586455;16054.598635034217;16168.434104806276;522882;528165;528483;530309;531692;60735.39264607297;60881;60901.69549152226;60978.78042439126;61316;1146.810776221914;1284.036972270797;1449.5723761490597;1468.4713503138862;1611.4198888400167;29027.85486072556;30467.238319041313;30923.0723078308;30964.60659270293;31310.530342044432;56200.43799561952;56457.43542564522;56613.15080273717;56647.43352566587;56662.7166864163;447835;521224;521797;536460;552670;31059.447027648977;31079;31425.21436964094;31466;31512.36975260528;44093;44553.55446445494;44756.77621611871;45265;45985.08029839318;38556.80721596374;38747.806260968515;39042.80478597589;39847;39979;37846.62153378431;38503.422448662735;38661;38759.64341248043;38961;37276.25447491089;38206.235875282895;38401.03997400087;38427.23145537129;38653.033674158374;31542.842285789342;33294;34478.65521344754;34601.134971625914;34700.78547250834;24409.51180976406;24430.511389772462;24578.89394977266;24689.506209875344;24691.259262222164 12:09:17 INFO - 2015-11-24 12:09:17,657 DEBUG : BROWSER_OUTPUT: |2;jquery.html;303.47650303226936;356.5258206585242;356.7003716877822;361.11166530335373;364.86682360938266;15324.616884577863;16348.591285217875;18970.715439268406;20475.283365082225;21689.783102168993;20761.896190519026;20810.271640492585;21150.365489035314;21193.83433911134;21202;6377.649229292399;6560.901586476183;6566.934330656704;6569.244536878248;6569.638669873155;4661.743604101773;4816.87957801056;4939.629527785412;6458.225012998447;7730.458867879251;7146.8570628587395;7248.3838873695795;7684.9231507685045;7691.538507689528;7703.499272547295;7231.493795434321;7248.4563657725885;7252.782416527512;7257.310555497219;7259.0563226780705;6856.760013399557;7249.818754531127;7252.238514955907;7257.092863392076;7260.455465840083;27351.589726154125;27398.767055482353;27782.722172778416;28158.859205704044;28278.575821362698;2160.2763074370105;2233.4304752288226;2298.1726578431753;2449.0571130115036;2456.8648724320155;14975.251237438084;15202.543923682308;15822.52532424029;15979.440719574759;16525.091119988396;1805.7742782152231;1878;1879.6710575649206;1886.2549293029315;1904.8761830480973;109809.35285970717;115544;115548.42225788817;116683.83316166814;118249;18790.248390064244;18816.717749233772;18847.71728424075;18883.52791180204;18976.905115474336;27921.30196745057;27983.02059427951;28051;28060.43879122447;28076.43847123087;8230.917690823135;10051;10106;10114.342567733074;10130.37913933767;8378.916210837813;8386;8415.368847336475;8433.578321084044;8488.40581159313;6928.1339832520935;7353.889691654629;8503.787405314917;8617.82764344722;8627.396082274181;1810.2306519729063;1820.3264792027035;1828.6982647862953;1846.1415441819618;2389.2951579284154;879.4371602174614;936.3305236755753;953.6900507335143;961.9470929098827;1016.4409574734015;19191;19721;20146;20216.29242976518;20318.390448286576;912.6623149434752;942.6182396129578;949.3639261694681;956.8134213828375;1026.2604884720326;10453.738656533495;10792.46037698112;10794;10816.621418250481;10859.34843909368;647641;751558;757964;770683;785000;85732;105317;112088;114127.85872141339;117010.41494792471;1104.3870651788334;1118.3737107219983;1168.8480497535436;1193.7075416522835;1194.9761004779855;17379.217935192693;17570.472885813448;17589;17603.383881564085;17693.64612707713;40553.75569954338;48254;48788;51293;52755;65328;65619.68760624665;65844;66285;67518.66240668962;9450.858237126311;9813.656522021694;9848.753781155528;9857.162141218078;9870.605175792887;14920.7761883574;19595.216191352185;19691.113899874254;19810.50473738168;20092.39722808318;5161.793528258828;15427.305771240546;15896.761548577011;16109;16174;14963.476278330207;15709.764353534934;15719;15829.604259893595;15848.683026339639;16067.678646427239;16093.75859362134;16127.596810079842;16525.421610243582;16717.749233761748;8280.296174825207;9594.04059594035;9653.855192171983;9727.270454715783;9864.457454840052;15552.688946221238;15646.530604081896;15694.529164125095;16046.919765401099;16179.595510112342 12:09:17 INFO - 2015-11-24 12:09:17,658 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1470.35304466035;1540.9845901540982;1550.7906432631592;1909.1790530072071;1924.143756028567;7507.24927507249;7636.427267954905;8179.263866252044;8535.999999999984;8549.61526731297;7348.669309881055;7505.437092218078;8410.57947102644;8471.576421178946;8479.618417171227;2127.9148834046696;2183.235867446389;2364.326167042393;2377.465070359173;2380.143148466551;1757.4639734880857;2373.0389192377115;2391.784739373456;2395.101836811196;2395.2454976682375;2294.655801629752;2325.360525855395;2344.4724936889147;2348.4481146930457;2368.7631236876346;2121.257559854039;2161.827053835689;2162.0919213930188;2348.859068455898;2380.285914225734;2176.5646870625937;2188.9452763680874;2352.952940941189;2404.61526155816;2407.3139155340646;8231.711890083818;8363.372747043935;8376;8379.748607541722;8388.664453421856;5080.237964305346;5188.325517682677;5193.195054766517;5206.895862082775;5213.582913366921;3476.4090104682264;3553.4847447120023;3593.4430163324464;3620.1130722972775;3624.673779359844;1037.6108959140322;1042.9374237545771;1050.2700623066971;1074.6023971130653;1080.3247970018738;10986;11117.27737697047;11131.554737810478;11136.387498687569;11158.665240042812;4606.355110284563;4684.180268453007;4686.718796872198;4733.905321893543;4746.28805679144;9740.610375584898;9741.610335586638;9747.951260243653;9750.609975600897;9752;5187.818426355135;5217.243499692523;5219.060569097523;5223.869403264949;5228.424873263938;4742;4747.8575642730775;4750.714957102585;4759.976200118977;4761.785719642625;3620.4388319810473;3718.5537735471917;3732.720045996561;3741.5884252732176;3756.4928734620476;1203.3622180244483;1224.834647322618;1228.0605336917265;1229.0413477487573;1239.535174309634;1363.2502123831853;1391.436468230348;1410.978835317471;1410.9911413339307;1419.9929000354932;7679.308862202429;7843.9215607844335;7846.411519136088;7851.882221766678;7856.7250146244605;490.6148673291449;496.81866118866355;498.36956250343343;503.8589195025399;504.13540777566647;5998.670073146019;6095.207623008981;6135.601185922901;6233.3143354231;6251.593646412968;9449.196818270386;10056.74858128538;10109.696709098738;10168.898311016796;10199.796004079877;9805.901940980642;9962.352447090916;10040.849387259197;10047.748806279902;10181.745456363502;7851.960740196262;7923.683052677944;8004.5597492138495;8010.479318844256;8049.476784009021;6618.90071648916;6745.494087943522;6752.797416077526;7787.377009839086;7834;8673.522956237468;9009.90990090117;9123.224525915106;9161.358704890594;9167.266618670623;8997;9244.491552964651;9301.674441394789;9330.860037099585;9422.528873556432;6396.32838551964;7302.817429564303;7348.559086454829;7387.1135463744695;7409.962950185214;7982.521048736862;8034.076081250497;8043.83912321762;8048.758537243892;8065.112837587743;7368.189499155196;7500.9249907500225;7508.849823003618;7618.200088990798;7642.312191902533;7337.486375953632;7365.52124111931;7380.040594722652;7449.925500744923;7451.739189128354;7534.397248220239;7583.9620801895635;7603.695852165852;7607.12518060408;7623.809404764926;6816.522843401112;6843.3840954314355;6889.896651550131;6895.6552172392185;6900.03399524057;6969.1985421677155;7017.193022802443;7019.122609673791;7029.05107810439;7042.964785176247 12:09:17 INFO - 2015-11-24 12:09:17,662 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.8831232443996;327.5659750830151;328.3236532742549;329.77575248830794;334.6436045611425;6779.728810847572;6792.966035169823;6803.795886123412;6882.793516194522;6888.24229334774;5869.471747542721;6443.29123796382;6770.729170833173;6791.08320376749;6808.4212841908375;4955.925661115086;4981.178105612569;4983.352164218664;4993.650444468889;4998.925016124761;4051;4733.692309999857;4871.025794841028;4928.137575924216;4933.150068724229;4855.902881942377;4867.1482490564185;4867.464578896319;4894.535019173173;4905.337779399771;4618.237990731525;4720.315554244649;4735.337052812609;4871.684645145809;4898.632602554805;4038.676905847525;4053.4527838741687;4053.8783836484954;4066.329055705805;4068.0033391819193;6242.719077641517;6476.708548115346;6615.867682646368;6648.335166483362;6648.900266496006;5810.273715785527;5848.2689663792025;5850.853728656775;5857.297124345063;5864.824055278348;6910.689018994158;7274.418046556316;7277.745278915212;7314.195438501761;7322.121345438528;3873.573906870242;4364.869053928387;4603.746793926332;4611.677182597219;4623;7404.629768511553;7545.735899243555;7549.433792465587;7558.811029724246;7562.810929726746;4710.858674239778;4722.716637001722;4729.881752956204;4735.810567577328;4739.857804265877;4639.628829693616;4778.976105119522;4818.048690280442;4827.131116399082;4831.782569784368;5817.447342502455;5830.154627578977;5839.854003649943;5844;5845.210896528914;7292.708291668274;7306.671199796022;7320.450966177558;7326.3040011198855;7334.266573342729;1366.5968539280937;1606.8232494425604;1666.258514960855;1673.790776152981;1675.6062325353532;1039.95840166394;1055.7941201465794;1064.9414282214398;1070.5450183672065;1073.103958194916;6730.730770769114;6746.696398662072;6771.187457505131;6775.322467753185;6799.524033317719;6213.751449941951;7365.594892280868;7470.477066605394;7496.325330720261;7501.66242519088;6521.054447105238;6737.258901520829;6750.763723269662;6752.561083529555;6769.695363708645;3967.4643923070594;3993.121513267077;3999.1002024544828;4007.499062617173;4033.233685599727;7735.497192682457;7739.651715672809;7740.071191457061;7757.495762775401;7779.611019449118;7376.520526165782;7693.384529237647;7720.266574675396;7738.922610773933;7741.303282704471;7698.653560589787;7725.92274077252;7738.961305193438;7742;7742.92257077422;7222;7398.778036658909;7424.406047516078;7432.554046757212;7443.590602516913;7231.2768723127265;7307.3058059484265;7478.887816682863;7500.399968002655;7502.661315714673;7659.770206893802;7845.960770196112;7870.72452464161;7894.328982036591;7904.2886140245355;3927.469791578215;4652.464966528757;4675.719456832601;4682.719036857799;4692.835750748707;7573.053368328959;7584.4311676625575;7587.734429294948;7589.848203036019;7594.924050759642;7129.536580122275;7266.709331626887;7307.013553170466;7309.5248808827255;7321.560706357635;7302.0142280791415;7306.4885458017425;7310.488265821342;7321.74373896911;7324.707011719472;7118.145822501333;7120.60836653989;7146.606936618536;7148.749793757193;7152.392046676091;7098.503104782822;7280.890786638311;7301.488895777245;7316.414686825147;7337.486375953846;7128.893066604109;7140.9285907140265;7155.141383033861;7166.175889772534;7171 12:09:17 INFO - 2015-11-24 12:09:17,663 DEBUG : BROWSER_OUTPUT: |5;yui.html;743.7657138001529;807.6688557691348;812.9715459958899;825.5211977053308;827.4580150001751;14941.551753447387;15398.461053863117;15416.61458463539;15455.45905893294;15459.30433130509;14314.642133946656;14362.28188590569;14378.477273068087;14385.856141438582;14408.423663053465;760.1448370583093;772.088935056633;773.3697036914897;952.7999120184752;984.3995162950595;724.7861880745193;948.2414068744977;963.7686955130788;968.8740463739739;970.6602689058808;847.9745607631781;1002.844559093338;1015.5785349080123;1015.8882522922472;1016.903394177552;787.7794217619075;1001.3641337750508;1008.5310330696225;1008.7629407089328;1010.934289271195;600.3666132230495;601.362555690969;745.0388998192325;759.7720683794839;760.4980712729572;12883.549075782397;15135.545933622008;15208;15250.466233681767;15282.847171528254;12283.631491055283;12334;12348.691282717915;12833.935830320788;13206.537771177962;9330.626774928995;10134.54394552247;10283.382997020128;10399.32404393712;10453.895461045367;3517.050396392985;3533.522974398449;3534.9469757953652;3538.327717733622;3542.3800834853796;71983.64008179925;72905.27094729038;73632.52734945324;73831.99999999946;82624;9437.103475169848;9468.526573671288;9484.715458536255;9493.905060949302;9518.428894266366;20944.790552094284;21013.159473620883;21083.68374474384;21122.683159752614;21232.150713971267;7103.82240443993;7178.856422871618;7199.964000179965;7218.350348468558;7357.153927298322;3896.532416110085;3961.1483531040963;3966.4446977423186;3973.5231772186944;3977.423273625366;3541.734369922266;3568.1971556399603;3569.3218288525095;3573.8034408107806;3579.1410061585034;633.7401665317198;634.2072409488139;642.325558163926;657.5101549345768;658.9209294884645;478.8268741583135;507.52546369144966;529.1612793721994;552.9889402211933;622.094851990362;7326.816829579303;8149.592520373958;8503.362247831437;8519.95740021296;8656.740297791077;522.5088416888113;546.0716781471435;569.8205065404385;619.2661695890384;629.3297638015499;3832.7891965941585;4055.6755459563165;4153.273177193979;4163.7293575917465;4464.933026004613;73504.63247683727;91072;92679.60980585296;96452;98147;85642;87024;87169.5641521801;87863.24273514622;89170;74795.87806182912;74981;76038.6198069006;77032.84450733132;77617;8872.23486143936;8989.46063236208;9009.54952252398;9050.411723237969;9278.62885484573;53755.731221343645;54206.728966354916;54494.45505544894;54676.17985730138;55458.44541554533;76267.23732762602;78402.6079869597;78581;78598;78624.82062768949;9495.14543691071;10746.516406761559;11136;11171.944140279571;11894.821577676516;11661.183717139718;11981.400929953294;12213.206141600767;12236.694082648006;12444.875551244371;11527.423628818358;11762.23545469576;11828.585999489977;12042.157049006835;12079.27524348542;11491.655250342503;11756.882431175922;11905.702357441134;11911.3448760319;11976.101792365782;11484.770304594029;11637.709057273636;11713.531458741554;11719.472623731783;11892.762144756884;9738.977407372407;9785.559649815918;9844.310898237054;9877.851832222666;9997.600095996078;9902;10062.647807326708;10112.79774404493;10114;10129.544170512492 12:09:17 INFO - 2015-11-24 12:09:17,663 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:09:17 INFO - 2015-11-24 12:09:17,664 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:09:17 INFO - 2015-11-24 12:09:17,664 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1173 12:09:17 INFO - 2015-11-24 12:09:17,664 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:09:17 INFO - 2015-11-24 12:09:17,664 DEBUG : BROWSER_OUTPUT: __startTimestamp1448395757648__endTimestamp 12:09:17 INFO - 2015-11-24 12:09:17,664 DEBUG : BROWSER_OUTPUT: 12:09:17 INFO - 2015-11-24 12:09:17,664 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:09:17 INFO - 2015-11-24 12:09:17,664 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:09:17 INFO - 2015-11-24 12:09:17,664 DEBUG : BROWSER_OUTPUT: 12:09:17 INFO - 2015-11-24 12:09:17,664 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5771.29 Median:6042.70 stddev:614.24 (10.2%) stddev-sans-first:586.81 12:09:17 INFO - 2015-11-24 12:09:17,666 DEBUG : BROWSER_OUTPUT: Values: 3381.0 3420.7 3468.7 3480.4 3509.8 5594.4 5662.5 5742.1 5910.8 5914.1 5753.3 5819.4 5828.7 5830.2 5831.2 5195.0 5226.0 5253.2 5288.8 5308.6 5302.8 5308.2 5311.8 5312.4 5324.6 5289.3 5295.2 5304.4 5305.8 5320.6 5282.1 5288.9 5295.4 5303.8 5305.5 4445.5 5141.3 5162.8 5246.1 5287.6 5700.6 5821.4 5841.9 5870.2 5883.3 6215.2 6217.1 6220.1 6220.5 6253.1 6098.4 6130.9 6186.5 6203.1 6235.2 5982.4 6046.5 6051.4 6075.9 6076.6 5443.4 5865.5 6219.6 6361.4 6368.0 6042.7 6104.1 6125.6 6139.2 6171.3 6239.1 6240.2 6242.3 6243.4 6246.5 6182.6 6227.3 6231.5 6232.3 6242.5 6093.4 6120.8 6159.4 6173.4 6176.1 5024.4 5025.7 5031.2 5033.7 5055.7 4507.5 4514.2 4522.2 4540.3 4544.0 5660.3 5750.4 5804.5 5811.4 5881.3 6203.9 6218.0 6220.0 6223.1 6225.1 5753.9 5790.2 5817.3 5818.2 5823.9 5444.8 5457.7 5468.8 5470.3 5485.5 6219.5 6239.3 6253.1 6287.3 6290.4 6222.9 6225.9 6229.0 6237.4 6246.6 6292.2 6321.2 6326.5 6327.2 6348.6 5280.6 6066.2 6092.0 6140.3 6147.5 6216.4 6221.3 6239.8 6241.9 6244.9 5375.0 6195.4 6198.7 6201.6 6205.6 5974.0 6099.6 6130.8 6140.0 6176.9 6080.6 6099.7 6117.7 6126.1 6131.0 5881.0 5968.1 6184.8 6220.3 6233.4 5883.1 5970.1 5983.5 6017.4 6108.2 12:09:17 INFO - 2015-11-24 12:09:17,666 DEBUG : BROWSER_OUTPUT: 12:09:17 INFO - 2015-11-24 12:09:17,666 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:66696.87 Median:34650.96 stddev:136476.06 (393.9%) stddev-sans-first:136768.49 12:09:17 INFO - 2015-11-24 12:09:17,666 DEBUG : BROWSER_OUTPUT: Values: 529.5 545.8 554.3 637.0 637.5 31702.5 42450.6 42960.6 43086.0 43095.0 44526.0 45055.0 45083.5 45092.8 45119.0 8842.9 8990.8 9836.7 10031.6 10041.9 8802.4 12172.3 12275.2 12283.0 12290.4 12056.0 12164.6 12169.1 12184.3 12223.9 8975.4 9084.3 9125.1 12051.8 12164.7 12111.0 12254.9 12262.4 12280.6 12290.4 41903.0 42321.2 42382.9 42400.4 42494.4 3110.5 3116.1 3125.0 3126.7 3202.8 26751.9 29045.0 29214.6 29244.0 30410.8 2646.0 2838.4 2847.0 2864.3 2875.8 494149.0 494353.0 494638.0 494930.0 495894.5 62436.7 62523.7 63420.4 67910.0 72518.0 70147.0 70711.6 70815.3 70995.6 71070.3 16425.2 16568.8 16585.3 16594.8 16665.8 12496.1 12558.7 12563.4 12570.7 12758.5 17668.2 21015.0 21137.7 21366.9 21391.4 8904.9 9146.8 9153.4 9166.5 9242.6 918.3 935.9 1013.5 1078.8 1169.1 29123.9 29391.4 29479.0 30049.8 30155.4 1065.2 1112.8 1144.7 1162.0 1207.8 15151.8 15612.9 15939.8 16054.6 16168.4 522882.0 528165.0 528483.0 530309.0 531692.0 60735.4 60881.0 60901.7 60978.8 61316.0 1146.8 1284.0 1449.6 1468.5 1611.4 29027.9 30467.2 30923.1 30964.6 31310.5 56200.4 56457.4 56613.2 56647.4 56662.7 447835.0 521224.0 521797.0 536460.0 552670.0 31059.4 31079.0 31425.2 31466.0 31512.4 44093.0 44553.6 44756.8 45265.0 45985.1 38556.8 38747.8 39042.8 39847.0 39979.0 37846.6 38503.4 38661.0 38759.6 38961.0 37276.3 38206.2 38401.0 38427.2 38653.0 31542.8 33294.0 34478.7 34601.1 34700.8 24409.5 24430.5 24578.9 24689.5 24691.3 12:09:17 INFO - 2015-11-24 12:09:17,666 DEBUG : BROWSER_OUTPUT: 12:09:17 INFO - 2015-11-24 12:09:17,666 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39627.98 Median:2343.73 stddev:122197.00 (5213.8%) stddev-sans-first:122504.11 12:09:17 INFO - 2015-11-24 12:09:17,668 DEBUG : BROWSER_OUTPUT: Values: 303.5 356.5 356.7 361.1 364.9 15324.6 16348.6 18970.7 20475.3 21689.8 20761.9 20810.3 21150.4 21193.8 21202.0 6377.6 6560.9 6566.9 6569.2 6569.6 4661.7 4816.9 4939.6 6458.2 7730.5 7146.9 7248.4 7684.9 7691.5 7703.5 7231.5 7248.5 7252.8 7257.3 7259.1 6856.8 7249.8 7252.2 7257.1 7260.5 27351.6 27398.8 27782.7 28158.9 28278.6 2160.3 2233.4 2298.2 2449.1 2456.9 14975.3 15202.5 15822.5 15979.4 16525.1 1805.8 1878.0 1879.7 1886.3 1904.9 109809.4 115544.0 115548.4 116683.8 118249.0 18790.2 18816.7 18847.7 18883.5 18976.9 27921.3 27983.0 28051.0 28060.4 28076.4 8230.9 10051.0 10106.0 10114.3 10130.4 8378.9 8386.0 8415.4 8433.6 8488.4 6928.1 7353.9 8503.8 8617.8 8627.4 1810.2 1820.3 1828.7 1846.1 2389.3 879.4 936.3 953.7 961.9 1016.4 19191.0 19721.0 20146.0 20216.3 20318.4 912.7 942.6 949.4 956.8 1026.3 10453.7 10792.5 10794.0 10816.6 10859.3 647641.0 751558.0 757964.0 770683.0 785000.0 85732.0 105317.0 112088.0 114127.9 117010.4 1104.4 1118.4 1168.8 1193.7 1195.0 17379.2 17570.5 17589.0 17603.4 17693.6 40553.8 48254.0 48788.0 51293.0 52755.0 65328.0 65619.7 65844.0 66285.0 67518.7 9450.9 9813.7 9848.8 9857.2 9870.6 14920.8 19595.2 19691.1 19810.5 20092.4 5161.8 15427.3 15896.8 16109.0 16174.0 14963.5 15709.8 15719.0 15829.6 15848.7 16067.7 16093.8 16127.6 16525.4 16717.7 8280.3 9594.0 9653.9 9727.3 9864.5 15552.7 15646.5 15694.5 16046.9 16179.6 12:09:17 INFO - 2015-11-24 12:09:17,668 DEBUG : BROWSER_OUTPUT: 12:09:17 INFO - 2015-11-24 12:09:17,668 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5797.31 Median:5226.15 stddev:3037.61 (58.1%) stddev-sans-first:3028.72 12:09:17 INFO - 2015-11-24 12:09:17,669 DEBUG : BROWSER_OUTPUT: Values: 1470.4 1541.0 1550.8 1909.2 1924.1 7507.2 7636.4 8179.3 8536.0 8549.6 7348.7 7505.4 8410.6 8471.6 8479.6 2127.9 2183.2 2364.3 2377.5 2380.1 1757.5 2373.0 2391.8 2395.1 2395.2 2294.7 2325.4 2344.5 2348.4 2368.8 2121.3 2161.8 2162.1 2348.9 2380.3 2176.6 2188.9 2353.0 2404.6 2407.3 8231.7 8363.4 8376.0 8379.7 8388.7 5080.2 5188.3 5193.2 5206.9 5213.6 3476.4 3553.5 3593.4 3620.1 3624.7 1037.6 1042.9 1050.3 1074.6 1080.3 10986.0 11117.3 11131.6 11136.4 11158.7 4606.4 4684.2 4686.7 4733.9 4746.3 9740.6 9741.6 9748.0 9750.6 9752.0 5187.8 5217.2 5219.1 5223.9 5228.4 4742.0 4747.9 4750.7 4760.0 4761.8 3620.4 3718.6 3732.7 3741.6 3756.5 1203.4 1224.8 1228.1 1229.0 1239.5 1363.3 1391.4 1411.0 1411.0 1420.0 7679.3 7843.9 7846.4 7851.9 7856.7 490.6 496.8 498.4 503.9 504.1 5998.7 6095.2 6135.6 6233.3 6251.6 9449.2 10056.7 10109.7 10168.9 10199.8 9805.9 9962.4 10040.8 10047.7 10181.7 7852.0 7923.7 8004.6 8010.5 8049.5 6618.9 6745.5 6752.8 7787.4 7834.0 8673.5 9009.9 9123.2 9161.4 9167.3 8997.0 9244.5 9301.7 9330.9 9422.5 6396.3 7302.8 7348.6 7387.1 7410.0 7982.5 8034.1 8043.8 8048.8 8065.1 7368.2 7500.9 7508.8 7618.2 7642.3 7337.5 7365.5 7380.0 7449.9 7451.7 7534.4 7584.0 7603.7 7607.1 7623.8 6816.5 6843.4 6889.9 6895.7 6900.0 6969.2 7017.2 7019.1 7029.1 7043.0 12:09:17 INFO - 2015-11-24 12:09:17,670 DEBUG : BROWSER_OUTPUT: 12:09:17 INFO - 2015-11-24 12:09:17,670 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5906.08 Median:6770.96 stddev:1927.68 (28.5%) stddev-sans-first:1886.87 12:09:17 INFO - 2015-11-24 12:09:17,671 DEBUG : BROWSER_OUTPUT: Values: 315.9 327.6 328.3 329.8 334.6 6779.7 6793.0 6803.8 6882.8 6888.2 5869.5 6443.3 6770.7 6791.1 6808.4 4955.9 4981.2 4983.4 4993.7 4998.9 4051.0 4733.7 4871.0 4928.1 4933.2 4855.9 4867.1 4867.5 4894.5 4905.3 4618.2 4720.3 4735.3 4871.7 4898.6 4038.7 4053.5 4053.9 4066.3 4068.0 6242.7 6476.7 6615.9 6648.3 6648.9 5810.3 5848.3 5850.9 5857.3 5864.8 6910.7 7274.4 7277.7 7314.2 7322.1 3873.6 4364.9 4603.7 4611.7 4623.0 7404.6 7545.7 7549.4 7558.8 7562.8 4710.9 4722.7 4729.9 4735.8 4739.9 4639.6 4779.0 4818.0 4827.1 4831.8 5817.4 5830.2 5839.9 5844.0 5845.2 7292.7 7306.7 7320.5 7326.3 7334.3 1366.6 1606.8 1666.3 1673.8 1675.6 1040.0 1055.8 1064.9 1070.5 1073.1 6730.7 6746.7 6771.2 6775.3 6799.5 6213.8 7365.6 7470.5 7496.3 7501.7 6521.1 6737.3 6750.8 6752.6 6769.7 3967.5 3993.1 3999.1 4007.5 4033.2 7735.5 7739.7 7740.1 7757.5 7779.6 7376.5 7693.4 7720.3 7738.9 7741.3 7698.7 7725.9 7739.0 7742.0 7742.9 7222.0 7398.8 7424.4 7432.6 7443.6 7231.3 7307.3 7478.9 7500.4 7502.7 7659.8 7846.0 7870.7 7894.3 7904.3 3927.5 4652.5 4675.7 4682.7 4692.8 7573.1 7584.4 7587.7 7589.8 7594.9 7129.5 7266.7 7307.0 7309.5 7321.6 7302.0 7306.5 7310.5 7321.7 7324.7 7118.1 7120.6 7146.6 7148.7 7152.4 7098.5 7280.9 7301.5 7316.4 7337.5 7128.9 7140.9 7155.1 7166.2 7171.0 12:09:17 INFO - 2015-11-24 12:09:17,671 DEBUG : BROWSER_OUTPUT: 12:09:17 INFO - 2015-11-24 12:09:17,671 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19002.12 Median:54350.59 stddev:26941.87 (49.6%) stddev-sans-first:26982.56 12:09:17 INFO - 2015-11-24 12:09:17,672 DEBUG : BROWSER_OUTPUT: Values: 743.8 807.7 813.0 825.5 827.5 14941.6 15398.5 15416.6 15455.5 15459.3 14314.6 14362.3 14378.5 14385.9 14408.4 760.1 772.1 773.4 952.8 984.4 724.8 948.2 963.8 968.9 970.7 848.0 1002.8 1015.6 1015.9 1016.9 787.8 1001.4 1008.5 1008.8 1010.9 600.4 601.4 745.0 759.8 760.5 12883.5 15135.5 15208.0 15250.5 15282.8 12283.6 12334.0 12348.7 12833.9 13206.5 9330.6 10134.5 10283.4 10399.3 10453.9 3517.1 3533.5 3534.9 3538.3 3542.4 71983.6 72905.3 73632.5 73832.0 82624.0 9437.1 9468.5 9484.7 9493.9 9518.4 20944.8 21013.2 21083.7 21122.7 21232.2 7103.8 7178.9 7200.0 7218.4 7357.2 3896.5 3961.1 3966.4 3973.5 3977.4 3541.7 3568.2 3569.3 3573.8 3579.1 633.7 634.2 642.3 657.5 658.9 478.8 507.5 529.2 553.0 622.1 7326.8 8149.6 8503.4 8520.0 8656.7 522.5 546.1 569.8 619.3 629.3 3832.8 4055.7 4153.3 4163.7 4464.9 73504.6 91072.0 92679.6 96452.0 98147.0 85642.0 87024.0 87169.6 87863.2 89170.0 74795.9 74981.0 76038.6 77032.8 77617.0 8872.2 8989.5 9009.5 9050.4 9278.6 53755.7 54206.7 54494.5 54676.2 55458.4 76267.2 78402.6 78581.0 78598.0 78624.8 9495.1 10746.5 11136.0 11171.9 11894.8 11661.2 11981.4 12213.2 12236.7 12444.9 11527.4 11762.2 11828.6 12042.2 12079.3 11491.7 11756.9 11905.7 11911.3 11976.1 11484.8 11637.7 11713.5 11719.5 11892.8 9739.0 9785.6 9844.3 9877.9 9997.6 9902.0 10062.6 10112.8 10114.0 10129.5 12:09:17 INFO - 2015-11-24 12:09:17,672 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:09:17 INFO - 2015-11-24 12:09:17,673 DEBUG : BROWSER_OUTPUT: 12:09:18 INFO - 2015-11-24 12:09:18,102 INFO : Browser exited with error code: 0 12:09:18 INFO - 2015-11-24 12:09:18,124 INFO : Completed test dromaeo_css (00:18:34) 12:09:18 INFO - 2015-11-24 12:09:18,124 INFO : Starting test kraken 12:09:18 INFO - 2015-11-24 12:09:18,124 DEBUG : operating with platform_type : mac_ 12:09:18 INFO - 2015-11-24 12:09:18,124 INFO : Initialising browser for kraken test... 12:09:18 INFO - 2015-11-24 12:09:18,135 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpksmNX3/profile http://localhost:50109/getInfo.html 12:09:19 INFO - 2015-11-24 12:09:19,976 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:09:19 INFO - 2015-11-24 12:09:19,976 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:09:19 INFO - 2015-11-24 12:09:19,976 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:09:19 INFO - 2015-11-24 12:09:19,976 DEBUG : BROWSER_OUTPUT: __metrics 12:09:19 INFO - 2015-11-24 12:09:19,993 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:09:20 INFO - 2015-11-24 12:09:20,629 INFO : Browser initialized. 12:09:20 INFO - 2015-11-24 12:09:20,629 INFO : Running cycle 1/1 for kraken test... 12:09:20 INFO - 2015-11-24 12:09:20,629 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpksmNX3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:09:32 INFO - 2015-11-24 12:09:32,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 225394688 12:09:32 INFO - 2015-11-24 12:09:32,419 DEBUG : BROWSER_OUTPUT: 12:09:34 INFO - 2015-11-24 12:09:34,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50109/tests/kraken/driver.html?testName=audio-beat-detection) 12:09:35 INFO - 2015-11-24 12:09:35,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 276504576 12:09:35 INFO - 2015-11-24 12:09:35,546 DEBUG : BROWSER_OUTPUT: 12:09:38 INFO - 2015-11-24 12:09:38,099 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50109/tests/kraken/driver.html?testName=audio-dft) 12:09:38 INFO - 2015-11-24 12:09:38,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 291205120 12:09:38 INFO - 2015-11-24 12:09:38,690 DEBUG : BROWSER_OUTPUT: 12:09:41 INFO - 2015-11-24 12:09:41,907 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50109/tests/kraken/driver.html?testName=audio-fft) 12:09:42 INFO - 2015-11-24 12:09:42,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 277372928 12:09:42 INFO - 2015-11-24 12:09:42,492 DEBUG : BROWSER_OUTPUT: 12:09:44 INFO - 2015-11-24 12:09:44,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50109/tests/kraken/driver.html?testName=audio-oscillator) 12:09:44 INFO - 2015-11-24 12:09:44,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 278118400 12:09:44 INFO - 2015-11-24 12:09:44,911 DEBUG : BROWSER_OUTPUT: 12:09:46 INFO - 2015-11-24 12:09:46,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50109/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:09:47 INFO - 2015-11-24 12:09:47,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 280297472 12:09:47 INFO - 2015-11-24 12:09:47,493 DEBUG : BROWSER_OUTPUT: 12:09:50 INFO - 2015-11-24 12:09:50,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50109/tests/kraken/driver.html?testName=imaging-darkroom) 12:09:50 INFO - 2015-11-24 12:09:50,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 282136576 12:09:50 INFO - 2015-11-24 12:09:50,884 DEBUG : BROWSER_OUTPUT: 12:09:53 INFO - 2015-11-24 12:09:53,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50109/tests/kraken/driver.html?testName=imaging-desaturate) 12:09:54 INFO - 2015-11-24 12:09:54,245 DEBUG : BROWSER_OUTPUT: RSS: Main: 282181632 12:09:54 INFO - 2015-11-24 12:09:54,245 DEBUG : BROWSER_OUTPUT: 12:09:56 INFO - 2015-11-24 12:09:56,946 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50109/tests/kraken/driver.html?testName=json-parse-financial) 12:09:57 INFO - 2015-11-24 12:09:57,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 280862720 12:09:57 INFO - 2015-11-24 12:09:57,547 DEBUG : BROWSER_OUTPUT: 12:09:59 INFO - 2015-11-24 12:09:59,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50109/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:09:59 INFO - 2015-11-24 12:09:59,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 312680448 12:09:59 INFO - 2015-11-24 12:09:59,624 DEBUG : BROWSER_OUTPUT: 12:10:01 INFO - 2015-11-24 12:10:01,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50109/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:10:02 INFO - 2015-11-24 12:10:02,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 314384384 12:10:02 INFO - 2015-11-24 12:10:02,024 DEBUG : BROWSER_OUTPUT: 12:10:04 INFO - 2015-11-24 12:10:04,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50109/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:10:04 INFO - 2015-11-24 12:10:04,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 322285568 12:10:04 INFO - 2015-11-24 12:10:04,663 DEBUG : BROWSER_OUTPUT: 12:10:07 INFO - 2015-11-24 12:10:07,180 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50109/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:10:07 INFO - 2015-11-24 12:10:07,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 324870144 12:10:07 INFO - 2015-11-24 12:10:07,779 DEBUG : BROWSER_OUTPUT: 12:10:10 INFO - 2015-11-24 12:10:10,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50109/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:10:10 INFO - 2015-11-24 12:10:10,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 323809280 12:10:10 INFO - 2015-11-24 12:10:10,745 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,472 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50109/tests/kraken/driver.html?testName=ai-astar) 12:10:12 INFO - 2015-11-24 12:10:12,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 382418944 12:10:12 INFO - 2015-11-24 12:10:12,730 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,730 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:10:12 INFO - 2015-11-24 12:10:12,731 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:10:12 INFO - 2015-11-24 12:10:12,731 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:10:12 INFO - 2015-11-24 12:10:12,731 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:10:12 INFO - 2015-11-24 12:10:12,731 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;111;103;111;110;111;110;109;103;109 12:10:12 INFO - 2015-11-24 12:10:12,731 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;123;149;157;119;143;143;116;155;118 12:10:12 INFO - 2015-11-24 12:10:12,731 DEBUG : BROWSER_OUTPUT: |2;audio-dft;184;184;181;184;187;186;184;183;186;181 12:10:12 INFO - 2015-11-24 12:10:12,731 DEBUG : BROWSER_OUTPUT: |3;audio-fft;67;67;76;73;54;56;58;69;69;55 12:10:12 INFO - 2015-11-24 12:10:12,731 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;84;86;117;75;74;76;113;77;73;111 12:10:12 INFO - 2015-11-24 12:10:12,731 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;85;85;85;89;130;125;85;85;86;87 12:10:12 INFO - 2015-11-24 12:10:12,732 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;93;94;94;94;93;94;94;94;94;92 12:10:12 INFO - 2015-11-24 12:10:12,732 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;90;88;89;88;88;90;88;90;92;85 12:10:12 INFO - 2015-11-24 12:10:12,732 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;55;54;53;54;53;54;62;52;52 12:10:12 INFO - 2015-11-24 12:10:12,732 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;62;62;65;62;67;68;67;67;66 12:10:12 INFO - 2015-11-24 12:10:12,732 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;83;81;83;83;82;82;83;85;81 12:10:12 INFO - 2015-11-24 12:10:12,732 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;131;123;126;120;120;132;120;120;128 12:10:12 INFO - 2015-11-24 12:10:12,732 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;131;124;133;134;133;122;135;131;133;133 12:10:12 INFO - 2015-11-24 12:10:12,732 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;64;63;64;63;64;65;78;86;86 12:10:12 INFO - 2015-11-24 12:10:12,732 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:10:12 INFO - 2015-11-24 12:10:12,732 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:10:12 INFO - 2015-11-24 12:10:12,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1023 12:10:12 INFO - 2015-11-24 12:10:12,732 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:10:12 INFO - 2015-11-24 12:10:12,732 DEBUG : BROWSER_OUTPUT: __startTimestamp1448395812726__endTimestamp 12:10:12 INFO - 2015-11-24 12:10:12,733 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,733 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:10:12 INFO - 2015-11-24 12:10:12,733 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:10:12 INFO - 2015-11-24 12:10:12,733 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,733 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.80 Median:110.50 stddev:3.16 (2.9%) stddev-sans-first:3.24 12:10:12 INFO - 2015-11-24 12:10:12,733 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 103.0 111.0 110.0 111.0 110.0 109.0 103.0 109.0 12:10:12 INFO - 2015-11-24 12:10:12,733 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,733 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:137.30 Median:146.00 stddev:16.43 (11.3%) stddev-sans-first:16.77 12:10:12 INFO - 2015-11-24 12:10:12,733 DEBUG : BROWSER_OUTPUT: Values: 150.0 123.0 149.0 157.0 119.0 143.0 143.0 116.0 155.0 118.0 12:10:12 INFO - 2015-11-24 12:10:12,733 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,733 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:2.00 (1.1%) stddev-sans-first:2.12 12:10:12 INFO - 2015-11-24 12:10:12,733 DEBUG : BROWSER_OUTPUT: Values: 184.0 184.0 181.0 184.0 187.0 186.0 184.0 183.0 186.0 181.0 12:10:12 INFO - 2015-11-24 12:10:12,733 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,734 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:64.40 Median:68.00 stddev:7.97 (11.7%) stddev-sans-first:8.40 12:10:12 INFO - 2015-11-24 12:10:12,734 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 76.0 73.0 54.0 56.0 58.0 69.0 69.0 55.0 12:10:12 INFO - 2015-11-24 12:10:12,734 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,734 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.60 Median:75.50 stddev:17.85 (23.6%) stddev-sans-first:18.85 12:10:12 INFO - 2015-11-24 12:10:12,734 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 117.0 75.0 74.0 76.0 113.0 77.0 73.0 111.0 12:10:12 INFO - 2015-11-24 12:10:12,734 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,734 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:94.20 Median:85.00 stddev:17.64 (20.7%) stddev-sans-first:18.39 12:10:12 INFO - 2015-11-24 12:10:12,734 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 85.0 89.0 130.0 125.0 85.0 85.0 86.0 87.0 12:10:12 INFO - 2015-11-24 12:10:12,734 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,734 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:93.60 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 12:10:12 INFO - 2015-11-24 12:10:12,734 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 92.0 12:10:12 INFO - 2015-11-24 12:10:12,734 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,734 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:88.80 Median:89.50 stddev:1.87 (2.1%) stddev-sans-first:1.94 12:10:12 INFO - 2015-11-24 12:10:12,734 DEBUG : BROWSER_OUTPUT: Values: 90.0 88.0 89.0 88.0 88.0 90.0 88.0 90.0 92.0 85.0 12:10:12 INFO - 2015-11-24 12:10:12,735 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,736 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:2.92 (5.4%) stddev-sans-first:3.04 12:10:12 INFO - 2015-11-24 12:10:12,736 DEBUG : BROWSER_OUTPUT: Values: 56.0 55.0 54.0 53.0 54.0 53.0 54.0 62.0 52.0 52.0 12:10:12 INFO - 2015-11-24 12:10:12,736 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,736 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:66.50 stddev:2.53 (3.8%) stddev-sans-first:2.47 12:10:12 INFO - 2015-11-24 12:10:12,736 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 62.0 65.0 62.0 67.0 68.0 67.0 67.0 66.0 12:10:12 INFO - 2015-11-24 12:10:12,736 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,736 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:1.26 (1.5%) stddev-sans-first:1.24 12:10:12 INFO - 2015-11-24 12:10:12,736 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 81.0 83.0 83.0 82.0 82.0 83.0 85.0 81.0 12:10:12 INFO - 2015-11-24 12:10:12,736 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,736 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:124.50 stddev:4.69 (3.8%) stddev-sans-first:4.95 12:10:12 INFO - 2015-11-24 12:10:12,736 DEBUG : BROWSER_OUTPUT: Values: 123.0 131.0 123.0 126.0 120.0 120.0 132.0 120.0 120.0 128.0 12:10:12 INFO - 2015-11-24 12:10:12,736 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,737 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:130.90 Median:133.00 stddev:4.36 (3.3%) stddev-sans-first:4.62 12:10:12 INFO - 2015-11-24 12:10:12,737 DEBUG : BROWSER_OUTPUT: Values: 131.0 124.0 133.0 134.0 133.0 122.0 135.0 131.0 133.0 133.0 12:10:12 INFO - 2015-11-24 12:10:12,737 DEBUG : BROWSER_OUTPUT: 12:10:12 INFO - 2015-11-24 12:10:12,737 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:64.50 stddev:9.67 (15.0%) stddev-sans-first:10.04 12:10:12 INFO - 2015-11-24 12:10:12,737 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 63.0 64.0 63.0 64.0 65.0 78.0 86.0 86.0 12:10:12 INFO - 2015-11-24 12:10:12,737 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:10:12 INFO - 2015-11-24 12:10:12,737 DEBUG : BROWSER_OUTPUT: 12:10:13 INFO - 2015-11-24 12:10:13,460 INFO : Browser exited with error code: 0 12:10:13 INFO - 2015-11-24 12:10:13,508 INFO : Completed test kraken (00:00:55) 12:10:13 INFO - 2015-11-24 12:10:13,508 INFO : Starting test v8_7 12:10:13 INFO - 2015-11-24 12:10:13,508 DEBUG : operating with platform_type : mac_ 12:10:13 INFO - 2015-11-24 12:10:13,508 INFO : Initialising browser for v8_7 test... 12:10:13 INFO - 2015-11-24 12:10:13,521 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpgL7bBS/profile http://localhost:50109/getInfo.html 12:10:15 INFO - 2015-11-24 12:10:15,400 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:10:15 INFO - 2015-11-24 12:10:15,401 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:10:15 INFO - 2015-11-24 12:10:15,401 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:10:15 INFO - 2015-11-24 12:10:15,401 DEBUG : BROWSER_OUTPUT: __metrics 12:10:15 INFO - 2015-11-24 12:10:15,417 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:10:16 INFO - 2015-11-24 12:10:16,030 INFO : Browser initialized. 12:10:16 INFO - 2015-11-24 12:10:16,031 INFO : Running cycle 1/1 for v8_7 test... 12:10:16 INFO - 2015-11-24 12:10:16,031 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpgL7bBS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:10:27 INFO - 2015-11-24 12:10:27,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 225255424 12:10:27 INFO - 2015-11-24 12:10:27,919 DEBUG : BROWSER_OUTPUT: 12:10:49 INFO - 2015-11-24 12:10:49,360 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50109/tests/v8_7/run.html (next: http://localhost:50109/tests/v8_7/run.html) 12:10:49 INFO - 2015-11-24 12:10:49,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 581275648 12:10:49 INFO - 2015-11-24 12:10:49,619 DEBUG : BROWSER_OUTPUT: 12:10:49 INFO - 2015-11-24 12:10:49,619 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:10:49 INFO - 2015-11-24 12:10:49,619 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:10:49 INFO - 2015-11-24 12:10:49,620 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:10:49 INFO - 2015-11-24 12:10:49,620 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:10:49 INFO - 2015-11-24 12:10:49,620 DEBUG : BROWSER_OUTPUT: |0;Richards;173.79214459506431 12:10:49 INFO - 2015-11-24 12:10:49,620 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;160.56518946692358 12:10:49 INFO - 2015-11-24 12:10:49,620 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.70680044593087 12:10:49 INFO - 2015-11-24 12:10:49,620 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4716.981132075472 12:10:49 INFO - 2015-11-24 12:10:49,620 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1708.1911262798635 12:10:49 INFO - 2015-11-24 12:10:49,620 DEBUG : BROWSER_OUTPUT: |5;Earley;792.3930269413629 12:10:49 INFO - 2015-11-24 12:10:49,620 DEBUG : BROWSER_OUTPUT: |6;Boyer;12746.835443037975 12:10:49 INFO - 2015-11-24 12:10:49,620 DEBUG : BROWSER_OUTPUT: |7;RegExp;27833.333333333332 12:10:49 INFO - 2015-11-24 12:10:49,620 DEBUG : BROWSER_OUTPUT: |8;Splay;700.9803921568628 12:10:49 INFO - 2015-11-24 12:10:49,620 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4497.757847533632 12:10:49 INFO - 2015-11-24 12:10:49,620 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:10:49 INFO - 2015-11-24 12:10:49,620 DEBUG : BROWSER_OUTPUT: __startTimestamp1448395849613__endTimestamp 12:10:49 INFO - 2015-11-24 12:10:49,620 DEBUG : BROWSER_OUTPUT: 12:10:49 INFO - 2015-11-24 12:10:49,621 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:10:49 INFO - 2015-11-24 12:10:49,621 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:10:49 INFO - 2015-11-24 12:10:49,621 DEBUG : BROWSER_OUTPUT: 12:10:49 INFO - 2015-11-24 12:10:49,621 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:173.79 Median:173.79 stddev:0.00 (0.0%) 12:10:49 INFO - 2015-11-24 12:10:49,621 DEBUG : BROWSER_OUTPUT: Values: 173.8 12:10:49 INFO - 2015-11-24 12:10:49,621 DEBUG : BROWSER_OUTPUT: 12:10:49 INFO - 2015-11-24 12:10:49,621 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:160.57 Median:160.57 stddev:0.00 (0.0%) 12:10:49 INFO - 2015-11-24 12:10:49,621 DEBUG : BROWSER_OUTPUT: Values: 160.6 12:10:49 INFO - 2015-11-24 12:10:49,621 DEBUG : BROWSER_OUTPUT: 12:10:49 INFO - 2015-11-24 12:10:49,621 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%) 12:10:49 INFO - 2015-11-24 12:10:49,621 DEBUG : BROWSER_OUTPUT: Values: 278.7 12:10:49 INFO - 2015-11-24 12:10:49,621 DEBUG : BROWSER_OUTPUT: 12:10:49 INFO - 2015-11-24 12:10:49,621 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4716.98 Median:4716.98 stddev:0.00 (0.0%) 12:10:49 INFO - 2015-11-24 12:10:49,621 DEBUG : BROWSER_OUTPUT: Values: 4717.0 12:10:49 INFO - 2015-11-24 12:10:49,621 DEBUG : BROWSER_OUTPUT: 12:10:49 INFO - 2015-11-24 12:10:49,622 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1708.19 Median:1708.19 stddev:0.00 (0.0%) 12:10:49 INFO - 2015-11-24 12:10:49,622 DEBUG : BROWSER_OUTPUT: Values: 1708.2 12:10:49 INFO - 2015-11-24 12:10:49,622 DEBUG : BROWSER_OUTPUT: 12:10:49 INFO - 2015-11-24 12:10:49,622 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 12:10:49 INFO - 2015-11-24 12:10:49,622 DEBUG : BROWSER_OUTPUT: Values: 792.4 12:10:49 INFO - 2015-11-24 12:10:49,622 DEBUG : BROWSER_OUTPUT: 12:10:49 INFO - 2015-11-24 12:10:49,622 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12746.84 Median:12746.84 stddev:0.00 (0.0%) 12:10:49 INFO - 2015-11-24 12:10:49,622 DEBUG : BROWSER_OUTPUT: Values: 12746.8 12:10:49 INFO - 2015-11-24 12:10:49,622 DEBUG : BROWSER_OUTPUT: 12:10:49 INFO - 2015-11-24 12:10:49,622 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27833.33 Median:27833.33 stddev:0.00 (0.0%) 12:10:49 INFO - 2015-11-24 12:10:49,622 DEBUG : BROWSER_OUTPUT: Values: 27833.3 12:10:49 INFO - 2015-11-24 12:10:49,622 DEBUG : BROWSER_OUTPUT: 12:10:49 INFO - 2015-11-24 12:10:49,622 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:700.98 Median:700.98 stddev:0.00 (0.0%) 12:10:49 INFO - 2015-11-24 12:10:49,622 DEBUG : BROWSER_OUTPUT: Values: 701.0 12:10:49 INFO - 2015-11-24 12:10:49,622 DEBUG : BROWSER_OUTPUT: 12:10:49 INFO - 2015-11-24 12:10:49,623 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4497.76 Median:4497.76 stddev:0.00 (0.0%) 12:10:49 INFO - 2015-11-24 12:10:49,623 DEBUG : BROWSER_OUTPUT: Values: 4497.8 12:10:49 INFO - 2015-11-24 12:10:49,623 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:10:49 INFO - 2015-11-24 12:10:49,623 DEBUG : BROWSER_OUTPUT: 12:10:50 INFO - 2015-11-24 12:10:50,376 INFO : Browser exited with error code: 0 12:10:50 INFO - 2015-11-24 12:10:50,394 INFO : Completed test v8_7 (00:00:36) 12:10:50 INFO - 2015-11-24 12:10:50,709 INFO : Completed test suite (00:20:07) 12:10:50 INFO - 2015-11-24 12:10:50,709 DEBUG : Working with test: dromaeo_css 12:10:50 INFO - 2015-11-24 12:10:50,709 DEBUG : Generating results file: dromaeo_css 12:10:50 INFO - 2015-11-24 12:10:50,710 DEBUG : Working with test: kraken 12:10:50 INFO - 2015-11-24 12:10:50,710 DEBUG : Generating results file: kraken 12:10:50 INFO - 2015-11-24 12:10:50,710 INFO : javascript benchmark 12:10:50 INFO - 2015-11-24 12:10:50,710 DEBUG : Working with test: v8_7 12:10:50 INFO - 2015-11-24 12:10:50,710 DEBUG : Generating results file: v8_7 12:10:50 INFO - 2015-11-24 12:10:50,711 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:10:51 INFO - 2015-11-24 12:10:51,105 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 12:10:51 INFO - 2015-11-24 12:10:51,106 DEBUG : process_Request line: dromaeo_css 7797.20 graph.html#tests=[[72,64,59]] 12:10:51 INFO - 2015-11-24 12:10:51,106 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:10:51 INFO - 2015-11-24 12:10:51,132 DEBUG : process_Request line: kraken 1386.30 graph.html#tests=[[232,64,59]] 12:10:51 INFO - 2015-11-24 12:10:51,132 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:10:51 INFO - 2015-11-24 12:10:51,251 DEBUG : process_Request line: v8_7 20185.16 graph.html#tests=[[230,64,59]] 12:10:51 INFO - 2015-11-24 12:10:51,252 INFO : javascript benchmark 12:10:51 INFO - 2015-11-24 12:10:51,254 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3381.0, 3420.7434442416825, 3468.67047630475, 3480.3735327641016, 3509.789412635242, 5594.356648985368, 5662.546996240301, 5742.138679198122, 5910.793122240722, 5914.053751399782, 5753.252077229965, 5819.418058194189, 5828.650280983134, 5830.183774271605, 5831.212786273863, 5195.03891780021, 5226.033183860979, 5253.159494480884, 5288.814891478799, 5308.575313974873, 5302.840914772543, 5308.150695888658, 5311.840644780663, 5312.442193569677, 5324.600654950875, 5289.312389389374, 5295.152775555912, 5304.3634763828395, 5305.840824775263, 5320.6275560710765, 5282.128448805943, 5288.867778305535, 5295.391030031557, 5303.761330740126, 5305.495977882114, 4445.51099379068, 5141.305923700327, 5162.845114646567, 5246.081935661244, 5287.576993840484, 5700.600957932905, 5821.417858214187, 5841.941580584183, 5870.178175055496, 5883.294004719418, 6215.1609532712955, 6217.067439884008, 6220.098085777537, 6220.533459990519, 6253.1245625612455, 6098.3701427309925, 6130.917941863022, 6186.474149697281, 6203.069539569101, 6235.158253635792, 5982.392460437646, 6046.486048685823, 6051.425114614105, 6075.939240607538, 6076.605020673642, 5443.374011988592, 5865.472107510259, 6219.626822390671, 6361.363863613602, 6368.0, 6042.6978651067275, 6104.053871649812, 6125.551374386395, 6139.2325959255095, 6171.321154672983, 6239.06414037898, 6240.157578726814, 6242.313345531988, 6243.43809057178, 6246.500279977591, 6182.598131121463, 6227.346128656516, 6231.501479881598, 6232.345603711636, 6242.500599951993, 6093.421124993119, 6120.843333897677, 6159.414855588712, 6173.41352571505, 6176.135341052256, 5024.397072351341, 5025.748712564357, 5031.195008798574, 5033.672811267256, 5055.721935293521, 4507.459104907432, 4514.164879497303, 4522.163399771053, 4540.273556230987, 4543.954560454353, 5660.320761508646, 5750.367459579443, 5804.535637149018, 5811.360750317462, 5881.264841894763, 6203.906941395882, 6218.005119181, 6219.968900155471, 6223.066540019034, 6225.066240064027, 5753.942460575341, 5790.160426738099, 5817.3019237690905, 5818.21454103699, 5823.88352232953, 5444.8366549003595, 5457.672539647634, 5468.808591699271, 5470.343558772893, 5485.533729633026, 6219.47134493564, 6239.282482514569, 6253.062040693932, 6287.2769631492965, 6290.370962903765, 6222.875542489034, 6225.937740622536, 6228.968855155696, 6237.438630523275, 6246.593971391845, 6292.2134733158355, 6321.1782468278825, 6326.4622507087415, 6327.209098862642, 6348.555601107878, 5280.603954703336, 6066.241719785027, 6091.974537450126, 6140.320203811546, 6147.477464415396, 6216.378362163748, 6221.3156552778255, 6239.812805615838, 6241.875162496815, 6244.875102497834, 5375.0, 6195.411435913581, 6198.659073750807, 6201.565890387629, 6205.596636218631, 5974.0, 6099.634021958696, 6130.816075517741, 6140.0, 6176.876462470816, 6080.5824274458255, 6099.695015249308, 6117.724702388314, 6126.129726867241, 6131.019036954244, 5880.970595146997, 5968.104784282393, 6184.828464538675, 6220.346863579259, 6233.438990490878, 5883.0881213411985, 5970.134330522137, 5983.461488465885, 6017.368176341596, 6108.17539632144], "unit": "ms", "name": "dojo.html", "value": 5734.037019380976}, {"lowerIsBetter": false, "replicates": [529.4705294705295, 545.8471627944177, 554.3486403475915, 637.0317117980672, 637.4549759955238, 31702.524462133057, 42450.57549424505, 42960.570394296046, 43086.0, 43094.99999999996, 44526.0, 45054.99999999992, 45083.549164508346, 45092.774536127275, 45119.0, 8842.867356989651, 8990.820183596325, 9836.655717049905, 10031.59873605055, 10041.899581004169, 8802.383833131684, 12172.330521821295, 12275.202111862745, 12283.01735861129, 12290.385480725972, 12055.975242104432, 12164.635060948185, 12169.14815962883, 12184.268943863352, 12223.877761222408, 8975.371723979324, 9084.2732581394, 9125.087491250888, 12051.819222711667, 12164.695882602917, 12111.0, 12254.877451225462, 12262.386880655931, 12280.631581052494, 12290.446929888176, 41903.0, 42321.1535769286, 42382.94042648927, 42400.36399454011, 42494.362584561255, 3110.5178697301726, 3116.1430606583144, 3125.0, 3126.656067832537, 3202.823844688541, 26751.866240668867, 29045.0, 29214.561781573295, 29244.0, 30410.84794576035, 2646.020972240264, 2838.3613686920485, 2847.0, 2864.3125649844096, 2875.7699384049224, 494149.0, 494353.0, 494637.9999999964, 494930.0, 495894.52052739507, 62436.687816560625, 62523.6873815628, 63420.365796341444, 67910.0, 72518.0, 70147.0, 70711.64644176746, 70815.2918470819, 70995.64502177456, 71070.28929710637, 16425.1787410629, 16568.75146872798, 16585.25366358517, 16594.83405165957, 16665.750013749803, 12496.062795290389, 12558.68603284907, 12563.371831408393, 12570.748585028432, 12758.48966041348, 17668.204930778145, 21015.0, 21137.67485576616, 21366.89316553407, 21391.358259252247, 8904.8664270036, 9146.771330716652, 9153.35926485153, 9166.450012999241, 9242.630294788134, 918.3158546882615, 935.9064093590587, 1013.4983183324301, 1078.8381742738495, 1169.128998895828, 29123.85438072796, 29391.412171756874, 29479.0, 30049.849750751542, 30155.396892062035, 1065.2223876569992, 1112.8330750387345, 1144.6966553863233, 1161.9593314233962, 1207.758448310324, 15151.772723409158, 15612.92193539025, 15939.760903586455, 16054.598635034217, 16168.434104806276, 522882.0, 528165.0, 528483.0, 530309.0, 531692.0, 60735.39264607297, 60881.0, 60901.69549152226, 60978.78042439126, 61316.0, 1146.810776221914, 1284.036972270797, 1449.5723761490597, 1468.4713503138862, 1611.4198888400167, 29027.85486072556, 30467.238319041313, 30923.0723078308, 30964.60659270293, 31310.530342044432, 56200.43799561952, 56457.43542564522, 56613.15080273717, 56647.43352566587, 56662.7166864163, 447835.0, 521224.0, 521797.0, 536460.0, 552670.0, 31059.447027648977, 31079.0, 31425.21436964094, 31466.0, 31512.36975260528, 44093.0, 44553.55446445494, 44756.77621611871, 45265.0, 45985.08029839318, 38556.80721596374, 38747.806260968515, 39042.80478597589, 39847.0, 39979.0, 37846.62153378431, 38503.422448662735, 38661.0, 38759.64341248043, 38961.0, 37276.25447491089, 38206.235875282895, 38401.03997400087, 38427.23145537129, 38653.033674158374, 31542.842285789342, 33294.0, 34478.65521344754, 34601.134971625914, 34700.78547250834, 24409.51180976406, 24430.511389772462, 24578.89394977266, 24689.506209875344, 24691.259262222164], "unit": "ms", "name": "ext.html", "value": 20744.766041770188}, {"lowerIsBetter": false, "replicates": [303.47650303226936, 356.5258206585242, 356.7003716877822, 361.11166530335373, 364.86682360938266, 15324.616884577863, 16348.591285217875, 18970.715439268406, 20475.283365082225, 21689.783102168993, 20761.896190519026, 20810.271640492585, 21150.365489035314, 21193.83433911134, 21202.0, 6377.649229292399, 6560.901586476183, 6566.934330656704, 6569.244536878248, 6569.638669873155, 4661.743604101773, 4816.87957801056, 4939.629527785412, 6458.225012998447, 7730.458867879251, 7146.8570628587395, 7248.3838873695795, 7684.9231507685045, 7691.538507689528, 7703.499272547295, 7231.493795434321, 7248.4563657725885, 7252.782416527512, 7257.310555497219, 7259.0563226780705, 6856.760013399557, 7249.818754531127, 7252.238514955907, 7257.092863392076, 7260.455465840083, 27351.589726154125, 27398.767055482353, 27782.722172778416, 28158.859205704044, 28278.575821362698, 2160.2763074370105, 2233.4304752288226, 2298.1726578431753, 2449.0571130115036, 2456.8648724320155, 14975.251237438084, 15202.543923682308, 15822.52532424029, 15979.440719574759, 16525.091119988396, 1805.7742782152231, 1878.0, 1879.6710575649206, 1886.2549293029315, 1904.8761830480973, 109809.35285970717, 115544.0, 115548.42225788817, 116683.83316166814, 118249.0, 18790.248390064244, 18816.717749233772, 18847.71728424075, 18883.52791180204, 18976.905115474336, 27921.30196745057, 27983.02059427951, 28051.0, 28060.43879122447, 28076.43847123087, 8230.917690823135, 10051.0, 10106.0, 10114.342567733074, 10130.37913933767, 8378.916210837813, 8386.0, 8415.368847336475, 8433.578321084044, 8488.40581159313, 6928.1339832520935, 7353.889691654629, 8503.787405314917, 8617.82764344722, 8627.396082274181, 1810.2306519729063, 1820.3264792027035, 1828.6982647862953, 1846.1415441819618, 2389.2951579284154, 879.4371602174614, 936.3305236755753, 953.6900507335143, 961.9470929098827, 1016.4409574734015, 19191.0, 19721.0, 20146.0, 20216.29242976518, 20318.390448286576, 912.6623149434752, 942.6182396129578, 949.3639261694681, 956.8134213828375, 1026.2604884720326, 10453.738656533495, 10792.46037698112, 10794.0, 10816.621418250481, 10859.34843909368, 647641.0, 751558.0, 757964.0, 770683.0, 785000.0, 85732.0, 105317.0, 112088.0, 114127.85872141339, 117010.41494792471, 1104.3870651788334, 1118.3737107219983, 1168.8480497535436, 1193.7075416522835, 1194.9761004779855, 17379.217935192693, 17570.472885813448, 17589.0, 17603.383881564085, 17693.64612707713, 40553.75569954338, 48254.0, 48788.0, 51293.0, 52755.0, 65328.0, 65619.68760624665, 65844.0, 66285.0, 67518.66240668962, 9450.858237126311, 9813.656522021694, 9848.753781155528, 9857.162141218078, 9870.605175792887, 14920.7761883574, 19595.216191352185, 19691.113899874254, 19810.50473738168, 20092.39722808318, 5161.793528258828, 15427.305771240546, 15896.761548577011, 16109.0, 16174.0, 14963.476278330207, 15709.764353534934, 15719.0, 15829.604259893595, 15848.683026339639, 16067.678646427239, 16093.75859362134, 16127.596810079842, 16525.421610243582, 16717.749233761748, 8280.296174825207, 9594.04059594035, 9653.855192171983, 9727.270454715783, 9864.457454840052, 15552.688946221238, 15646.530604081896, 15694.529164125095, 16046.919765401099, 16179.595510112342], "unit": "ms", "name": "jquery.html", "value": 10970.884674774128}, {"lowerIsBetter": false, "replicates": [1470.35304466035, 1540.9845901540982, 1550.7906432631592, 1909.1790530072071, 1924.143756028567, 7507.24927507249, 7636.427267954905, 8179.263866252044, 8535.999999999984, 8549.61526731297, 7348.669309881055, 7505.437092218078, 8410.57947102644, 8471.576421178946, 8479.618417171227, 2127.9148834046696, 2183.235867446389, 2364.326167042393, 2377.465070359173, 2380.143148466551, 1757.4639734880857, 2373.0389192377115, 2391.784739373456, 2395.101836811196, 2395.2454976682375, 2294.655801629752, 2325.360525855395, 2344.4724936889147, 2348.4481146930457, 2368.7631236876346, 2121.257559854039, 2161.827053835689, 2162.0919213930188, 2348.859068455898, 2380.285914225734, 2176.5646870625937, 2188.9452763680874, 2352.952940941189, 2404.61526155816, 2407.3139155340646, 8231.711890083818, 8363.372747043935, 8376.0, 8379.748607541722, 8388.664453421856, 5080.237964305346, 5188.325517682677, 5193.195054766517, 5206.895862082775, 5213.582913366921, 3476.4090104682264, 3553.4847447120023, 3593.4430163324464, 3620.1130722972775, 3624.673779359844, 1037.6108959140322, 1042.9374237545771, 1050.2700623066971, 1074.6023971130653, 1080.3247970018738, 10986.0, 11117.27737697047, 11131.554737810478, 11136.387498687569, 11158.665240042812, 4606.355110284563, 4684.180268453007, 4686.718796872198, 4733.905321893543, 4746.28805679144, 9740.610375584898, 9741.610335586638, 9747.951260243653, 9750.609975600897, 9752.0, 5187.818426355135, 5217.243499692523, 5219.060569097523, 5223.869403264949, 5228.424873263938, 4742.0, 4747.8575642730775, 4750.714957102585, 4759.976200118977, 4761.785719642625, 3620.4388319810473, 3718.5537735471917, 3732.720045996561, 3741.5884252732176, 3756.4928734620476, 1203.3622180244483, 1224.834647322618, 1228.0605336917265, 1229.0413477487573, 1239.535174309634, 1363.2502123831853, 1391.436468230348, 1410.978835317471, 1410.9911413339307, 1419.9929000354932, 7679.308862202429, 7843.9215607844335, 7846.411519136088, 7851.882221766678, 7856.7250146244605, 490.6148673291449, 496.81866118866355, 498.36956250343343, 503.8589195025399, 504.13540777566647, 5998.670073146019, 6095.207623008981, 6135.601185922901, 6233.3143354231, 6251.593646412968, 9449.196818270386, 10056.74858128538, 10109.696709098738, 10168.898311016796, 10199.796004079877, 9805.901940980642, 9962.352447090916, 10040.849387259197, 10047.748806279902, 10181.745456363502, 7851.960740196262, 7923.683052677944, 8004.5597492138495, 8010.479318844256, 8049.476784009021, 6618.90071648916, 6745.494087943522, 6752.797416077526, 7787.377009839086, 7834.0, 8673.522956237468, 9009.90990090117, 9123.224525915106, 9161.358704890594, 9167.266618670623, 8997.0, 9244.491552964651, 9301.674441394789, 9330.860037099585, 9422.528873556432, 6396.32838551964, 7302.817429564303, 7348.559086454829, 7387.1135463744695, 7409.962950185214, 7982.521048736862, 8034.076081250497, 8043.83912321762, 8048.758537243892, 8065.112837587743, 7368.189499155196, 7500.9249907500225, 7508.849823003618, 7618.200088990798, 7642.312191902533, 7337.486375953632, 7365.52124111931, 7380.040594722652, 7449.925500744923, 7451.739189128354, 7534.397248220239, 7583.9620801895635, 7603.695852165852, 7607.12518060408, 7623.809404764926, 6816.522843401112, 6843.3840954314355, 6889.896651550131, 6895.6552172392185, 6900.03399524057, 6969.1985421677155, 7017.193022802443, 7019.122609673791, 7029.05107810439, 7042.964785176247], "unit": "ms", "name": "mootools.html", "value": 4664.514030904862}, {"lowerIsBetter": false, "replicates": [315.8831232443996, 327.5659750830151, 328.3236532742549, 329.77575248830794, 334.6436045611425, 6779.728810847572, 6792.966035169823, 6803.795886123412, 6882.793516194522, 6888.24229334774, 5869.471747542721, 6443.29123796382, 6770.729170833173, 6791.08320376749, 6808.4212841908375, 4955.925661115086, 4981.178105612569, 4983.352164218664, 4993.650444468889, 4998.925016124761, 4051.0, 4733.692309999857, 4871.025794841028, 4928.137575924216, 4933.150068724229, 4855.902881942377, 4867.1482490564185, 4867.464578896319, 4894.535019173173, 4905.337779399771, 4618.237990731525, 4720.315554244649, 4735.337052812609, 4871.684645145809, 4898.632602554805, 4038.676905847525, 4053.4527838741687, 4053.8783836484954, 4066.329055705805, 4068.0033391819193, 6242.719077641517, 6476.708548115346, 6615.867682646368, 6648.335166483362, 6648.900266496006, 5810.273715785527, 5848.2689663792025, 5850.853728656775, 5857.297124345063, 5864.824055278348, 6910.689018994158, 7274.418046556316, 7277.745278915212, 7314.195438501761, 7322.121345438528, 3873.573906870242, 4364.869053928387, 4603.746793926332, 4611.677182597219, 4623.0, 7404.629768511553, 7545.735899243555, 7549.433792465587, 7558.811029724246, 7562.810929726746, 4710.858674239778, 4722.716637001722, 4729.881752956204, 4735.810567577328, 4739.857804265877, 4639.628829693616, 4778.976105119522, 4818.048690280442, 4827.131116399082, 4831.782569784368, 5817.447342502455, 5830.154627578977, 5839.854003649943, 5844.0, 5845.210896528914, 7292.708291668274, 7306.671199796022, 7320.450966177558, 7326.3040011198855, 7334.266573342729, 1366.5968539280937, 1606.8232494425604, 1666.258514960855, 1673.790776152981, 1675.6062325353532, 1039.95840166394, 1055.7941201465794, 1064.9414282214398, 1070.5450183672065, 1073.103958194916, 6730.730770769114, 6746.696398662072, 6771.187457505131, 6775.322467753185, 6799.524033317719, 6213.751449941951, 7365.594892280868, 7470.477066605394, 7496.325330720261, 7501.66242519088, 6521.054447105238, 6737.258901520829, 6750.763723269662, 6752.561083529555, 6769.695363708645, 3967.4643923070594, 3993.121513267077, 3999.1002024544828, 4007.499062617173, 4033.233685599727, 7735.497192682457, 7739.651715672809, 7740.071191457061, 7757.495762775401, 7779.611019449118, 7376.520526165782, 7693.384529237647, 7720.266574675396, 7738.922610773933, 7741.303282704471, 7698.653560589787, 7725.92274077252, 7738.961305193438, 7742.0, 7742.92257077422, 7222.0, 7398.778036658909, 7424.406047516078, 7432.554046757212, 7443.590602516913, 7231.2768723127265, 7307.3058059484265, 7478.887816682863, 7500.399968002655, 7502.661315714673, 7659.770206893802, 7845.960770196112, 7870.72452464161, 7894.328982036591, 7904.2886140245355, 3927.469791578215, 4652.464966528757, 4675.719456832601, 4682.719036857799, 4692.835750748707, 7573.053368328959, 7584.4311676625575, 7587.734429294948, 7589.848203036019, 7594.924050759642, 7129.536580122275, 7266.709331626887, 7307.013553170466, 7309.5248808827255, 7321.560706357635, 7302.0142280791415, 7306.4885458017425, 7310.488265821342, 7321.74373896911, 7324.707011719472, 7118.145822501333, 7120.60836653989, 7146.606936618536, 7148.749793757193, 7152.392046676091, 7098.503104782822, 7280.890786638311, 7301.488895777245, 7316.414686825147, 7337.486375953846, 7128.893066604109, 7140.9285907140265, 7155.141383033861, 7166.175889772534, 7171.0], "unit": "ms", "name": "prototype.html", "value": 5250.137293639935}, {"lowerIsBetter": false, "replicates": [743.7657138001529, 807.6688557691348, 812.9715459958899, 825.5211977053308, 827.4580150001751, 14941.551753447387, 15398.461053863117, 15416.61458463539, 15455.45905893294, 15459.30433130509, 14314.642133946656, 14362.28188590569, 14378.477273068087, 14385.856141438582, 14408.423663053465, 760.1448370583093, 772.088935056633, 773.3697036914897, 952.7999120184752, 984.3995162950595, 724.7861880745193, 948.2414068744977, 963.7686955130788, 968.8740463739739, 970.6602689058808, 847.9745607631781, 1002.844559093338, 1015.5785349080123, 1015.8882522922472, 1016.903394177552, 787.7794217619075, 1001.3641337750508, 1008.5310330696225, 1008.7629407089328, 1010.934289271195, 600.3666132230495, 601.362555690969, 745.0388998192325, 759.7720683794839, 760.4980712729572, 12883.549075782397, 15135.545933622008, 15208.0, 15250.466233681767, 15282.847171528254, 12283.631491055283, 12334.0, 12348.691282717915, 12833.935830320788, 13206.537771177962, 9330.626774928995, 10134.54394552247, 10283.382997020128, 10399.32404393712, 10453.895461045367, 3517.050396392985, 3533.522974398449, 3534.9469757953652, 3538.327717733622, 3542.3800834853796, 71983.64008179925, 72905.27094729038, 73632.52734945324, 73831.99999999946, 82624.0, 9437.103475169848, 9468.526573671288, 9484.715458536255, 9493.905060949302, 9518.428894266366, 20944.790552094284, 21013.159473620883, 21083.68374474384, 21122.683159752614, 21232.150713971267, 7103.82240443993, 7178.856422871618, 7199.964000179965, 7218.350348468558, 7357.153927298322, 3896.532416110085, 3961.1483531040963, 3966.4446977423186, 3973.5231772186944, 3977.423273625366, 3541.734369922266, 3568.1971556399603, 3569.3218288525095, 3573.8034408107806, 3579.1410061585034, 633.7401665317198, 634.2072409488139, 642.325558163926, 657.5101549345768, 658.9209294884645, 478.8268741583135, 507.52546369144966, 529.1612793721994, 552.9889402211933, 622.094851990362, 7326.816829579303, 8149.592520373958, 8503.362247831437, 8519.95740021296, 8656.740297791077, 522.5088416888113, 546.0716781471435, 569.8205065404385, 619.2661695890384, 629.3297638015499, 3832.7891965941585, 4055.6755459563165, 4153.273177193979, 4163.7293575917465, 4464.933026004613, 73504.63247683727, 91072.0, 92679.60980585296, 96452.0, 98147.0, 85642.0, 87024.0, 87169.5641521801, 87863.24273514622, 89170.0, 74795.87806182912, 74981.0, 76038.6198069006, 77032.84450733132, 77617.0, 8872.23486143936, 8989.46063236208, 9009.54952252398, 9050.411723237969, 9278.62885484573, 53755.731221343645, 54206.728966354916, 54494.45505544894, 54676.17985730138, 55458.44541554533, 76267.23732762602, 78402.6079869597, 78581.0, 78598.0, 78624.82062768949, 9495.14543691071, 10746.516406761559, 11136.0, 11171.944140279571, 11894.821577676516, 11661.183717139718, 11981.400929953294, 12213.206141600767, 12236.694082648006, 12444.875551244371, 11527.423628818358, 11762.23545469576, 11828.585999489977, 12042.157049006835, 12079.27524348542, 11491.655250342503, 11756.882431175922, 11905.702357441134, 11911.3448760319, 11976.101792365782, 11484.770304594029, 11637.709057273636, 11713.531458741554, 11719.472623731783, 11892.762144756884, 9738.977407372407, 9785.559649815918, 9844.310898237054, 9877.851832222666, 9997.600095996078, 9902.0, 10062.647807326708, 10112.79774404493, 10114.0, 10129.544170512492], "unit": "ms", "name": "yui.html", "value": 7030.81992332371}], "name": "dromaeo_css", "value": 7797.203989857626}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 103.0, 111.0, 110.0, 111.0, 110.0, 109.0, 103.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [150.0, 123.0, 149.0, 157.0, 119.0, 143.0, 143.0, 116.0, 155.0, 118.0], "unit": "ms", "name": "audio-beat-detection", "value": 137.3}, {"lowerIsBetter": true, "replicates": [184.0, 184.0, 181.0, 184.0, 187.0, 186.0, 184.0, 183.0, 186.0, 181.0], "unit": "ms", "name": "audio-dft", "value": 184.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 76.0, 73.0, 54.0, 56.0, 58.0, 69.0, 69.0, 55.0], "unit": "ms", "name": "audio-fft", "value": 64.4}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 117.0, 75.0, 74.0, 76.0, 113.0, 77.0, 73.0, 111.0], "unit": "ms", "name": "audio-oscillator", "value": 88.6}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 89.0, 130.0, 125.0, 85.0, 85.0, 86.0, 87.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 94.2}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 92.0], "unit": "ms", "name": "imaging-darkroom", "value": 93.6}, {"lowerIsBetter": true, "replicates": [90.0, 88.0, 89.0, 88.0, 88.0, 90.0, 88.0, 90.0, 92.0, 85.0], "unit": "ms", "name": "imaging-desaturate", "value": 88.8}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 54.0, 53.0, 54.0, 53.0, 54.0, 62.0, 52.0, 52.0], "unit": "ms", "name": "json-parse-financial", "value": 54.5}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 62.0, 65.0, 62.0, 67.0, 68.0, 67.0, 67.0, 66.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.8}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 81.0, 83.0, 83.0, 82.0, 82.0, 83.0, 85.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [123.0, 131.0, 123.0, 126.0, 120.0, 120.0, 132.0, 120.0, 120.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [131.0, 124.0, 133.0, 134.0, 133.0, 122.0, 135.0, 131.0, 133.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 130.9}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 65.0, 78.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1386.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [173.79214459506431], "unit": "score", "name": "Richards", "value": 203.127708}, {"lowerIsBetter": false, "replicates": [160.56518946692358], "unit": "score", "name": "DeltaBlue", "value": 411.782904}, {"lowerIsBetter": false, "replicates": [278.70680044593087], "unit": "score", "name": "Encrypt", "value": 955.0574279999998}, {"lowerIsBetter": false, "replicates": [4716.981132075472], "unit": "score", "name": "Decrypt", "value": 56.430372000000034}, {"lowerIsBetter": false, "replicates": [1708.1911262798635], "unit": "score", "name": "RayTrace", "value": 433.2003536463537}, {"lowerIsBetter": false, "replicates": [792.3930269413629], "unit": "score", "name": "Earley", "value": 841.0763060000003}, {"lowerIsBetter": false, "replicates": [12746.835443037975], "unit": "score", "name": "Boyer", "value": 52.28458490566033}, {"lowerIsBetter": false, "replicates": [27833.333333333332], "unit": "score", "name": "RegExp", "value": 32.729999999999976}, {"lowerIsBetter": false, "replicates": [700.9803921568628], "unit": "score", "name": "Splay", "value": 116.25289510489505}, {"lowerIsBetter": false, "replicates": [4497.757847533632], "unit": "score", "name": "NavierStokes", "value": 329.94217347956106}], "name": "v8_7", "value": 20185.160621536856}]} 12:10:51 INFO - RETURN: dromaeo_css: 7797.20 12:10:51 INFO - RETURN: kraken: 1386.30 12:10:51 INFO - RETURN: v8_7: 20185.16 12:10:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20185.16"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1386.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7797.20"}}} 12:10:51 INFO - Return code: 0 12:10:51 INFO - # TBPL SUCCESS # 12:10:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:10:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:10:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:10:51 INFO - 2015-11-24 12:10:51.341 screenresolution[2257:18878] starting screenresolution argv=screenresolution get 12:10:51 INFO - 2015-11-24 12:10:51.343 screenresolution[2257:18878] Display 0: 1600x1200x32@60 12:10:51 INFO - 2015-11-24 12:10:51.349 screenresolution[2258:18881] starting screenresolution argv=screenresolution list 12:10:51 INFO - Available Modes on Display 0 12:10:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:10:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:10:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:10:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:10:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:10:51 INFO - Intel Iris: 12:10:51 INFO - Chipset Model: Intel Iris 12:10:51 INFO - Type: GPU 12:10:51 INFO - Bus: Built-In 12:10:51 INFO - VRAM (Dynamic, Max): 1536 MB 12:10:51 INFO - Vendor: Intel (0x8086) 12:10:51 INFO - Device ID: 0x0a2e 12:10:51 INFO - Revision ID: 0x0009 12:10:51 INFO - Displays: 12:10:51 INFO - Display: 12:10:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:10:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:10:51 INFO - Display Serial Number: 1600x1200 60 12:10:51 INFO - Main Display: Yes 12:10:51 INFO - Mirror: Off 12:10:51 INFO - Online: Yes 12:10:51 INFO - Rotation: Supported 12:10:51 INFO - Return code: 0 12:10:51 INFO - Running post-action listener: _resource_record_post_action 12:10:51 INFO - Running post-run listener: _resource_record_post_run 12:10:52 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 8192; Write bytes: 689480704; Read time: 1; Write time: 2226 12:10:52 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 336947712; Write bytes: 337868288; Read time: 26027; Write time: 677 12:10:52 INFO - run-tests - Wall time: 1209s; CPU: 53.0%; Read bytes: 8192; Write bytes: 341171712; Read time: 1; Write time: 1519 12:10:52 INFO - Running post-run listener: _upload_blobber_files 12:10:52 INFO - Blob upload gear active. 12:10:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:10:52 INFO - Copying logs to upload dir... 12:10:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1281.729299 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-11-24 12:10:52.708885) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 12:10:52.714493) ========= 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.eMqNJrQ3Xu/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.Ujd85nbAUR/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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/z1zQHjPXQfe0q7_IcxNFkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009401 build_url: 'https://queue.taskcluster.net/v1/task/z1zQHjPXQfe0q7_IcxNFkg/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-24 12:10:52.738746) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 12:10:52.739136) ========= 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.eMqNJrQ3Xu/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.Ujd85nbAUR/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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.005195 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 12:10:52.788414) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 12:10:52.788760) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 12:10:52.789185) ========= ========= Total master_lag: 0.22 =========