builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0015 starttime: 1447764939.3 results: success (0) buildid: 20151117030105 builduid: c1dda71e472747f5bea520f32f32e1fd revision: 898c2c656e4b156c323416ef0c859915f3fd2308 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:39.299237) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:39.299700) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:39.300005) ========= 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.12Tcf6lJiV/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.X9NGmqzz0D/Listeners TMPDIR=/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/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:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006018 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:39.360183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:39.360507) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:39.391113) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:39.391504) ========= 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.12Tcf6lJiV/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.X9NGmqzz0D/Listeners TMPDIR=/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.015973 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:39.440480) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:39.444111) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:39.444831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:39.445331) ========= 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.12Tcf6lJiV/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.X9NGmqzz0D/Listeners TMPDIR=/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/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:0x0:0x0 using PTY: False --2015-11-17 04:55:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.26G=0s 2015-11-17 04:55:39 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201540 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:39.807399) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:39.807738) ========= 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.12Tcf6lJiV/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.X9NGmqzz0D/Listeners TMPDIR=/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.139246 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:40.072940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:40.073307) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 898c2c656e4b156c323416ef0c859915f3fd2308 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 898c2c656e4b156c323416ef0c859915f3fd2308 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.12Tcf6lJiV/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.X9NGmqzz0D/Listeners TMPDIR=/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/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:0x0:0x0 using PTY: False 2015-11-17 04:55:40,160 truncating revision to first 12 chars 2015-11-17 04:55:40,160 Setting DEBUG logging. 2015-11-17 04:55:40,160 attempt 1/10 2015-11-17 04:55:40,160 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/898c2c656e4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 04:55:40,427 unpacking tar archive at: mozilla-central-898c2c656e4b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.527250 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:40.620192) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:40.620529) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:40.747611) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:40.747993) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 04:55:40.748471) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 45 secs) (at 2015-11-17 04:55:40.748785) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.12Tcf6lJiV/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.X9NGmqzz0D/Listeners TMPDIR=/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/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:0x0:0x0 using PTY: False 04:55:41 INFO - MultiFileLogger online at 20151117 04:55:41 in /builds/slave/test 04:55:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:55:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:55:41 INFO - {'append_to_log': False, 04:55:41 INFO - 'base_work_dir': '/builds/slave/test', 04:55:41 INFO - 'blob_upload_branch': 'Firefox', 04:55:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:55:41 INFO - 'branch': 'Firefox', 04:55:41 INFO - 'buildbot_json_path': 'buildprops.json', 04:55:41 INFO - 'config_files': ('talos/mac_config.py',), 04:55:41 INFO - 'default_actions': ('clobber', 04:55:41 INFO - 'read-buildbot-config', 04:55:41 INFO - 'download-and-extract', 04:55:41 INFO - 'populate-webroot', 04:55:41 INFO - 'create-virtualenv', 04:55:41 INFO - 'install', 04:55:41 INFO - 'run-tests'), 04:55:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:55:41 INFO - 'download_minidump_stackwalk': True, 04:55:41 INFO - 'download_symbols': 'ondemand', 04:55:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:55:41 INFO - 'tooltool.py': '/tools/tooltool.py', 04:55:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:55:41 INFO - '/tools/misc-python/virtualenv.py')}, 04:55:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:55:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:55:41 INFO - 'installer_path': 'installer.exe', 04:55:41 INFO - 'log_level': 'info', 04:55:41 INFO - 'log_name': 'talos', 04:55:41 INFO - 'log_to_console': True, 04:55:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:55:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:55:41 INFO - 'opt_config_files': (), 04:55:41 INFO - 'pip_index': False, 04:55:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:55:41 INFO - 'cmd': ('bash', 04:55:41 INFO - '-c', 04:55:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:55:41 INFO - 'enabled': True, 04:55:41 INFO - 'halt_on_failure': False, 04:55:41 INFO - 'name': 'check_screen_resolution'},), 04:55:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:55:41 INFO - 'cmd': ('bash', 04:55:41 INFO - '-c', 04:55:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:55:41 INFO - 'enabled': True, 04:55:41 INFO - 'halt_on_failure': False, 04:55:41 INFO - 'name': 'check_screen_resolution'},), 04:55:41 INFO - 'run_cmd_checks_enabled': True, 04:55:41 INFO - 'sps_profile': False, 04:55:41 INFO - 'sps_profile_interval': 0, 04:55:41 INFO - 'suite': 'dromaeojs', 04:55:41 INFO - 'system_bits': '64', 04:55:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:55:41 INFO - 'title': 't-yosemite-r5-0015', 04:55:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:55:41 INFO - 'use_talos_json': True, 04:55:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:55:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:55:41 INFO - 'work_dir': 'build'} 04:55:41 INFO - ##### 04:55:41 INFO - ##### Running clobber step. 04:55:41 INFO - ##### 04:55:41 INFO - Running pre-action listener: _resource_record_pre_action 04:55:41 INFO - Running main action method: clobber 04:55:41 INFO - rmtree: /builds/slave/test/build 04:55:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:55:45 INFO - Running post-action listener: _resource_record_post_action 04:55:45 INFO - ##### 04:55:45 INFO - ##### Running read-buildbot-config step. 04:55:45 INFO - ##### 04:55:45 INFO - Running pre-action listener: _resource_record_pre_action 04:55:45 INFO - Running main action method: read_buildbot_config 04:55:45 INFO - Using buildbot properties: 04:55:45 INFO - { 04:55:45 INFO - "properties": { 04:55:45 INFO - "buildnumber": 610, 04:55:45 INFO - "product": "firefox", 04:55:45 INFO - "script_repo_revision": "production", 04:55:45 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 04:55:45 INFO - "repository": "", 04:55:45 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 04:55:45 INFO - "buildid": "20151117030105", 04:55:45 INFO - "slavename": "t-yosemite-r5-0015", 04:55:45 INFO - "pgo_build": "False", 04:55:45 INFO - "basedir": "/builds/slave/test", 04:55:45 INFO - "project": "", 04:55:45 INFO - "platform": "yosemite", 04:55:45 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:55:45 INFO - "slavebuilddir": "test", 04:55:45 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:55:45 INFO - "branch": "mozilla-central", 04:55:45 INFO - "repo_path": "mozilla-central", 04:55:45 INFO - "stage_platform": "macosx64", 04:55:45 INFO - "builduid": "c1dda71e472747f5bea520f32f32e1fd", 04:55:45 INFO - "revision": "898c2c656e4b156c323416ef0c859915f3fd2308" 04:55:45 INFO - }, 04:55:45 INFO - "sourcestamp": { 04:55:45 INFO - "repository": "", 04:55:45 INFO - "hasPatch": false, 04:55:45 INFO - "project": "", 04:55:45 INFO - "branch": "mozilla-central-macosx64-talos", 04:55:45 INFO - "changes": [ 04:55:45 INFO - { 04:55:45 INFO - "category": null, 04:55:45 INFO - "files": [ 04:55:45 INFO - { 04:55:45 INFO - "url": null, 04:55:45 INFO - "name": "https://queue.taskcluster.net/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 04:55:45 INFO - } 04:55:45 INFO - ], 04:55:45 INFO - "repository": "", 04:55:45 INFO - "rev": "898c2c656e4b156c323416ef0c859915f3fd2308", 04:55:45 INFO - "who": "cbook@mozilla.com", 04:55:45 INFO - "when": 1447764219, 04:55:45 INFO - "number": 6671563, 04:55:45 INFO - "comments": "merge b2g-inbound to mozilla-central a=merge", 04:55:45 INFO - "project": "", 04:55:45 INFO - "at": "Tue 17 Nov 2015 04:43:39", 04:55:45 INFO - "branch": "mozilla-central-macosx64-talos", 04:55:45 INFO - "revlink": "", 04:55:45 INFO - "properties": [ 04:55:45 INFO - [ 04:55:45 INFO - "buildid", 04:55:45 INFO - "20151117030105", 04:55:45 INFO - "Change" 04:55:45 INFO - ], 04:55:45 INFO - [ 04:55:45 INFO - "builduid", 04:55:45 INFO - "c1dda71e472747f5bea520f32f32e1fd", 04:55:45 INFO - "Change" 04:55:45 INFO - ], 04:55:45 INFO - [ 04:55:45 INFO - "pgo_build", 04:55:45 INFO - "False", 04:55:45 INFO - "Change" 04:55:45 INFO - ] 04:55:45 INFO - ], 04:55:45 INFO - "revision": "898c2c656e4b156c323416ef0c859915f3fd2308" 04:55:45 INFO - } 04:55:45 INFO - ], 04:55:45 INFO - "revision": "898c2c656e4b156c323416ef0c859915f3fd2308" 04:55:45 INFO - } 04:55:45 INFO - } 04:55:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 04:55:45 INFO - Running post-action listener: _resource_record_post_action 04:55:45 INFO - ##### 04:55:45 INFO - ##### Running download-and-extract step. 04:55:45 INFO - ##### 04:55:45 INFO - Running pre-action listener: _resource_record_pre_action 04:55:45 INFO - Running main action method: download_and_extract 04:55:45 INFO - mkdir: /builds/slave/test/build/tests 04:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:45 INFO - https://queue.taskcluster.net/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:55:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/test_packages.json 04:55:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/test_packages.json 04:55:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:55:46 INFO - Downloaded 1149 bytes. 04:55:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:55:46 INFO - Using the following test package requirements: 04:55:46 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:55:46 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:55:46 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 04:55:46 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:55:46 INFO - u'jsshell-mac.zip'], 04:55:46 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:55:46 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 04:55:46 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:55:46 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:55:46 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 04:55:46 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:55:46 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 04:55:46 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:55:46 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 04:55:46 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:55:46 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:55:46 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 04:55:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:55:46 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')]} 04:55:46 INFO - https://queue.taskcluster.net/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:55:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:55:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:55:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/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 04:55:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/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 04:55:47 INFO - Downloaded 17464131 bytes. 04:55:47 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 04:55:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:55:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 04:55:52 INFO - Return code: 0 04:55:52 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 04:55:52 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')]} 04:55:52 INFO - https://queue.taskcluster.net/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:55:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:55:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:55:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/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 04:55:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/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 04:55:53 INFO - Downloaded 17464131 bytes. 04:55:53 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 04:55:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:55:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 04:55:59 INFO - Return code: 0 04:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:55:59 INFO - https://queue.taskcluster.net/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:55:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:55:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:55:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/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 04:55:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/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 04:56:00 INFO - Downloaded 11131693 bytes. 04:56:00 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 04:56:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:56:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 04:56:01 INFO - Return code: 0 04:56: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')]} 04:56:01 INFO - https://queue.taskcluster.net/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:56:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:56:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:56:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 04:56:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yduO-oZMSwifDsAJ_iCmRg/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 04:56:05 INFO - Downloaded 108781603 bytes. 04:56:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:56:05 INFO - mkdir: /builds/slave/test/properties 04:56:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:56:05 INFO - Writing to file /builds/slave/test/properties/build_url 04:56:05 INFO - Contents: 04:56:05 INFO - build_url:https://queue.taskcluster.net/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:56:05 INFO - Running post-action listener: _resource_record_post_action 04:56:05 INFO - Running post-action listener: set_extra_try_arguments 04:56:05 INFO - ##### 04:56:05 INFO - ##### Running populate-webroot step. 04:56:05 INFO - ##### 04:56:05 INFO - Running pre-action listener: _resource_record_pre_action 04:56:05 INFO - Running main action method: populate_webroot 04:56:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:56:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:56:05 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:56:05 INFO - '../fennec_ids.txt'], 04:56:05 INFO - 'tests': ['tcheck2']}, 04:56:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:56:05 INFO - '--tppagecycles', 04:56:05 INFO - '7'], 04:56:05 INFO - 'tests': ['tsvgm']}}, 04:56:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:56:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:56:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:56:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:56:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:56:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:56:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:05 INFO - 'talos_options': ['--e10s'], 04:56:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:05 INFO - 'tests': ['damp', 'tps']}, 04:56:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:05 INFO - 'talos_options': ['--e10s'], 04:56:05 INFO - 'tests': ['damp', 'tps']}, 04:56:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:56:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:56:05 INFO - 'other': {'tests': ['a11yr', 04:56:05 INFO - 'ts_paint', 04:56:05 INFO - 'tpaint', 04:56:05 INFO - 'sessionrestore', 04:56:05 INFO - 'sessionrestore_no_auto_restore']}, 04:56:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:56:05 INFO - 'tests': ['a11yr', 04:56:05 INFO - 'ts_paint', 04:56:05 INFO - 'tpaint', 04:56:05 INFO - 'sessionrestore', 04:56:05 INFO - 'sessionrestore_no_auto_restore']}, 04:56:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:56:05 INFO - 'tests': ['a11yr', 04:56:05 INFO - 'ts_paint', 04:56:05 INFO - 'tpaint', 04:56:05 INFO - 'sessionrestore', 04:56:05 INFO - 'sessionrestore_no_auto_restore']}, 04:56:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:56:05 INFO - 'tests': ['a11yr', 04:56:05 INFO - 'ts_paint', 04:56:05 INFO - 'tpaint', 04:56:05 INFO - 'sessionrestore', 04:56:05 INFO - 'sessionrestore_no_auto_restore']}, 04:56:05 INFO - 'other_l64': {'tests': ['a11yr', 04:56:05 INFO - 'ts_paint', 04:56:05 INFO - 'tpaint', 04:56:05 INFO - 'sessionrestore', 04:56:05 INFO - 'sessionrestore_no_auto_restore']}, 04:56:05 INFO - 'other_nol64': {'tests': ['a11yr', 04:56:05 INFO - 'ts_paint', 04:56:05 INFO - 'tpaint', 04:56:05 INFO - 'sessionrestore', 04:56:05 INFO - 'sessionrestore_no_auto_restore']}, 04:56:05 INFO - 'svgr': {'tests': ['tsvgx', 04:56:05 INFO - 'tsvgr_opacity', 04:56:05 INFO - 'tart', 04:56:05 INFO - 'tscrollx', 04:56:05 INFO - 'cart']}, 04:56:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:56:05 INFO - 'tests': ['tsvgx', 04:56:05 INFO - 'tsvgr_opacity', 04:56:05 INFO - 'tart', 04:56:05 INFO - 'tscrollx', 04:56:05 INFO - 'cart']}, 04:56:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:05 INFO - 'tests': ['tp5o']}, 04:56:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:05 INFO - 'talos_options': ['--e10s'], 04:56:05 INFO - 'tests': ['tp5o']}, 04:56:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:05 INFO - 'talos_options': ['--xperf_path', 04:56:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:05 INFO - 'tests': ['tp5n']}, 04:56:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:05 INFO - 'talos_options': ['--e10s', 04:56:05 INFO - '--xperf_path', 04:56:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:05 INFO - 'tests': ['tp5n']}}, 04:56:05 INFO - 'talos.zip': {'path': '', 04:56:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:56:05 INFO - Running post-action listener: _resource_record_post_action 04:56:05 INFO - ##### 04:56:05 INFO - ##### Running create-virtualenv step. 04:56:05 INFO - ##### 04:56:05 INFO - Running pre-action listener: _resource_record_pre_action 04:56:05 INFO - Running main action method: create_virtualenv 04:56:05 INFO - Creating virtualenv /builds/slave/test/build/venv 04:56:05 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 04:56:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:56:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:56:05 INFO - Using real prefix '/tools/python27' 04:56:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:56:06 INFO - Installing distribute.............................................................................................................................................................................................done. 04:56:09 INFO - Installing pip.................done. 04:56:09 INFO - Return code: 0 04:56:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:09 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 0x10b91d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe811d40550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8409f0>, '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 0x10b5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8348c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12Tcf6lJiV/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.X9NGmqzz0D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:56:09 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 04:56:09 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 04:56:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12Tcf6lJiV/Render', 04:56:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:09 INFO - 'HOME': '/Users/cltbld', 04:56:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:09 INFO - 'LOGNAME': 'cltbld', 04:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:09 INFO - 'MOZ_NO_REMOTE': '1', 04:56:09 INFO - 'NO_EM_RESTART': '1', 04:56:09 INFO - 'PAGER': '/bin/cat', 04:56:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:09 INFO - 'PWD': '/builds/slave/test', 04:56:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:09 INFO - 'SHELL': '/bin/bash', 04:56:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9NGmqzz0D/Listeners', 04:56:09 INFO - 'TMPDIR': '/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/', 04:56:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:09 INFO - 'USER': 'cltbld', 04:56:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:09 INFO - 'XPC_FLAGS': '0x0', 04:56:09 INFO - 'XPC_SERVICE_NAME': '0', 04:56:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:10 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 04:56:10 INFO - Cleaning up... 04:56:10 INFO - Return code: 0 04:56:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:56:10 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')]} 04:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:10 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')]} 04:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:10 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 0x10b91d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe811d40550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8409f0>, '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 0x10b5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8348c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12Tcf6lJiV/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.X9NGmqzz0D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:56:10 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 04:56:10 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 04:56:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12Tcf6lJiV/Render', 04:56:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:10 INFO - 'HOME': '/Users/cltbld', 04:56:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:10 INFO - 'LOGNAME': 'cltbld', 04:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:10 INFO - 'MOZ_NO_REMOTE': '1', 04:56:10 INFO - 'NO_EM_RESTART': '1', 04:56:10 INFO - 'PAGER': '/bin/cat', 04:56:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:10 INFO - 'PWD': '/builds/slave/test', 04:56:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:10 INFO - 'SHELL': '/bin/bash', 04:56:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9NGmqzz0D/Listeners', 04:56:10 INFO - 'TMPDIR': '/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/', 04:56:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:10 INFO - 'USER': 'cltbld', 04:56:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:10 INFO - 'XPC_FLAGS': '0x0', 04:56:10 INFO - 'XPC_SERVICE_NAME': '0', 04:56:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:11 INFO - Downloading/unpacking psutil>=0.7.1 04:56:11 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 04:56:11 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 04:56:11 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 04:56:11 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 04:56:11 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 04:56:11 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 04:56:13 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:56:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:56:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:56:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:13 INFO - Installing collected packages: psutil 04:56:13 INFO - Running setup.py install for psutil 04:56:13 INFO - building 'psutil._psutil_osx' extension 04:56:13 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 04:56:15 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 04:56:15 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 04:56:15 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 04:56:16 INFO - building 'psutil._psutil_posix' extension 04:56:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:56:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:56:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:56:16 INFO - ^ 04:56:16 INFO - 1 warning generated. 04:56:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:56:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:16 INFO - Successfully installed psutil 04:56:16 INFO - Cleaning up... 04:56:16 INFO - Return code: 0 04:56:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:16 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 0x10b91d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe811d40550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8409f0>, '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 0x10b5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8348c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12Tcf6lJiV/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.X9NGmqzz0D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:56:16 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 04:56:16 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 04:56:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12Tcf6lJiV/Render', 04:56:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:16 INFO - 'HOME': '/Users/cltbld', 04:56:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:16 INFO - 'LOGNAME': 'cltbld', 04:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:16 INFO - 'MOZ_NO_REMOTE': '1', 04:56:16 INFO - 'NO_EM_RESTART': '1', 04:56:16 INFO - 'PAGER': '/bin/cat', 04:56:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:16 INFO - 'PWD': '/builds/slave/test', 04:56:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:16 INFO - 'SHELL': '/bin/bash', 04:56:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9NGmqzz0D/Listeners', 04:56:16 INFO - 'TMPDIR': '/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/', 04:56:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:16 INFO - 'USER': 'cltbld', 04:56:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:16 INFO - 'XPC_FLAGS': '0x0', 04:56:16 INFO - 'XPC_SERVICE_NAME': '0', 04:56:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:56:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:56:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:56:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:56:19 INFO - Installing collected packages: mozsystemmonitor 04:56:19 INFO - Running setup.py install for mozsystemmonitor 04:56:19 INFO - Successfully installed mozsystemmonitor 04:56:19 INFO - Cleaning up... 04:56:19 INFO - Return code: 0 04:56:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b91d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe811d40550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8409f0>, '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 0x10b5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8348c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12Tcf6lJiV/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.X9NGmqzz0D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:56:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:56:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12Tcf6lJiV/Render', 04:56:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:19 INFO - 'HOME': '/Users/cltbld', 04:56:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:19 INFO - 'LOGNAME': 'cltbld', 04:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:19 INFO - 'MOZ_NO_REMOTE': '1', 04:56:19 INFO - 'NO_EM_RESTART': '1', 04:56:19 INFO - 'PAGER': '/bin/cat', 04:56:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:19 INFO - 'PWD': '/builds/slave/test', 04:56:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:19 INFO - 'SHELL': '/bin/bash', 04:56:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9NGmqzz0D/Listeners', 04:56:19 INFO - 'TMPDIR': '/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/', 04:56:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:19 INFO - 'USER': 'cltbld', 04:56:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:19 INFO - 'XPC_FLAGS': '0x0', 04:56:19 INFO - 'XPC_SERVICE_NAME': '0', 04:56:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:19 INFO - Downloading/unpacking blobuploader==1.2.4 04:56:19 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 04:56:19 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 04:56:19 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 04:56:19 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 04:56:19 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 04:56:19 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 04:56:21 INFO - Downloading blobuploader-1.2.4.tar.gz 04:56:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:56:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:56:21 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 04:56:21 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 04:56:21 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 04:56:21 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 04:56:21 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 04:56:21 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 04:56:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:56:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:56:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:22 INFO - Downloading docopt-0.6.1.tar.gz 04:56:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:56:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:56:23 INFO - Installing collected packages: blobuploader, requests, docopt 04:56:23 INFO - Running setup.py install for blobuploader 04:56:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:56:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:56:23 INFO - Running setup.py install for requests 04:56:23 INFO - Running setup.py install for docopt 04:56:23 INFO - Successfully installed blobuploader requests docopt 04:56:23 INFO - Cleaning up... 04:56:24 INFO - Return code: 0 04:56:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b91d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe811d40550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8409f0>, '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 0x10b5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8348c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12Tcf6lJiV/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.X9NGmqzz0D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:56:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:56:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12Tcf6lJiV/Render', 04:56:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:24 INFO - 'HOME': '/Users/cltbld', 04:56:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:24 INFO - 'LOGNAME': 'cltbld', 04:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:24 INFO - 'MOZ_NO_REMOTE': '1', 04:56:24 INFO - 'NO_EM_RESTART': '1', 04:56:24 INFO - 'PAGER': '/bin/cat', 04:56:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:24 INFO - 'PWD': '/builds/slave/test', 04:56:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:24 INFO - 'SHELL': '/bin/bash', 04:56:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9NGmqzz0D/Listeners', 04:56:24 INFO - 'TMPDIR': '/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/', 04:56:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:24 INFO - 'USER': 'cltbld', 04:56:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:24 INFO - 'XPC_FLAGS': '0x0', 04:56:24 INFO - 'XPC_SERVICE_NAME': '0', 04:56:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:56:24 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-UKoV3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:56:24 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-V_omB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:24 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-nl0rIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:24 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-etu5CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:24 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-0_Io0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:24 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-zGNkj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:25 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-cPmhbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:25 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-MCIKVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:25 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-u3ykMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:25 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-vyLReC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:25 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-DUTwh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:25 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-ieCnL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:25 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-4oDPSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:25 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-K6qO2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:25 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-MCFa1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:26 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-FDA3Mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:26 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-vHiDgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:56:26 INFO - Running setup.py install for manifestparser 04:56:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:56:26 INFO - Running setup.py install for mozcrash 04:56:26 INFO - Running setup.py install for mozdebug 04:56:26 INFO - Running setup.py install for mozdevice 04:56:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:56:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:56:26 INFO - Running setup.py install for mozfile 04:56:27 INFO - Running setup.py install for mozhttpd 04:56:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:56:27 INFO - Running setup.py install for mozinfo 04:56:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:56:27 INFO - Running setup.py install for mozInstall 04:56:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:56:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:56:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:56:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:56:27 INFO - Running setup.py install for mozleak 04:56:27 INFO - Running setup.py install for mozlog 04:56:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:56:27 INFO - Running setup.py install for moznetwork 04:56:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:56:28 INFO - Running setup.py install for mozprocess 04:56:28 INFO - Running setup.py install for mozprofile 04:56:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:56:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:56:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:56:28 INFO - Running setup.py install for mozrunner 04:56:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:56:28 INFO - Running setup.py install for mozscreenshot 04:56:28 INFO - Running setup.py install for moztest 04:56:28 INFO - Running setup.py install for mozversion 04:56:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:56:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:56:29 INFO - Cleaning up... 04:56:29 INFO - Return code: 0 04:56:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:29 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')]} 04:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:29 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')]} 04:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:29 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 0x10b91d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe811d40550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8409f0>, '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 0x10b5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8348c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12Tcf6lJiV/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.X9NGmqzz0D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:56:29 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 04:56:29 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 04:56:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12Tcf6lJiV/Render', 04:56:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:29 INFO - 'HOME': '/Users/cltbld', 04:56:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:29 INFO - 'LOGNAME': 'cltbld', 04:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:29 INFO - 'MOZ_NO_REMOTE': '1', 04:56:29 INFO - 'NO_EM_RESTART': '1', 04:56:29 INFO - 'PAGER': '/bin/cat', 04:56:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:29 INFO - 'PWD': '/builds/slave/test', 04:56:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:29 INFO - 'SHELL': '/bin/bash', 04:56:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9NGmqzz0D/Listeners', 04:56:29 INFO - 'TMPDIR': '/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/', 04:56:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:29 INFO - 'USER': 'cltbld', 04:56:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:29 INFO - 'XPC_FLAGS': '0x0', 04:56:29 INFO - 'XPC_SERVICE_NAME': '0', 04:56:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:56:29 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-oNOmL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:56:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:56:29 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-ebOHJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:29 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-dO8Wo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:29 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-BgqlYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:29 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-19DxyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:29 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-ACJPwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:30 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)) 04:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:30 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-a_dSAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:30 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)) 04:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:30 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-04RLMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:30 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-Xte117-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:30 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-oYLVGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:30 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-uuaQVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:30 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-6IddrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:30 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-ObslKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:30 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-BTNJWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:31 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)) 04:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:31 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-MsG8yU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:31 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)) 04:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:31 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-kWy5_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:31 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)) 04:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:31 INFO - Running setup.py (path:/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/pip-LOos1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:56:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:34 INFO - Downloading blessings-1.5.1.tar.gz 04:56:34 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 04:56:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:56:34 INFO - Installing collected packages: blessings 04:56:34 INFO - Running setup.py install for blessings 04:56:35 INFO - Successfully installed blessings 04:56:35 INFO - Cleaning up... 04:56:35 INFO - Return code: 0 04:56:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:56:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:56:35 INFO - Reading from file tmpfile_stdout 04:56:35 INFO - Current package versions: 04:56:35 INFO - blessings == 1.5.1 04:56:35 INFO - blobuploader == 1.2.4 04:56:35 INFO - docopt == 0.6.1 04:56:35 INFO - manifestparser == 1.1 04:56:35 INFO - mozInstall == 1.12 04:56:35 INFO - mozcrash == 0.16 04:56:35 INFO - mozdebug == 0.1 04:56:35 INFO - mozdevice == 0.47 04:56:35 INFO - mozfile == 1.2 04:56:35 INFO - mozhttpd == 0.7 04:56:35 INFO - mozinfo == 0.9 04:56:35 INFO - mozleak == 0.1 04:56:35 INFO - mozlog == 3.0 04:56:35 INFO - moznetwork == 0.27 04:56:35 INFO - mozprocess == 0.22 04:56:35 INFO - mozprofile == 0.27 04:56:35 INFO - mozrunner == 6.11 04:56:35 INFO - mozscreenshot == 0.1 04:56:35 INFO - mozsystemmonitor == 0.0 04:56:35 INFO - moztest == 0.7 04:56:35 INFO - mozversion == 1.4 04:56:35 INFO - psutil == 3.1.1 04:56:35 INFO - requests == 1.2.3 04:56:35 INFO - wsgiref == 0.1.2 04:56:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:35 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')]} 04:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:35 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')]} 04:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:35 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 0x10b91d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe811d40550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8409f0>, '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 0x10b5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8348c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12Tcf6lJiV/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.X9NGmqzz0D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:56:35 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 04:56:35 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 04:56:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12Tcf6lJiV/Render', 04:56:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:35 INFO - 'HOME': '/Users/cltbld', 04:56:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:35 INFO - 'LOGNAME': 'cltbld', 04:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:35 INFO - 'MOZ_NO_REMOTE': '1', 04:56:35 INFO - 'NO_EM_RESTART': '1', 04:56:35 INFO - 'PAGER': '/bin/cat', 04:56:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:35 INFO - 'PWD': '/builds/slave/test', 04:56:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:35 INFO - 'SHELL': '/bin/bash', 04:56:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9NGmqzz0D/Listeners', 04:56:35 INFO - 'TMPDIR': '/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/', 04:56:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:35 INFO - 'USER': 'cltbld', 04:56:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:35 INFO - 'XPC_FLAGS': '0x0', 04:56:35 INFO - 'XPC_SERVICE_NAME': '0', 04:56:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:35 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)) 04:56:35 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)) 04:56:35 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)) 04:56:35 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)) 04:56:35 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)) 04:56:35 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)) 04:56:35 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)) 04:56:35 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)) 04:56:35 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)) 04:56:35 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)) 04:56:35 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)) 04:56:35 INFO - Cleaning up... 04:56:35 INFO - Return code: 0 04:56:35 INFO - Running post-action listener: _resource_record_post_action 04:56:35 INFO - Running post-action listener: _start_resource_monitoring 04:56:35 INFO - Starting resource monitoring. 04:56:35 INFO - ##### 04:56:35 INFO - ##### Running install step. 04:56:35 INFO - ##### 04:56:35 INFO - Running pre-action listener: _resource_record_pre_action 04:56:35 INFO - Running main action method: install 04:56:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:56:36 INFO - Reading from file tmpfile_stdout 04:56:36 INFO - Detecting whether we're running mozinstall >=1.0... 04:56:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:56:36 INFO - Reading from file tmpfile_stdout 04:56:36 INFO - Output received: 04:56:36 INFO - Usage: mozinstall [options] installer 04:56:36 INFO - Options: 04:56:36 INFO - -h, --help show this help message and exit 04:56:36 INFO - -d DEST, --destination=DEST 04:56:36 INFO - Directory to install application into. [default: 04:56:36 INFO - "/builds/slave/test"] 04:56:36 INFO - --app=APP Application being installed. [default: firefox] 04:56:36 INFO - mkdir: /builds/slave/test/build/application 04:56:36 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'] 04:56:36 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 04:57:12 INFO - Reading from file tmpfile_stdout 04:57:12 INFO - Output received: 04:57:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:57:12 INFO - Running post-action listener: _resource_record_post_action 04:57:12 INFO - ##### 04:57:12 INFO - ##### Running run-tests step. 04:57:12 INFO - ##### 04:57:12 INFO - Running pre-action listener: _resource_record_pre_action 04:57:12 INFO - Running main action method: run_tests 04:57:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:57:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:57:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:57:12 INFO - 2015-11-17 04:57:12.502 screenresolution[1630:7567] starting screenresolution argv=screenresolution get 04:57:12 INFO - 2015-11-17 04:57:12.505 screenresolution[1630:7567] Display 0: 1600x1200x32@60 04:57:12 INFO - 2015-11-17 04:57:12.512 screenresolution[1631:7569] starting screenresolution argv=screenresolution list 04:57:12 INFO - Available Modes on Display 0 04:57:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:57:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:57:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:57:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:57:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:57:12 INFO - Intel HD Graphics 3000: 04:57:12 INFO - Chipset Model: Intel HD Graphics 3000 04:57:12 INFO - Type: GPU 04:57:12 INFO - Bus: Built-In 04:57:12 INFO - VRAM (Total): 512 MB 04:57:12 INFO - VRAM (Dynamic, Max): 10 04:57:12 INFO - Vendor: Intel (0x8086) 04:57:12 INFO - Device ID: 0x0116 04:57:12 INFO - Revision ID: 0x0009 04:57:12 INFO - Displays: 04:57:12 INFO - Display: 04:57:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:57:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:57:12 INFO - Display Serial Number: 1600x1200 60 04:57:12 INFO - Main Display: Yes 04:57:12 INFO - Mirror: Off 04:57:12 INFO - Online: Yes 04:57:12 INFO - Rotation: Supported 04:57:12 INFO - Return code: 0 04:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:57:12 INFO - Python 2.7.3 04:57:12 INFO - Return code: 0 04:57:12 INFO - grabbing minidump binary from tooltool 04:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:12 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8409f0>, '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 0x10b5a0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8348c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:57:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:57:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:57:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:57:12 INFO - Return code: 0 04:57:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:57:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:57:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:57:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:57:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0015', '--webServer', 'localhost'] in /builds/slave/test/build 04:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0015 --webServer localhost 04:57:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.12Tcf6lJiV/Render', 04:57:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:12 INFO - 'HOME': '/Users/cltbld', 04:57:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:12 INFO - 'LOGNAME': 'cltbld', 04:57:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:57:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:12 INFO - 'MOZ_NO_REMOTE': '1', 04:57:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:57:12 INFO - 'NO_EM_RESTART': '1', 04:57:12 INFO - 'PAGER': '/bin/cat', 04:57:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:12 INFO - 'PWD': '/builds/slave/test', 04:57:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:57:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:12 INFO - 'SHELL': '/bin/bash', 04:57:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X9NGmqzz0D/Listeners', 04:57:12 INFO - 'TMPDIR': '/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/', 04:57:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:12 INFO - 'USER': 'cltbld', 04:57:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:12 INFO - 'XPC_FLAGS': '0x0', 04:57:12 INFO - 'XPC_SERVICE_NAME': '0', 04:57:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:57:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0015', '--webServer', 'localhost'] with output_timeout 3600 04:57:13 INFO - mozversion INFO | application_buildid: 20151117030105 04:57:13 INFO - mozversion INFO | application_changeset: 898c2c656e4b156c323416ef0c859915f3fd2308 04:57:13 INFO - mozversion INFO | application_display_name: Nightly 04:57:13 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:57:13 INFO - mozversion INFO | application_name: Firefox 04:57:13 INFO - mozversion INFO | application_remotingname: firefox 04:57:13 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:57:13 INFO - mozversion INFO | application_vendor: Mozilla 04:57:13 INFO - mozversion INFO | application_version: 45.0a1 04:57:13 INFO - mozversion INFO | platform_buildid: 20151117030105 04:57:13 INFO - mozversion INFO | platform_changeset: 898c2c656e4b156c323416ef0c859915f3fd2308 04:57:13 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:57:13 INFO - mozversion INFO | platform_version: 45.0a1 04:57:13 INFO - 2015-11-17 04:57:13,214 DEBUG : using testdate: 1447765033 04:57:13 INFO - 2015-11-17 04:57:13,214 DEBUG : actual date: 1447765033 04:57:13 INFO - 2015-11-17 04:57:13,263 INFO : starting webserver on 'localhost:49263' 04:57:13 INFO - 2015-11-17 04:57:13,264 INFO : Starting test suite t-yosemite-r5-0015 04:57:13 INFO - 2015-11-17 04:57:13,264 INFO : Starting test dromaeo_css 04:57:13 INFO - 2015-11-17 04:57:13,264 DEBUG : operating with platform_type : mac_ 04:57:13 INFO - 2015-11-17 04:57:13,265 INFO : Initialising browser for dromaeo_css test... 04:57:13 INFO - 2015-11-17 04:57:13,279 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/tmphEikRp/profile http://localhost:49263/getInfo.html 04:57:16 INFO - 2015-11-17 04:57:16,723 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:57:16 INFO - 2015-11-17 04:57:16,723 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:57:16 INFO - 2015-11-17 04:57:16,723 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:57:16 INFO - 2015-11-17 04:57:16,723 DEBUG : BROWSER_OUTPUT: __metrics 04:57:16 INFO - 2015-11-17 04:57:16,732 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:57:17 INFO - 2015-11-17 04:57:17,453 INFO : Browser initialized. 04:57:17 INFO - 2015-11-17 04:57:17,453 INFO : Running cycle 1/1 for dromaeo_css test... 04:57:17 INFO - 2015-11-17 04:57:17,454 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/tmphEikRp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:57:29 INFO - 2015-11-17 04:57:29,438 DEBUG : BROWSER_OUTPUT: RSS: Main: 228163584 04:57:29 INFO - 2015-11-17 04:57:29,438 DEBUG : BROWSER_OUTPUT: 04:58:20 INFO - 2015-11-17 04:58:20,498 DEBUG : BROWSER_OUTPUT: 1447765100491 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] 05:00:31 INFO - 2015-11-17 05:00:31,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49263/tests/dromaeo/cssquery-ext.html) 05:00:33 INFO - 2015-11-17 05:00:33,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 420630528 05:00:33 INFO - 2015-11-17 05:00:33,262 DEBUG : BROWSER_OUTPUT: 05:03:36 INFO - 2015-11-17 05:03:36,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-ext.html (next: http://localhost:49263/tests/dromaeo/cssquery-jquery.html) 05:03:36 INFO - 2015-11-17 05:03:36,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 372154368 05:03:36 INFO - 2015-11-17 05:03:36,731 DEBUG : BROWSER_OUTPUT: 05:06:38 INFO - 2015-11-17 05:06:38,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49263/tests/dromaeo/cssquery-mootools.html) 05:06:39 INFO - 2015-11-17 05:06:39,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 339992576 05:06:39 INFO - 2015-11-17 05:06:39,495 DEBUG : BROWSER_OUTPUT: 05:09:41 INFO - 2015-11-17 05:09:41,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49263/tests/dromaeo/cssquery-prototype.html) 05:09:42 INFO - 2015-11-17 05:09:42,154 DEBUG : BROWSER_OUTPUT: RSS: Main: 330088448 05:09:42 INFO - 2015-11-17 05:09:42,154 DEBUG : BROWSER_OUTPUT: 05:12:45 INFO - 2015-11-17 05:12:45,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49263/tests/dromaeo/cssquery-yui.html) 05:12:45 INFO - 2015-11-17 05:12:45,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 327630848 05:12:45 INFO - 2015-11-17 05:12:45,935 DEBUG : BROWSER_OUTPUT: 05:15:48 INFO - 2015-11-17 05:15:48,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-yui.html (next: http://localhost:49263/tests/dromaeo/cssquery-dojo.html) 05:15:49 INFO - 2015-11-17 05:15:49,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 385069056 05:15:49 INFO - 2015-11-17 05:15:49,153 DEBUG : BROWSER_OUTPUT: 05:15:49 INFO - 2015-11-17 05:15:49,155 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:15:49 INFO - 2015-11-17 05:15:49,155 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:15:49 INFO - 2015-11-17 05:15:49,155 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:15:49 INFO - 2015-11-17 05:15:49,155 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:15:49 INFO - 2015-11-17 05:15:49,157 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3138.1840721412427;3162.7627927905405;3241.335526217126;3250.5286733423654;3257.641659417464;4977.452480227172;5113.33526641537;5128.820491282806;5178.741062946857;5213.921791173136;5091.821786237482;5149.150390185615;5182.2226666000115;5293.364796224459;5295.338082739658;4733.763311834412;4734.195186818232;4736.218523943545;4742.739149346785;4845.903081938359;4413.911721765563;4795.256735206049;4838.225883858583;4842.636802239828;4897.485763994782;4511.368408422823;4597.517260687647;4632.119897219518;4641.976790116028;4790.712557246559;4650.023495066041;4653.046125544289;4657.510961349043;4673.369095172142;4702.059588082398;4674.088552732219;4676.649251306131;4733.077049975256;4760.23836186212;4771.594414474774;4932.901341973176;5079;5083.212102124176;5098.133317336062;5133.537981581639;5369.19462080691;5394.05604019299;5395.298611180521;5408.215808707755;5417.59368047394;5360.088784906575;5361.437049109865;5373.75818088183;5382.6232163748555;5514.420985796473;5052.040112378636;5060.139776238048;5065.417476990119;5076.086304465195;5103.897922041576;5428.131498960148;5476.424975377528;5538.169274608841;5563.638363506359;5570.192322113271;5165.40859208512;5291.656042357235;5317.282166907496;5332.2801421808335;5364.892702145935;5499.972500137474;5506.752196151103;5535.667859928337;5565.30433695788;5646.463585959327;5143.12566863634;5423.484768946943;5429.701366424884;5444.8366549003595;5461.508464238238;5442;5457.099578569491;5496.587755918322;5524.475174858382;5634.802781902614;4232.682548808852;4242.490901091889;4253.106847562047;4265.850695225652;4318;3743.9625603743616;3844.826982785781;3849.9037524061564;3866.5940076292145;3911.78485183312;5111.897762044739;5115.232715092766;5125.589952803767;5138.691678499302;5152.793888244429;5290.391604965402;5430.538404235605;5447.319085114361;5491.725413729378;5558.360788509292;5133.666311689728;5141.845744627667;5148.768305426265;5161.716105614228;5163.380394352702;4817.518248175154;4836.661433699607;4838.564529192389;4859.392575928009;4869.245266983623;5567.3040869891265;5661.716914154194;5694.629849059881;5710.086386178192;5809.680467574324;5448.346198456052;5469.753861076181;5470.370907345706;5490.752916118864;5506.531944784738;5604.747786349705;5626.465485778845;5630.634008789416;5658.490735833795;5687.77248910039;5105.846824595268;5266.683998960075;5363.490468405495;5383.81156659515;5466.316710411199;5453;5557.749901254372;5561.805336813192;5593.972030139823;5692.402297758841;5413.350397952271;5444.646098003617;5513.61404701667;5522.91715624274;5532.336119665666;5184.507471790174;5278.4721527846905;5433.293671822637;5460.945390546044;5497.065498865122;5242.947570524246;5262.447443018428;5270.209468579744;5283.577313814809;5297.947020529899;5415.756290966837;5434.5652347812875;5472.315960504937;5476;5494.011078005998;5218.556422704112;5319.893602128013;5353.250544923636;5369.946300536944;5392.245085687929 05:15:49 INFO - 2015-11-17 05:15:49,158 DEBUG : BROWSER_OUTPUT: |1;ext.html;525.6031696069467;526.4077912348608;528.62995902868;544.1266766839223;552.5827999860105;29583.852080739594;30271.394572108544;37110.25779484409;37192;37910.725356478564;40416.79791601038;40636.79681601588;41169.382459263135;41469.792651036776;41516.37725434121;7764.844703105934;8831.95584022079;8951.597178127;9074.591643376063;9088.182063614273;7954.443188976774;10451.634192803253;10541;10553.314034587765;10769.62306319279;10427.739306517322;10517.421541815198;10587.73530661732;10616.840747388756;10725.624603138891;8042.758717238492;8190.140035296327;10344.896551034468;10380.325278856888;10410.791784164312;10194.082532572103;10357.585696572129;10359.844602330972;10396.584136634525;10500.474976251156;37121.44317835208;37503.624963750284;37698.05754856123;37958.43062354067;38011.61988380108;2815.7747380209535;2818.210900947738;2826.0956493921954;2871.3539453622975;3067.9233019174476;26027.73972260272;26708.732912670817;26743.19770406891;26795.196144115707;27022.5946610801;2298.2300929188573;2342.6251799711963;2349.7180338359335;2350.6356514740073;2497.438076432806;243906;244468;245452;246022;248556.75721621458;48397.27404088942;48793.268100978516;55376;55798.721006394706;59237;55472.445275547536;55624.44375556274;55718.72140639271;56051.15923261154;56586.71706641441;15135.697286054217;15262.08427494354;15329.31018104188;15356.462523811613;15359.846401536066;10478.476076196159;10485.161187105014;10487.94756026215;10545.367277963347;10552;17518.29926802939;17706.91146544259;17741.911290443466;17850.464486065437;17873.19570619325;7661.808454788675;7787.610619469004;7841.451098423056;7846;7888.960555197187;876.2595606712318;889.2397000564424;1010.161565900301;1027.6140118310186;1035.0167341026056;26672.733272667414;27219.319517012234;27488.58767118495;28099.297517561816;28758.568621470276;971.6962328084428;995.0745806399973;1042.4683411460057;1048.2976405808126;1065.9626913058005;13217.867821321855;13402.798958015637;13516.391762370717;13591.184528928296;14228.430862765581;278481;285176;285891;286456;288223;51809.99999999924;51815.74092129515;51923.22115168275;51932;51974.22038669423;1303.1073714505594;1312.5078095714107;1313.4680454416168;1315.4080663701372;1329.6808765896308;26925.865370673022;27023.59464607993;27572.44855102927;27707.58438623382;27800;44637.55362446334;45229.477052294504;45266.773666131456;45283.54716452793;45305.546944530135;248167;250188;252185;252190;253622;25668.743312566636;25748.8712556436;26235.868820655774;26262.4747505045;27975;30775.230619233804;35980.10049748777;35988.46017309795;36037.45943810898;36155.45766813447;25247.99713734773;30128.698713013466;30500.694993049787;30696;30984.69015309818;30083.69916300809;30401.23996900095;30537.847310763304;30604.305006899474;30966;28194.2951426216;28214.43571128607;31795.52306715355;33085.17287067843;33109.33781324312;24761.25716228516;30353.62919495726;30478.862271563597;30602.693973059984;30662;21823.635272945157;22003.889980549993;22180.334589962327;22198.667019995035;22242.555148897256 05:15:49 INFO - 2015-11-17 05:15:49,162 DEBUG : BROWSER_OUTPUT: |2;jquery.html;311.15676516639905;319.9330233670708;322.9192701824544;329.2000438933392;333.4298349821805;13773.173609583431;14037.50868719595;17399.739003914936;17776.55558611034;18477.53806154847;12264.264144151335;12858.807117893239;16772.58068548287;17038.574035649115;17056.914715426406;5013.197888337867;5237.685738855681;5244.187150991584;5255.054090263751;5317;3236.3203727217197;4486.641068714495;5215.322008138936;5222.529972302492;5246.632735708502;3393.100828280508;4504.301833215857;4675.859724208279;4743;4744.976275118637;4657.767111644421;4674.182018146811;4696.225122854725;4708.10545996263;4716.4340279166545;3879.0690234343556;3880.8835734927998;3883.8446462141483;3900.609939006105;3920.941185882214;12052.698682533006;12472.501099956082;12580.937095314464;12691.809622855664;12693.428795704123;1760.10234780263;1795.5780391607962;1800.79290881549;1856.1368963431935;1922.3079691311116;9091.909080909172;9102.04428535001;9250.629974801;9353.111454411888;9402.435853848723;1440.8415074341815;1442.6537630968596;1490.6646004648976;1522.8401017893184;1545;53737.73131134358;54587.727061364436;54794.452055479334;55674.443255567334;56110.719446402916;5991.700414979321;6159.23009623797;6176.7838125665385;6211.720472578745;6412.583182093149;7091.645417729196;7161.319674630901;7174.964125179341;7192.892106618405;7235.819104522324;5215.24378965048;5269.314989051399;5270.341207349082;5286.60350473716;5377;5667.121596152603;5682.488576028178;5705.229793977843;5711.114777209539;5719.7712091516705;2825.7598104161375;2834.801563890549;2841.1902607756692;2845.558938364557;2864.4414339204072;984.1437948984429;989.3964681544252;991.5389343955095;994.1897353656891;1053.9249965035622;335.3879170513822;383.5359215349458;385.77817754791107;396.76590811420823;454.2096751652102;10683.465826708634;10900.236983411085;11300.773984520263;11374.260673056226;11414.143939204427;427.0135985872644;427.8673611180544;431.2065798929984;436.13644982933334;465.76478878166307;5792.362840087587;6064.939350606525;6080.300765412034;6113.786017489367;6193.318734939153;462891;463822;548006;549566;571323;62891;65689;66910.33089669042;67819.3218067813;68256.31743682499;468.0778865634694;481.662836014791;485.3375142929875;485.621215451941;491.98278060267717;10278.02358775945;10299.897001029894;10460.110890574386;10551.577936882746;10839.674809755405;30970.69029309678;31668;31810.363792724478;33267.16832079121;33296.66703333033;41444;44891.55108448874;45114;46013.53986460093;47101.293480598506;5915.319738230159;6003.549733769897;6014.548908831767;6030.6080104793045;6056.3035250946705;10689.786204276026;11261.71845703864;11394.25937314072;11553.82669259945;11597.76804463923;9465.47939863314;9535.52322383892;9689;9803.754906127404;9867;9282.30382721285;9360.719178424659;9466.384684995728;9490.383125096847;9538.23694104484;9812.705618831447;9821.312508124363;9832.508374581099;9865.753356166153;9895.406275623198;5824.21373114641;5875.383084776208;5903.0555111182;5929.229200203946;5933.050711886078;9551.936545439281;9617.278704097082;9830.55762490704;9991.900080999098;10063.798724025331 05:15:49 INFO - 2015-11-17 05:15:49,163 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1209.3529961470615;1708.4276767282959;1710.1791140252678;1740.2777847193408;1770.6458708258347;6782.864342713149;7008.929910700898;7072.292770722932;7277.636118194096;7319.670614822332;7469.738559150431;7602.847943041136;7610.923890761091;7637.809054773619;7668.961655191716;2133.743950725915;2165.5127596290868;2167.219800871685;2172.087723156278;2175.6192666283337;2223.7776222377793;2242.9775702243014;2276.169198242638;2280.5062683942047;2299.54009198161;2185.0058223508267;2187.136081247906;2211.5466329402434;2213.6458166693333;2222.0000999550184;2169.4684802223396;2192.506685995654;2198;2198.791114844087;2203.383052745226;2234.519578290659;2246.730392352928;2257;2261.9886900565557;2272.4659704969317;7474.4767866249385;7523.774286771406;7539.396848252127;7555.584442855641;7657.157712651604;4036.9596304036877;4254.361845723135;4692.389989301403;4760.738159401231;4765.499622539618;2571.961420578693;2646.192911162095;2728.6043523689154;2765.267204190891;2777.8611069446647;787.6770524085155;794.5391672829745;1484.7772834074867;1511.470985155198;1549.8992565483209;9886.604535818558;10045.296829221958;10094;10179.18566514677;10184.643537476153;4158.792060396968;4183.686223533247;4255.212785634668;4277.721948073366;4282.807273672693;8143.674253029931;8181;8222.917770822334;8237.83524329522;8268;4790.760461976887;4803.351547541037;4809.879753006203;4813.614910807127;4836.782344794493;4407.184670835842;4414.139242847678;4416.492103408149;4445.088756804847;4483.730976141442;3243.9675603244136;3289.9506507402407;3302.4220761366664;3303.3228188221356;3337.0823023668686;999.7950420163849;1007.9496025198857;1020.5968642386364;1027.8612387327764;1037.8910214427528;978.9167920726676;1005.8994100590029;1006.8741407324085;1112.4938153140301;1310.600266918599;7149.571025738473;7171.175314838756;7200.207977122513;7211.3870321023305;7220.711171553184;1064.435849000031;1122.4612186150694;1141.634676903383;1204.084895479442;1223.2049168040667;5229.895402091937;5520.171974203901;5586.190002449622;5597.608167428322;5642.915356269659;7813.335866451302;8541.316694664412;8970.551472426352;8979.910200898039;9031;8821.911780882108;8964.551772411354;8976.371653984159;9049.819003620023;9089.363744537952;7092.574445533284;7152.92847071533;7193.460490463236;7293.015442915244;7357.264273572707;7055.259197784364;7113.893291600733;7142.107236595426;7168.2831716827895;7254.600996945219;7526.209747976383;8127.3091787198755;8133.79665508367;8184.918150818416;8286.502809831429;8104.675812967651;8205.671773129247;8223.09545949957;8303.086660467223;8330.541820199947;6722.697478613376;6744.730210791709;6762.256151823394;6776.7628133015105;6837.692303846239;7279.781606551812;7348.77953661391;7374.299441553044;7449;7497.962510187414;6836.350546698056;6843;6904.13698287714;6939.6877140529805;6948.9305106950305;6530.640814755234;6719.294474080151;6769.849125648553;6853.17761868579;6864.965675171592;6826.726930922906;6831.6242606657115;6855.5543889647015;6924.238333783179;6963.79108626742;6153.446189842935;6193.659348735682;6219.315875253809;6223.937760622336;6276.246850377984;5563.666180029211;5848.883022339444;5994.31065427464;6206.782762603287;6309.1167236586 05:15:49 INFO - 2015-11-17 05:15:49,165 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.80279015849544;302.91518374855036;308.1018830110229;308.42170929507176;308.74528513975974;6064.818055458338;6153.200083989081;6201.565890387664;6206.627602343857;6208.286047104584;5811.4479124483105;5886.411358864122;5970.910436343458;6078.422549857756;6154.107654390111;4612.584867361937;4632.5135860734645;4649.163150632885;4654.301854721802;4703.600193983515;4631.328457373679;4632.3283123947;4663.5336466353265;4690.413698287714;4708;4431.756253406062;4498.347739577759;4564.634829213672;4601.838935637254;4629.398178236825;4583.060472603109;4608.4700259470255;4635.165670179366;4645;4656.348111264426;3964.1873415949663;3971.205758848242;3973.165635216608;4039.939400908989;4044.737092089005;5829.4753472187285;5944.227250457456;5979.730912108966;6052.364501727299;6059.787907423219;5257.579393648499;5264.8683782905355;5284.286621306152;5311.920321195185;5318.574514038906;6377.457916077139;6419.711112999927;6422.967885160591;6425.871482570369;6447.580907241015;4356.825726970949;4358.063016451447;4361.476622805252;4387.451568553931;4416.580424859633;6483.341829849786;6716.194056713226;6719.361660642231;6780.32196780318;6816.829579260509;4455.1980643484485;4461.330800379904;4463.2635615123145;4514.977425112854;4519.367288579601;4522.751248681354;4526.909461810746;4546.65900057497;4550.772461376918;4567.132244873464;5235.554977826851;5237.5286224239235;5255.159174532133;5301.522862942354;5318.175682769177;6221.47117495018;6391.744330226832;6486.124373209651;6509.772157974543;6511.153550038464;1567.8432156784231;1583.073901767479;1590.952271431859;1594.8803839712068;1596.345498345696;1018.3228153278135;1024.2727663359099;1035.11497669493;1043.5095505112586;1054.3989925742253;6058.27300723916;6069.42049628906;6126.479249263863;6157.599756015845;6181.907271390933;6619.768308109289;6636.369544893228;6637.668116594151;6643.368879956396;6721.092652491851;5975.342712301644;6029.397060293935;6058.182145410401;6200.627962322275;6213.378662133841;3598.586162591283;3611.476335931275;3627.8186090695885;3666.596674365871;3672.7245456590863;6912.928496083015;6939.583624982517;6989.37095661393;7023.262557431498;7034.824129396704;6644.96677516619;6905.447564194852;6916.100906882174;7001.894971575431;7023.051887995055;6924.723011079501;6928.896066559006;6983.336583024605;7002.264762199998;7047.189573199045;6538.346165383614;6734.292899245509;6761.594304341756;6765.019072234597;6797.966010169917;6560;6579.144711187515;6594.571352862049;6679;6681.465482761465;6936.549124306904;6961.443084553325;7007.194172670208;7017.894731579133;7047.365737083687;4455.977720111378;4457.398251236172;4471.888202794956;4487.214737420873;4509.9549004510845;6479.5788273762055;6701.631410272482;6701.932980670131;6740.460763138839;6847.520673552804;6480.254770701241;6519.641419721961;6568.113304703804;6607.108040414675;6609;6341.778037768656;6499.090127382265;6515.543911926309;6524.934750652433;6601.636909969998;6348.841278967878;6350.079238510482;6414.454771344488;6445.291017988111;6457.354264573693;6510.316416776171;6515.869682606227;6551.279359270572;6609.041688954979;6610.966945165435;6258.217722784652;6396.776112836028;6403.487720982217;6435.388638079375;6481.675916204076 05:15:49 INFO - 2015-11-17 05:15:49,168 DEBUG : BROWSER_OUTPUT: |5;yui.html;595.8173026542314;600.3246347858659;611.5902345428563;622.2781573374884;627.5920651576474;11935.16453848231;12245.693857653541;12247.693807654812;12260.81608775868;12281.570145044925;11216.607418740346;11222.382768947704;11306.03898668612;11361.318320900751;11514.827277590843;833.4291010657719;839.3159574946415;846.1792061700172;851.4252879306474;859.4113032572676;828.0477450931417;843.2747836860295;844.105248436656;844.8901642786429;844.907060223375;867.3408209760596;868.5743985447117;871.4161511787086;879.8064425826308;882.294164668266;864.1703964194412;865.7143142762873;866.6793286483978;867.1848462445313;867.2238346679686;645.3739872323838;650.7884937395318;651.039716418284;653.9084528166061;655.5476721062452;10267.691969240936;10361.533730982124;10386.844197337046;10451.216158788122;10515.84226236607;9294.767630809216;9311.76720581984;9447.102525260088;10138.6597708324;10242.129418999393;8056.355491560661;8289.8342033159;8483.44857584255;8501.234888860032;8664.78338041554;2956.645202575705;3024.2654930415233;3057.2204087957653;3090.2892334763133;3090.3201295714907;39995.40006899899;40008.199836003114;45191.54808451906;45738.54261457376;46122.308165377544;8347.12355202695;8525.957370213233;8609.311255099703;8722.956385218033;9144.268458523302;18078.5480362992;18194.272229110687;18220.63558728818;18328.725069123975;18397.724034139497;6115.84710382244;6259.7496100156395;6298.433141017331;6395.872082558323;6576.901346479806;3574.249407624428;3594.6299250953352;3596.118950857057;3674.1365779041903;3697.722670799647;2791.190554739103;2791.3021744563857;2806.438712257516;2819.7039310872474;2819.9859000704864;415.7505496701955;415.75470472421415;420.9284421648327;421.5089420824766;428.5136370219761;462.7269910752672;467.5091154288052;472.1100725133149;567.7870798450581;575.8339362790383;7330.135891286949;7380.77857664271;7411.6664750086375;7458.73894413693;7587.2412758723685;486.59369426528536;529.8622358186822;577.8757567123089;580.8132381583342;590.2739630254811;3377.6791204835995;3852.7110466715108;3890.980545097313;3950.6049395060263;4082.2243773682903;56906.7154664224;58004;58324;58378;58482.707586461795;49167.26249106266;49552.50447495551;49985;50000.74999625052;50005.49994500081;40003;41722.1655566887;44605.55394446014;44696.776516117214;44771.55228447739;7568.243175682388;7789.64946577394;7939.126696063313;8007.199280071946;8180.672773089248;34091.14772130716;34331.65668343285;34673;34817.65182348144;35994;36962.96703681216;39868.60131398649;44151.33772993343;44245.33631995587;45029.32456013228;6862;6997.475189360716;7389.482736208413;7479.58862262559;7608;10577.524011419351;10864.402457864893;10872;10910.454477276264;10981.61564345244;10137.860215000434;10225.181985440999;10232.386056836614;10473.31923424975;10640.414777187329;9561.139497445263;10157.796844063225;10333.793324133325;10478.95210478946;10492;10381.792364152825;10449.947750261505;10471.371717696658;10609.151267898395;10690.19823513224;7792.961035194788;8098.056208988486;8282.668693252203;8836;9092.227160691415;7769.844603108019;8312.293455056388;8360.581970901309;8420.536870471939;8742.956285218534 05:15:49 INFO - 2015-11-17 05:15:49,168 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:15:49 INFO - 2015-11-17 05:15:49,168 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:15:49 INFO - 2015-11-17 05:15:49,168 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1696 05:15:49 INFO - 2015-11-17 05:15:49,168 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:15:49 INFO - 2015-11-17 05:15:49,169 DEBUG : BROWSER_OUTPUT: __startTimestamp1447766149153__endTimestamp 05:15:49 INFO - 2015-11-17 05:15:49,169 DEBUG : BROWSER_OUTPUT: 05:15:49 INFO - 2015-11-17 05:15:49,169 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:15:49 INFO - 2015-11-17 05:15:49,169 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:15:49 INFO - 2015-11-17 05:15:49,169 DEBUG : BROWSER_OUTPUT: 05:15:49 INFO - 2015-11-17 05:15:49,169 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5107.46 Median:5278.47 stddev:532.82 (10.1%) stddev-sans-first:511.57 05:15:49 INFO - 2015-11-17 05:15:49,170 DEBUG : BROWSER_OUTPUT: Values: 3138.2 3162.8 3241.3 3250.5 3257.6 4977.5 5113.3 5128.8 5178.7 5213.9 5091.8 5149.2 5182.2 5293.4 5295.3 4733.8 4734.2 4736.2 4742.7 4845.9 4413.9 4795.3 4838.2 4842.6 4897.5 4511.4 4597.5 4632.1 4642.0 4790.7 4650.0 4653.0 4657.5 4673.4 4702.1 4674.1 4676.6 4733.1 4760.2 4771.6 4932.9 5079.0 5083.2 5098.1 5133.5 5369.2 5394.1 5395.3 5408.2 5417.6 5360.1 5361.4 5373.8 5382.6 5514.4 5052.0 5060.1 5065.4 5076.1 5103.9 5428.1 5476.4 5538.2 5563.6 5570.2 5165.4 5291.7 5317.3 5332.3 5364.9 5500.0 5506.8 5535.7 5565.3 5646.5 5143.1 5423.5 5429.7 5444.8 5461.5 5442.0 5457.1 5496.6 5524.5 5634.8 4232.7 4242.5 4253.1 4265.9 4318.0 3744.0 3844.8 3849.9 3866.6 3911.8 5111.9 5115.2 5125.6 5138.7 5152.8 5290.4 5430.5 5447.3 5491.7 5558.4 5133.7 5141.8 5148.8 5161.7 5163.4 4817.5 4836.7 4838.6 4859.4 4869.2 5567.3 5661.7 5694.6 5710.1 5809.7 5448.3 5469.8 5470.4 5490.8 5506.5 5604.7 5626.5 5630.6 5658.5 5687.8 5105.8 5266.7 5363.5 5383.8 5466.3 5453.0 5557.7 5561.8 5594.0 5692.4 5413.4 5444.6 5513.6 5522.9 5532.3 5184.5 5278.5 5433.3 5460.9 5497.1 5242.9 5262.4 5270.2 5283.6 5297.9 5415.8 5434.6 5472.3 5476.0 5494.0 5218.6 5319.9 5353.3 5369.9 5392.2 05:15:49 INFO - 2015-11-17 05:15:49,170 DEBUG : BROWSER_OUTPUT: 05:15:49 INFO - 2015-11-17 05:15:49,170 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41945.50 Median:2816.99 stddev:68101.56 (2417.5%) stddev-sans-first:68221.59 05:15:49 INFO - 2015-11-17 05:15:49,172 DEBUG : BROWSER_OUTPUT: Values: 525.6 526.4 528.6 544.1 552.6 29583.9 30271.4 37110.3 37192.0 37910.7 40416.8 40636.8 41169.4 41469.8 41516.4 7764.8 8832.0 8951.6 9074.6 9088.2 7954.4 10451.6 10541.0 10553.3 10769.6 10427.7 10517.4 10587.7 10616.8 10725.6 8042.8 8190.1 10344.9 10380.3 10410.8 10194.1 10357.6 10359.8 10396.6 10500.5 37121.4 37503.6 37698.1 37958.4 38011.6 2815.8 2818.2 2826.1 2871.4 3067.9 26027.7 26708.7 26743.2 26795.2 27022.6 2298.2 2342.6 2349.7 2350.6 2497.4 243906.0 244468.0 245452.0 246022.0 248556.8 48397.3 48793.3 55376.0 55798.7 59237.0 55472.4 55624.4 55718.7 56051.2 56586.7 15135.7 15262.1 15329.3 15356.5 15359.8 10478.5 10485.2 10487.9 10545.4 10552.0 17518.3 17706.9 17741.9 17850.5 17873.2 7661.8 7787.6 7841.5 7846.0 7889.0 876.3 889.2 1010.2 1027.6 1035.0 26672.7 27219.3 27488.6 28099.3 28758.6 971.7 995.1 1042.5 1048.3 1066.0 13217.9 13402.8 13516.4 13591.2 14228.4 278481.0 285176.0 285891.0 286456.0 288223.0 51810.0 51815.7 51923.2 51932.0 51974.2 1303.1 1312.5 1313.5 1315.4 1329.7 26925.9 27023.6 27572.4 27707.6 27800.0 44637.6 45229.5 45266.8 45283.5 45305.5 248167.0 250188.0 252185.0 252190.0 253622.0 25668.7 25748.9 26235.9 26262.5 27975.0 30775.2 35980.1 35988.5 36037.5 36155.5 25248.0 30128.7 30500.7 30696.0 30984.7 30083.7 30401.2 30537.8 30604.3 30966.0 28194.3 28214.4 31795.5 33085.2 33109.3 24761.3 30353.6 30478.9 30602.7 30662.0 21823.6 22003.9 22180.3 22198.7 22242.6 05:15:49 INFO - 2015-11-17 05:15:49,172 DEBUG : BROWSER_OUTPUT: 05:15:49 INFO - 2015-11-17 05:15:49,172 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25455.87 Median:4743.99 stddev:85326.77 (1798.6%) stddev-sans-first:85545.24 05:15:49 INFO - 2015-11-17 05:15:49,172 DEBUG : BROWSER_OUTPUT: Values: 311.2 319.9 322.9 329.2 333.4 13773.2 14037.5 17399.7 17776.6 18477.5 12264.3 12858.8 16772.6 17038.6 17056.9 5013.2 5237.7 5244.2 5255.1 5317.0 3236.3 4486.6 5215.3 5222.5 5246.6 3393.1 4504.3 4675.9 4743.0 4745.0 4657.8 4674.2 4696.2 4708.1 4716.4 3879.1 3880.9 3883.8 3900.6 3920.9 12052.7 12472.5 12580.9 12691.8 12693.4 1760.1 1795.6 1800.8 1856.1 1922.3 9091.9 9102.0 9250.6 9353.1 9402.4 1440.8 1442.7 1490.7 1522.8 1545.0 53737.7 54587.7 54794.5 55674.4 56110.7 5991.7 6159.2 6176.8 6211.7 6412.6 7091.6 7161.3 7175.0 7192.9 7235.8 5215.2 5269.3 5270.3 5286.6 5377.0 5667.1 5682.5 5705.2 5711.1 5719.8 2825.8 2834.8 2841.2 2845.6 2864.4 984.1 989.4 991.5 994.2 1053.9 335.4 383.5 385.8 396.8 454.2 10683.5 10900.2 11300.8 11374.3 11414.1 427.0 427.9 431.2 436.1 465.8 5792.4 6064.9 6080.3 6113.8 6193.3 462891.0 463822.0 548006.0 549566.0 571323.0 62891.0 65689.0 66910.3 67819.3 68256.3 468.1 481.7 485.3 485.6 492.0 10278.0 10299.9 10460.1 10551.6 10839.7 30970.7 31668.0 31810.4 33267.2 33296.7 41444.0 44891.6 45114.0 46013.5 47101.3 5915.3 6003.5 6014.5 6030.6 6056.3 10689.8 11261.7 11394.3 11553.8 11597.8 9465.5 9535.5 9689.0 9803.8 9867.0 9282.3 9360.7 9466.4 9490.4 9538.2 9812.7 9821.3 9832.5 9865.8 9895.4 5824.2 5875.4 5903.1 5929.2 5933.1 9551.9 9617.3 9830.6 9991.9 10063.8 05:15:49 INFO - 2015-11-17 05:15:49,172 DEBUG : BROWSER_OUTPUT: 05:15:49 INFO - 2015-11-17 05:15:49,172 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5265.76 Median:6213.05 stddev:2678.68 (43.1%) stddev-sans-first:2668.83 05:15:49 INFO - 2015-11-17 05:15:49,174 DEBUG : BROWSER_OUTPUT: Values: 1209.4 1708.4 1710.2 1740.3 1770.6 6782.9 7008.9 7072.3 7277.6 7319.7 7469.7 7602.8 7610.9 7637.8 7669.0 2133.7 2165.5 2167.2 2172.1 2175.6 2223.8 2243.0 2276.2 2280.5 2299.5 2185.0 2187.1 2211.5 2213.6 2222.0 2169.5 2192.5 2198.0 2198.8 2203.4 2234.5 2246.7 2257.0 2262.0 2272.5 7474.5 7523.8 7539.4 7555.6 7657.2 4037.0 4254.4 4692.4 4760.7 4765.5 2572.0 2646.2 2728.6 2765.3 2777.9 787.7 794.5 1484.8 1511.5 1549.9 9886.6 10045.3 10094.0 10179.2 10184.6 4158.8 4183.7 4255.2 4277.7 4282.8 8143.7 8181.0 8222.9 8237.8 8268.0 4790.8 4803.4 4809.9 4813.6 4836.8 4407.2 4414.1 4416.5 4445.1 4483.7 3244.0 3290.0 3302.4 3303.3 3337.1 999.8 1007.9 1020.6 1027.9 1037.9 978.9 1005.9 1006.9 1112.5 1310.6 7149.6 7171.2 7200.2 7211.4 7220.7 1064.4 1122.5 1141.6 1204.1 1223.2 5229.9 5520.2 5586.2 5597.6 5642.9 7813.3 8541.3 8970.6 8979.9 9031.0 8821.9 8964.6 8976.4 9049.8 9089.4 7092.6 7152.9 7193.5 7293.0 7357.3 7055.3 7113.9 7142.1 7168.3 7254.6 7526.2 8127.3 8133.8 8184.9 8286.5 8104.7 8205.7 8223.1 8303.1 8330.5 6722.7 6744.7 6762.3 6776.8 6837.7 7279.8 7348.8 7374.3 7449.0 7498.0 6836.4 6843.0 6904.1 6939.7 6948.9 6530.6 6719.3 6769.8 6853.2 6865.0 6826.7 6831.6 6855.6 6924.2 6963.8 6153.4 6193.7 6219.3 6223.9 6276.2 5563.7 5848.9 5994.3 6206.8 6309.1 05:15:49 INFO - 2015-11-17 05:15:49,174 DEBUG : BROWSER_OUTPUT: 05:15:49 INFO - 2015-11-17 05:15:49,174 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5397.45 Median:6139.84 stddev:1661.86 (27.1%) stddev-sans-first:1621.86 05:15:49 INFO - 2015-11-17 05:15:49,175 DEBUG : BROWSER_OUTPUT: Values: 298.8 302.9 308.1 308.4 308.7 6064.8 6153.2 6201.6 6206.6 6208.3 5811.4 5886.4 5970.9 6078.4 6154.1 4612.6 4632.5 4649.2 4654.3 4703.6 4631.3 4632.3 4663.5 4690.4 4708.0 4431.8 4498.3 4564.6 4601.8 4629.4 4583.1 4608.5 4635.2 4645.0 4656.3 3964.2 3971.2 3973.2 4039.9 4044.7 5829.5 5944.2 5979.7 6052.4 6059.8 5257.6 5264.9 5284.3 5311.9 5318.6 6377.5 6419.7 6423.0 6425.9 6447.6 4356.8 4358.1 4361.5 4387.5 4416.6 6483.3 6716.2 6719.4 6780.3 6816.8 4455.2 4461.3 4463.3 4515.0 4519.4 4522.8 4526.9 4546.7 4550.8 4567.1 5235.6 5237.5 5255.2 5301.5 5318.2 6221.5 6391.7 6486.1 6509.8 6511.2 1567.8 1583.1 1591.0 1594.9 1596.3 1018.3 1024.3 1035.1 1043.5 1054.4 6058.3 6069.4 6126.5 6157.6 6181.9 6619.8 6636.4 6637.7 6643.4 6721.1 5975.3 6029.4 6058.2 6200.6 6213.4 3598.6 3611.5 3627.8 3666.6 3672.7 6912.9 6939.6 6989.4 7023.3 7034.8 6645.0 6905.4 6916.1 7001.9 7023.1 6924.7 6928.9 6983.3 7002.3 7047.2 6538.3 6734.3 6761.6 6765.0 6798.0 6560.0 6579.1 6594.6 6679.0 6681.5 6936.5 6961.4 7007.2 7017.9 7047.4 4456.0 4457.4 4471.9 4487.2 4510.0 6479.6 6701.6 6701.9 6740.5 6847.5 6480.3 6519.6 6568.1 6607.1 6609.0 6341.8 6499.1 6515.5 6524.9 6601.6 6348.8 6350.1 6414.5 6445.3 6457.4 6510.3 6515.9 6551.3 6609.0 6611.0 6258.2 6396.8 6403.5 6435.4 6481.7 05:15:49 INFO - 2015-11-17 05:15:49,175 DEBUG : BROWSER_OUTPUT: 05:15:49 INFO - 2015-11-17 05:15:49,176 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12698.28 Median:49359.88 stddev:15482.18 (31.4%) stddev-sans-first:15498.94 05:15:49 INFO - 2015-11-17 05:15:49,177 DEBUG : BROWSER_OUTPUT: Values: 595.8 600.3 611.6 622.3 627.6 11935.2 12245.7 12247.7 12260.8 12281.6 11216.6 11222.4 11306.0 11361.3 11514.8 833.4 839.3 846.2 851.4 859.4 828.0 843.3 844.1 844.9 844.9 867.3 868.6 871.4 879.8 882.3 864.2 865.7 866.7 867.2 867.2 645.4 650.8 651.0 653.9 655.5 10267.7 10361.5 10386.8 10451.2 10515.8 9294.8 9311.8 9447.1 10138.7 10242.1 8056.4 8289.8 8483.4 8501.2 8664.8 2956.6 3024.3 3057.2 3090.3 3090.3 39995.4 40008.2 45191.5 45738.5 46122.3 8347.1 8526.0 8609.3 8723.0 9144.3 18078.5 18194.3 18220.6 18328.7 18397.7 6115.8 6259.7 6298.4 6395.9 6576.9 3574.2 3594.6 3596.1 3674.1 3697.7 2791.2 2791.3 2806.4 2819.7 2820.0 415.8 415.8 420.9 421.5 428.5 462.7 467.5 472.1 567.8 575.8 7330.1 7380.8 7411.7 7458.7 7587.2 486.6 529.9 577.9 580.8 590.3 3377.7 3852.7 3891.0 3950.6 4082.2 56906.7 58004.0 58324.0 58378.0 58482.7 49167.3 49552.5 49985.0 50000.7 50005.5 40003.0 41722.2 44605.6 44696.8 44771.6 7568.2 7789.6 7939.1 8007.2 8180.7 34091.1 34331.7 34673.0 34817.7 35994.0 36963.0 39868.6 44151.3 44245.3 45029.3 6862.0 6997.5 7389.5 7479.6 7608.0 10577.5 10864.4 10872.0 10910.5 10981.6 10137.9 10225.2 10232.4 10473.3 10640.4 9561.1 10157.8 10333.8 10479.0 10492.0 10381.8 10449.9 10471.4 10609.2 10690.2 7793.0 8098.1 8282.7 8836.0 9092.2 7769.8 8312.3 8360.6 8420.5 8743.0 05:15:49 INFO - 2015-11-17 05:15:49,177 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:15:49 INFO - 2015-11-17 05:15:49,177 DEBUG : BROWSER_OUTPUT: 05:15:49 INFO - 2015-11-17 05:15:49,838 INFO : Browser exited with error code: 0 05:15:49 INFO - 2015-11-17 05:15:49,865 INFO : Completed test dromaeo_css (00:18:36) 05:15:49 INFO - 2015-11-17 05:15:49,866 INFO : Starting test kraken 05:15:49 INFO - 2015-11-17 05:15:49,866 DEBUG : operating with platform_type : mac_ 05:15:49 INFO - 2015-11-17 05:15:49,866 INFO : Initialising browser for kraken test... 05:15:49 INFO - 2015-11-17 05:15:49,879 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/tmpoxlrkx/profile http://localhost:49263/getInfo.html 05:15:52 INFO - 2015-11-17 05:15:52,167 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:15:52 INFO - 2015-11-17 05:15:52,167 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:15:52 INFO - 2015-11-17 05:15:52,167 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:15:52 INFO - 2015-11-17 05:15:52,167 DEBUG : BROWSER_OUTPUT: __metrics 05:15:52 INFO - 2015-11-17 05:15:52,187 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:15:52 INFO - 2015-11-17 05:15:52,879 INFO : Browser initialized. 05:15:52 INFO - 2015-11-17 05:15:52,879 INFO : Running cycle 1/1 for kraken test... 05:15:52 INFO - 2015-11-17 05:15:52,879 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/tmpoxlrkx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:16:04 INFO - 2015-11-17 05:16:04,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 230105088 05:16:04 INFO - 2015-11-17 05:16:04,829 DEBUG : BROWSER_OUTPUT: 05:16:07 INFO - 2015-11-17 05:16:07,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection) 05:16:07 INFO - 2015-11-17 05:16:07,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 284979200 05:16:07 INFO - 2015-11-17 05:16:07,975 DEBUG : BROWSER_OUTPUT: 05:16:10 INFO - 2015-11-17 05:16:10,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-dft) 05:16:11 INFO - 2015-11-17 05:16:11,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 297947136 05:16:11 INFO - 2015-11-17 05:16:11,198 DEBUG : BROWSER_OUTPUT: 05:16:14 INFO - 2015-11-17 05:16:14,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-fft) 05:16:14 INFO - 2015-11-17 05:16:14,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 280662016 05:16:14 INFO - 2015-11-17 05:16:14,732 DEBUG : BROWSER_OUTPUT: 05:16:16 INFO - 2015-11-17 05:16:16,801 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator) 05:16:17 INFO - 2015-11-17 05:16:17,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 282447872 05:16:17 INFO - 2015-11-17 05:16:17,383 DEBUG : BROWSER_OUTPUT: 05:16:19 INFO - 2015-11-17 05:16:19,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:16:20 INFO - 2015-11-17 05:16:20,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 283676672 05:16:20 INFO - 2015-11-17 05:16:20,143 DEBUG : BROWSER_OUTPUT: 05:16:23 INFO - 2015-11-17 05:16:23,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom) 05:16:23 INFO - 2015-11-17 05:16:23,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 284364800 05:16:23 INFO - 2015-11-17 05:16:23,755 DEBUG : BROWSER_OUTPUT: 05:16:26 INFO - 2015-11-17 05:16:26,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate) 05:16:27 INFO - 2015-11-17 05:16:27,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 284188672 05:16:27 INFO - 2015-11-17 05:16:27,475 DEBUG : BROWSER_OUTPUT: 05:16:30 INFO - 2015-11-17 05:16:30,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial) 05:16:30 INFO - 2015-11-17 05:16:30,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 284930048 05:16:30 INFO - 2015-11-17 05:16:30,891 DEBUG : BROWSER_OUTPUT: 05:16:32 INFO - 2015-11-17 05:16:32,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:16:33 INFO - 2015-11-17 05:16:33,027 DEBUG : BROWSER_OUTPUT: RSS: Main: 318439424 05:16:33 INFO - 2015-11-17 05:16:33,027 DEBUG : BROWSER_OUTPUT: 05:16:34 INFO - 2015-11-17 05:16:34,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:16:35 INFO - 2015-11-17 05:16:35,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 318775296 05:16:35 INFO - 2015-11-17 05:16:35,493 DEBUG : BROWSER_OUTPUT: 05:16:37 INFO - 2015-11-17 05:16:37,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:16:38 INFO - 2015-11-17 05:16:38,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 326758400 05:16:38 INFO - 2015-11-17 05:16:38,163 DEBUG : BROWSER_OUTPUT: 05:16:40 INFO - 2015-11-17 05:16:40,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:16:41 INFO - 2015-11-17 05:16:41,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 327827456 05:16:41 INFO - 2015-11-17 05:16:41,364 DEBUG : BROWSER_OUTPUT: 05:16:44 INFO - 2015-11-17 05:16:44,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:16:44 INFO - 2015-11-17 05:16:44,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 327806976 05:16:44 INFO - 2015-11-17 05:16:44,585 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,322 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49263/tests/kraken/driver.html?testName=ai-astar) 05:16:46 INFO - 2015-11-17 05:16:46,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 386727936 05:16:46 INFO - 2015-11-17 05:16:46,583 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,583 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:16:46 INFO - 2015-11-17 05:16:46,583 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:16:46 INFO - 2015-11-17 05:16:46,583 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:16:46 INFO - 2015-11-17 05:16:46,583 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:16:46 INFO - 2015-11-17 05:16:46,583 DEBUG : BROWSER_OUTPUT: |0;ai-astar;105;107;101;108;107;106;94;105;98;105 05:16:46 INFO - 2015-11-17 05:16:46,583 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;129;149;161;130;152;147;124;163;126 05:16:46 INFO - 2015-11-17 05:16:46,583 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;163;161;160;162;162;162;163;164;161 05:16:46 INFO - 2015-11-17 05:16:46,584 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;79;88;84;67;69;70;79;84;80 05:16:46 INFO - 2015-11-17 05:16:46,584 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;99;97;133;88;89;88;127;88;89;135 05:16:46 INFO - 2015-11-17 05:16:46,584 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;119;114;119;120;120;114;114;115;120 05:16:46 INFO - 2015-11-17 05:16:46,584 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;126;126;125;125;126;126;125;125;126;126 05:16:46 INFO - 2015-11-17 05:16:46,584 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;92;94;101;95;95;95;101;93;99;104 05:16:46 INFO - 2015-11-17 05:16:46,584 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;59;59;59;59;58;68;58;58 05:16:46 INFO - 2015-11-17 05:16:46,584 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;71;70;71;70;69;70;71 05:16:46 INFO - 2015-11-17 05:16:46,584 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;85;84;86;85;86;86;87;86;85 05:16:46 INFO - 2015-11-17 05:16:46,584 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;136;125;127;123;136;124;133;137;135;135 05:16:46 INFO - 2015-11-17 05:16:46,584 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;154;155;154;159;147;153;154;155;158 05:16:46 INFO - 2015-11-17 05:16:46,585 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;71;70;72;70;71;71;69;70 05:16:46 INFO - 2015-11-17 05:16:46,585 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:16:46 INFO - 2015-11-17 05:16:46,585 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:16:46 INFO - 2015-11-17 05:16:46,585 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,923 05:16:46 INFO - 2015-11-17 05:16:46,585 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:16:46 INFO - 2015-11-17 05:16:46,585 DEBUG : BROWSER_OUTPUT: __startTimestamp1447766206572__endTimestamp 05:16:46 INFO - 2015-11-17 05:16:46,585 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,585 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:16:46 INFO - 2015-11-17 05:16:46,585 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:16:46 INFO - 2015-11-17 05:16:46,586 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,586 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:103.60 Median:107.00 stddev:4.53 (4.2%) stddev-sans-first:4.77 05:16:46 INFO - 2015-11-17 05:16:46,586 DEBUG : BROWSER_OUTPUT: Values: 105.0 107.0 101.0 108.0 107.0 106.0 94.0 105.0 98.0 105.0 05:16:46 INFO - 2015-11-17 05:16:46,586 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,586 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.70 Median:150.50 stddev:15.04 (10.0%) stddev-sans-first:15.28 05:16:46 INFO - 2015-11-17 05:16:46,586 DEBUG : BROWSER_OUTPUT: Values: 156.0 129.0 149.0 161.0 130.0 152.0 147.0 124.0 163.0 126.0 05:16:46 INFO - 2015-11-17 05:16:46,586 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,586 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 05:16:46 INFO - 2015-11-17 05:16:46,586 DEBUG : BROWSER_OUTPUT: Values: 161.0 163.0 161.0 160.0 162.0 162.0 162.0 163.0 164.0 161.0 05:16:46 INFO - 2015-11-17 05:16:46,587 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,587 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:77.40 Median:79.50 stddev:7.12 (9.0%) stddev-sans-first:7.45 05:16:46 INFO - 2015-11-17 05:16:46,587 DEBUG : BROWSER_OUTPUT: Values: 74.0 79.0 88.0 84.0 67.0 69.0 70.0 79.0 84.0 80.0 05:16:46 INFO - 2015-11-17 05:16:46,587 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,587 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.30 Median:88.50 stddev:20.05 (22.7%) stddev-sans-first:21.21 05:16:46 INFO - 2015-11-17 05:16:46,587 DEBUG : BROWSER_OUTPUT: Values: 99.0 97.0 133.0 88.0 89.0 88.0 127.0 88.0 89.0 135.0 05:16:46 INFO - 2015-11-17 05:16:46,587 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,587 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:119.50 stddev:2.84 (2.4%) stddev-sans-first:2.86 05:16:46 INFO - 2015-11-17 05:16:46,587 DEBUG : BROWSER_OUTPUT: Values: 120.0 119.0 114.0 119.0 120.0 120.0 114.0 114.0 115.0 120.0 05:16:46 INFO - 2015-11-17 05:16:46,587 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,588 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:125.60 Median:126.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:16:46 INFO - 2015-11-17 05:16:46,588 DEBUG : BROWSER_OUTPUT: Values: 126.0 126.0 125.0 125.0 126.0 126.0 125.0 125.0 126.0 126.0 05:16:46 INFO - 2015-11-17 05:16:46,588 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,588 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.90 Median:94.50 stddev:4.04 (4.3%) stddev-sans-first:3.88 05:16:46 INFO - 2015-11-17 05:16:46,588 DEBUG : BROWSER_OUTPUT: Values: 92.0 94.0 101.0 95.0 95.0 95.0 101.0 93.0 99.0 104.0 05:16:46 INFO - 2015-11-17 05:16:46,588 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,588 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.50 Median:59.00 stddev:3.03 (5.1%) stddev-sans-first:3.21 05:16:46 INFO - 2015-11-17 05:16:46,588 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 59.0 59.0 59.0 59.0 58.0 68.0 58.0 58.0 05:16:46 INFO - 2015-11-17 05:16:46,588 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,589 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:1.16 (1.7%) stddev-sans-first:1.05 05:16:46 INFO - 2015-11-17 05:16:46,589 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 71.0 70.0 71.0 70.0 69.0 70.0 71.0 05:16:46 INFO - 2015-11-17 05:16:46,589 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,589 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.00 stddev:0.95 (1.1%) stddev-sans-first:0.88 05:16:46 INFO - 2015-11-17 05:16:46,589 DEBUG : BROWSER_OUTPUT: Values: 87.0 85.0 84.0 86.0 85.0 86.0 86.0 87.0 86.0 85.0 05:16:46 INFO - 2015-11-17 05:16:46,589 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,589 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:135.00 stddev:5.65 (4.2%) stddev-sans-first:5.70 05:16:46 INFO - 2015-11-17 05:16:46,589 DEBUG : BROWSER_OUTPUT: Values: 136.0 125.0 127.0 123.0 136.0 124.0 133.0 137.0 135.0 135.0 05:16:46 INFO - 2015-11-17 05:16:46,589 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,589 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.90 Median:154.50 stddev:5.55 (3.6%) stddev-sans-first:3.39 05:16:46 INFO - 2015-11-17 05:16:46,590 DEBUG : BROWSER_OUTPUT: Values: 140.0 154.0 155.0 154.0 159.0 147.0 153.0 154.0 155.0 158.0 05:16:46 INFO - 2015-11-17 05:16:46,590 DEBUG : BROWSER_OUTPUT: 05:16:46 INFO - 2015-11-17 05:16:46,590 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 05:16:46 INFO - 2015-11-17 05:16:46,590 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 70.0 72.0 70.0 71.0 71.0 69.0 70.0 05:16:46 INFO - 2015-11-17 05:16:46,590 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:16:46 INFO - 2015-11-17 05:16:46,590 DEBUG : BROWSER_OUTPUT: 05:16:47 INFO - 2015-11-17 05:16:47,248 INFO : Browser exited with error code: 0 05:16:47 INFO - 2015-11-17 05:16:47,297 INFO : Completed test kraken (00:00:57) 05:16:47 INFO - 2015-11-17 05:16:47,297 INFO : Starting test v8_7 05:16:47 INFO - 2015-11-17 05:16:47,297 DEBUG : operating with platform_type : mac_ 05:16:47 INFO - 2015-11-17 05:16:47,297 INFO : Initialising browser for v8_7 test... 05:16:47 INFO - 2015-11-17 05:16:47,311 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/tmpob8_op/profile http://localhost:49263/getInfo.html 05:16:49 INFO - 2015-11-17 05:16:49,529 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:16:49 INFO - 2015-11-17 05:16:49,529 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:16:49 INFO - 2015-11-17 05:16:49,529 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:16:49 INFO - 2015-11-17 05:16:49,529 DEBUG : BROWSER_OUTPUT: __metrics 05:16:49 INFO - 2015-11-17 05:16:49,545 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:16:50 INFO - 2015-11-17 05:16:50,255 INFO : Browser initialized. 05:16:50 INFO - 2015-11-17 05:16:50,255 INFO : Running cycle 1/1 for v8_7 test... 05:16:50 INFO - 2015-11-17 05:16:50,256 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/T/tmpob8_op/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:17:02 INFO - 2015-11-17 05:17:02,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 229965824 05:17:02 INFO - 2015-11-17 05:17:02,193 DEBUG : BROWSER_OUTPUT: 05:17:23 INFO - 2015-11-17 05:17:23,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/v8_7/run.html (next: http://localhost:49263/tests/v8_7/run.html) 05:17:23 INFO - 2015-11-17 05:17:23,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 613412864 05:17:23 INFO - 2015-11-17 05:17:23,969 DEBUG : BROWSER_OUTPUT: 05:17:23 INFO - 2015-11-17 05:17:23,969 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:17:23 INFO - 2015-11-17 05:17:23,970 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:17:23 INFO - 2015-11-17 05:17:23,970 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:17:23 INFO - 2015-11-17 05:17:23,970 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:17:23 INFO - 2015-11-17 05:17:23,970 DEBUG : BROWSER_OUTPUT: |0;Richards;166.30633627141194 05:17:23 INFO - 2015-11-17 05:17:23,970 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;199.6007984031936 05:17:23 INFO - 2015-11-17 05:17:23,971 DEBUG : BROWSER_OUTPUT: |2;Encrypt;327.54667540124467 05:17:23 INFO - 2015-11-17 05:17:23,971 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5725.714285714285 05:17:23 INFO - 2015-11-17 05:17:23,971 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1930.5019305019305 05:17:23 INFO - 2015-11-17 05:17:23,971 DEBUG : BROWSER_OUTPUT: |5;Earley;1022.4719101123595 05:17:23 INFO - 2015-11-17 05:17:23,971 DEBUG : BROWSER_OUTPUT: |6;Boyer;14211.267605633802 05:17:23 INFO - 2015-11-17 05:17:23,971 DEBUG : BROWSER_OUTPUT: |7;RegExp;30969.696969696968 05:17:23 INFO - 2015-11-17 05:17:23,972 DEBUG : BROWSER_OUTPUT: |8;Splay;1038.4215991692627 05:17:23 INFO - 2015-11-17 05:17:23,972 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5934.91124260355 05:17:23 INFO - 2015-11-17 05:17:23,972 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:17:23 INFO - 2015-11-17 05:17:23,972 DEBUG : BROWSER_OUTPUT: __startTimestamp1447766243969__endTimestamp 05:17:23 INFO - 2015-11-17 05:17:23,972 DEBUG : BROWSER_OUTPUT: 05:17:23 INFO - 2015-11-17 05:17:23,972 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:17:23 INFO - 2015-11-17 05:17:23,973 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:17:23 INFO - 2015-11-17 05:17:23,973 DEBUG : BROWSER_OUTPUT: 05:17:23 INFO - 2015-11-17 05:17:23,973 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.31 Median:166.31 stddev:0.00 (0.0%) 05:17:23 INFO - 2015-11-17 05:17:23,973 DEBUG : BROWSER_OUTPUT: Values: 166.3 05:17:23 INFO - 2015-11-17 05:17:23,973 DEBUG : BROWSER_OUTPUT: 05:17:23 INFO - 2015-11-17 05:17:23,973 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:199.60 Median:199.60 stddev:0.00 (0.0%) 05:17:23 INFO - 2015-11-17 05:17:23,974 DEBUG : BROWSER_OUTPUT: Values: 199.6 05:17:23 INFO - 2015-11-17 05:17:23,974 DEBUG : BROWSER_OUTPUT: 05:17:23 INFO - 2015-11-17 05:17:23,974 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:327.55 Median:327.55 stddev:0.00 (0.0%) 05:17:23 INFO - 2015-11-17 05:17:23,974 DEBUG : BROWSER_OUTPUT: Values: 327.5 05:17:23 INFO - 2015-11-17 05:17:23,974 DEBUG : BROWSER_OUTPUT: 05:17:23 INFO - 2015-11-17 05:17:23,975 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5725.71 Median:5725.71 stddev:0.00 (0.0%) 05:17:23 INFO - 2015-11-17 05:17:23,976 DEBUG : BROWSER_OUTPUT: Values: 5725.7 05:17:23 INFO - 2015-11-17 05:17:23,976 DEBUG : BROWSER_OUTPUT: 05:17:23 INFO - 2015-11-17 05:17:23,976 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1930.50 Median:1930.50 stddev:0.00 (0.0%) 05:17:23 INFO - 2015-11-17 05:17:23,976 DEBUG : BROWSER_OUTPUT: Values: 1930.5 05:17:23 INFO - 2015-11-17 05:17:23,976 DEBUG : BROWSER_OUTPUT: 05:17:23 INFO - 2015-11-17 05:17:23,976 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1022.47 Median:1022.47 stddev:0.00 (0.0%) 05:17:23 INFO - 2015-11-17 05:17:23,976 DEBUG : BROWSER_OUTPUT: Values: 1022.5 05:17:23 INFO - 2015-11-17 05:17:23,976 DEBUG : BROWSER_OUTPUT: 05:17:23 INFO - 2015-11-17 05:17:23,976 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14211.27 Median:14211.27 stddev:0.00 (0.0%) 05:17:23 INFO - 2015-11-17 05:17:23,977 DEBUG : BROWSER_OUTPUT: Values: 14211.3 05:17:23 INFO - 2015-11-17 05:17:23,977 DEBUG : BROWSER_OUTPUT: 05:17:23 INFO - 2015-11-17 05:17:23,977 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30969.70 Median:30969.70 stddev:0.00 (0.0%) 05:17:23 INFO - 2015-11-17 05:17:23,977 DEBUG : BROWSER_OUTPUT: Values: 30969.7 05:17:23 INFO - 2015-11-17 05:17:23,977 DEBUG : BROWSER_OUTPUT: 05:17:23 INFO - 2015-11-17 05:17:23,977 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:1038.42 Median:1038.42 stddev:0.00 (0.0%) 05:17:23 INFO - 2015-11-17 05:17:23,977 DEBUG : BROWSER_OUTPUT: Values: 1038.4 05:17:23 INFO - 2015-11-17 05:17:23,977 DEBUG : BROWSER_OUTPUT: 05:17:23 INFO - 2015-11-17 05:17:23,978 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5934.91 Median:5934.91 stddev:0.00 (0.0%) 05:17:23 INFO - 2015-11-17 05:17:23,978 DEBUG : BROWSER_OUTPUT: Values: 5934.9 05:17:23 INFO - 2015-11-17 05:17:23,978 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:17:23 INFO - 2015-11-17 05:17:23,978 DEBUG : BROWSER_OUTPUT: 05:17:24 INFO - 2015-11-17 05:17:24,659 INFO : Browser exited with error code: 0 05:17:24 INFO - 2015-11-17 05:17:24,679 INFO : Completed test v8_7 (00:00:37) 05:17:25 INFO - 2015-11-17 05:17:25,038 INFO : Completed test suite (00:20:11) 05:17:25 INFO - 2015-11-17 05:17:25,038 DEBUG : Working with test: dromaeo_css 05:17:25 INFO - 2015-11-17 05:17:25,038 DEBUG : Generating results file: dromaeo_css 05:17:25 INFO - 2015-11-17 05:17:25,039 DEBUG : Working with test: kraken 05:17:25 INFO - 2015-11-17 05:17:25,039 DEBUG : Generating results file: kraken 05:17:25 INFO - 2015-11-17 05:17:25,039 INFO : javascript benchmark 05:17:25 INFO - 2015-11-17 05:17:25,040 DEBUG : Working with test: v8_7 05:17:25 INFO - 2015-11-17 05:17:25,040 DEBUG : Generating results file: v8_7 05:17:25 INFO - 2015-11-17 05:17:25,040 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:17:25 INFO - 2015-11-17 05:17:25,108 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 05:17:25 INFO - 2015-11-17 05:17:25,108 DEBUG : process_Request line: dromaeo_css 6361.26 graph.html#tests=[[72,1,55]] 05:17:25 INFO - 2015-11-17 05:17:25,108 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:17:25 INFO - 2015-11-17 05:17:25,141 DEBUG : process_Request line: kraken 1499.30 graph.html#tests=[[232,1,55]] 05:17:25 INFO - 2015-11-17 05:17:25,141 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:17:25 INFO - 2015-11-17 05:17:25,174 DEBUG : process_Request line: v8_7 16883.57 graph.html#tests=[[230,1,55]] 05:17:25 INFO - 2015-11-17 05:17:25,175 INFO : javascript benchmark 05:17:25 INFO - 2015-11-17 05:17:25,177 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [311.15676516639905, 319.9330233670708, 322.9192701824544, 329.2000438933392, 333.4298349821805, 13773.173609583431, 14037.50868719595, 17399.739003914936, 17776.55558611034, 18477.53806154847, 12264.264144151335, 12858.807117893239, 16772.58068548287, 17038.574035649115, 17056.914715426406, 5013.197888337867, 5237.685738855681, 5244.187150991584, 5255.054090263751, 5317.0, 3236.3203727217197, 4486.641068714495, 5215.322008138936, 5222.529972302492, 5246.632735708502, 3393.100828280508, 4504.301833215857, 4675.859724208279, 4743.0, 4744.976275118637, 4657.767111644421, 4674.182018146811, 4696.225122854725, 4708.10545996263, 4716.4340279166545, 3879.0690234343556, 3880.8835734927998, 3883.8446462141483, 3900.609939006105, 3920.941185882214, 12052.698682533006, 12472.501099956082, 12580.937095314464, 12691.809622855664, 12693.428795704123, 1760.10234780263, 1795.5780391607962, 1800.79290881549, 1856.1368963431935, 1922.3079691311116, 9091.909080909172, 9102.04428535001, 9250.629974801, 9353.111454411888, 9402.435853848723, 1440.8415074341815, 1442.6537630968596, 1490.6646004648976, 1522.8401017893184, 1545.0, 53737.73131134358, 54587.727061364436, 54794.452055479334, 55674.443255567334, 56110.719446402916, 5991.700414979321, 6159.23009623797, 6176.7838125665385, 6211.720472578745, 6412.583182093149, 7091.645417729196, 7161.319674630901, 7174.964125179341, 7192.892106618405, 7235.819104522324, 5215.24378965048, 5269.314989051399, 5270.341207349082, 5286.60350473716, 5377.0, 5667.121596152603, 5682.488576028178, 5705.229793977843, 5711.114777209539, 5719.7712091516705, 2825.7598104161375, 2834.801563890549, 2841.1902607756692, 2845.558938364557, 2864.4414339204072, 984.1437948984429, 989.3964681544252, 991.5389343955095, 994.1897353656891, 1053.9249965035622, 335.3879170513822, 383.5359215349458, 385.77817754791107, 396.76590811420823, 454.2096751652102, 10683.465826708634, 10900.236983411085, 11300.773984520263, 11374.260673056226, 11414.143939204427, 427.0135985872644, 427.8673611180544, 431.2065798929984, 436.13644982933334, 465.76478878166307, 5792.362840087587, 6064.939350606525, 6080.300765412034, 6113.786017489367, 6193.318734939153, 462891.0, 463822.0, 548006.0, 549566.0, 571323.0, 62891.0, 65689.0, 66910.33089669042, 67819.3218067813, 68256.31743682499, 468.0778865634694, 481.662836014791, 485.3375142929875, 485.621215451941, 491.98278060267717, 10278.02358775945, 10299.897001029894, 10460.110890574386, 10551.577936882746, 10839.674809755405, 30970.69029309678, 31668.0, 31810.363792724478, 33267.16832079121, 33296.66703333033, 41444.0, 44891.55108448874, 45114.0, 46013.53986460093, 47101.293480598506, 5915.319738230159, 6003.549733769897, 6014.548908831767, 6030.6080104793045, 6056.3035250946705, 10689.786204276026, 11261.71845703864, 11394.25937314072, 11553.82669259945, 11597.76804463923, 9465.47939863314, 9535.52322383892, 9689.0, 9803.754906127404, 9867.0, 9282.30382721285, 9360.719178424659, 9466.384684995728, 9490.383125096847, 9538.23694104484, 9812.705618831447, 9821.312508124363, 9832.508374581099, 9865.753356166153, 9895.406275623198, 5824.21373114641, 5875.383084776208, 5903.0555111182, 5929.229200203946, 5933.050711886078, 9551.936545439281, 9617.278704097082, 9830.55762490704, 9991.900080999098, 10063.798724025331], "dojo.html": [3138.1840721412427, 3162.7627927905405, 3241.335526217126, 3250.5286733423654, 3257.641659417464, 4977.452480227172, 5113.33526641537, 5128.820491282806, 5178.741062946857, 5213.921791173136, 5091.821786237482, 5149.150390185615, 5182.2226666000115, 5293.364796224459, 5295.338082739658, 4733.763311834412, 4734.195186818232, 4736.218523943545, 4742.739149346785, 4845.903081938359, 4413.911721765563, 4795.256735206049, 4838.225883858583, 4842.636802239828, 4897.485763994782, 4511.368408422823, 4597.517260687647, 4632.119897219518, 4641.976790116028, 4790.712557246559, 4650.023495066041, 4653.046125544289, 4657.510961349043, 4673.369095172142, 4702.059588082398, 4674.088552732219, 4676.649251306131, 4733.077049975256, 4760.23836186212, 4771.594414474774, 4932.901341973176, 5079.0, 5083.212102124176, 5098.133317336062, 5133.537981581639, 5369.19462080691, 5394.05604019299, 5395.298611180521, 5408.215808707755, 5417.59368047394, 5360.088784906575, 5361.437049109865, 5373.75818088183, 5382.6232163748555, 5514.420985796473, 5052.040112378636, 5060.139776238048, 5065.417476990119, 5076.086304465195, 5103.897922041576, 5428.131498960148, 5476.424975377528, 5538.169274608841, 5563.638363506359, 5570.192322113271, 5165.40859208512, 5291.656042357235, 5317.282166907496, 5332.2801421808335, 5364.892702145935, 5499.972500137474, 5506.752196151103, 5535.667859928337, 5565.30433695788, 5646.463585959327, 5143.12566863634, 5423.484768946943, 5429.701366424884, 5444.8366549003595, 5461.508464238238, 5442.0, 5457.099578569491, 5496.587755918322, 5524.475174858382, 5634.802781902614, 4232.682548808852, 4242.490901091889, 4253.106847562047, 4265.850695225652, 4318.0, 3743.9625603743616, 3844.826982785781, 3849.9037524061564, 3866.5940076292145, 3911.78485183312, 5111.897762044739, 5115.232715092766, 5125.589952803767, 5138.691678499302, 5152.793888244429, 5290.391604965402, 5430.538404235605, 5447.319085114361, 5491.725413729378, 5558.360788509292, 5133.666311689728, 5141.845744627667, 5148.768305426265, 5161.716105614228, 5163.380394352702, 4817.518248175154, 4836.661433699607, 4838.564529192389, 4859.392575928009, 4869.245266983623, 5567.3040869891265, 5661.716914154194, 5694.629849059881, 5710.086386178192, 5809.680467574324, 5448.346198456052, 5469.753861076181, 5470.370907345706, 5490.752916118864, 5506.531944784738, 5604.747786349705, 5626.465485778845, 5630.634008789416, 5658.490735833795, 5687.77248910039, 5105.846824595268, 5266.683998960075, 5363.490468405495, 5383.81156659515, 5466.316710411199, 5453.0, 5557.749901254372, 5561.805336813192, 5593.972030139823, 5692.402297758841, 5413.350397952271, 5444.646098003617, 5513.61404701667, 5522.91715624274, 5532.336119665666, 5184.507471790174, 5278.4721527846905, 5433.293671822637, 5460.945390546044, 5497.065498865122, 5242.947570524246, 5262.447443018428, 5270.209468579744, 5283.577313814809, 5297.947020529899, 5415.756290966837, 5434.5652347812875, 5472.315960504937, 5476.0, 5494.011078005998, 5218.556422704112, 5319.893602128013, 5353.250544923636, 5369.946300536944, 5392.245085687929], "mootools.html": [1209.3529961470615, 1708.4276767282959, 1710.1791140252678, 1740.2777847193408, 1770.6458708258347, 6782.864342713149, 7008.929910700898, 7072.292770722932, 7277.636118194096, 7319.670614822332, 7469.738559150431, 7602.847943041136, 7610.923890761091, 7637.809054773619, 7668.961655191716, 2133.743950725915, 2165.5127596290868, 2167.219800871685, 2172.087723156278, 2175.6192666283337, 2223.7776222377793, 2242.9775702243014, 2276.169198242638, 2280.5062683942047, 2299.54009198161, 2185.0058223508267, 2187.136081247906, 2211.5466329402434, 2213.6458166693333, 2222.0000999550184, 2169.4684802223396, 2192.506685995654, 2198.0, 2198.791114844087, 2203.383052745226, 2234.519578290659, 2246.730392352928, 2257.0, 2261.9886900565557, 2272.4659704969317, 7474.4767866249385, 7523.774286771406, 7539.396848252127, 7555.584442855641, 7657.157712651604, 4036.9596304036877, 4254.361845723135, 4692.389989301403, 4760.738159401231, 4765.499622539618, 2571.961420578693, 2646.192911162095, 2728.6043523689154, 2765.267204190891, 2777.8611069446647, 787.6770524085155, 794.5391672829745, 1484.7772834074867, 1511.470985155198, 1549.8992565483209, 9886.604535818558, 10045.296829221958, 10094.0, 10179.18566514677, 10184.643537476153, 4158.792060396968, 4183.686223533247, 4255.212785634668, 4277.721948073366, 4282.807273672693, 8143.674253029931, 8181.0, 8222.917770822334, 8237.83524329522, 8268.0, 4790.760461976887, 4803.351547541037, 4809.879753006203, 4813.614910807127, 4836.782344794493, 4407.184670835842, 4414.139242847678, 4416.492103408149, 4445.088756804847, 4483.730976141442, 3243.9675603244136, 3289.9506507402407, 3302.4220761366664, 3303.3228188221356, 3337.0823023668686, 999.7950420163849, 1007.9496025198857, 1020.5968642386364, 1027.8612387327764, 1037.8910214427528, 978.9167920726676, 1005.8994100590029, 1006.8741407324085, 1112.4938153140301, 1310.600266918599, 7149.571025738473, 7171.175314838756, 7200.207977122513, 7211.3870321023305, 7220.711171553184, 1064.435849000031, 1122.4612186150694, 1141.634676903383, 1204.084895479442, 1223.2049168040667, 5229.895402091937, 5520.171974203901, 5586.190002449622, 5597.608167428322, 5642.915356269659, 7813.335866451302, 8541.316694664412, 8970.551472426352, 8979.910200898039, 9031.0, 8821.911780882108, 8964.551772411354, 8976.371653984159, 9049.819003620023, 9089.363744537952, 7092.574445533284, 7152.92847071533, 7193.460490463236, 7293.015442915244, 7357.264273572707, 7055.259197784364, 7113.893291600733, 7142.107236595426, 7168.2831716827895, 7254.600996945219, 7526.209747976383, 8127.3091787198755, 8133.79665508367, 8184.918150818416, 8286.502809831429, 8104.675812967651, 8205.671773129247, 8223.09545949957, 8303.086660467223, 8330.541820199947, 6722.697478613376, 6744.730210791709, 6762.256151823394, 6776.7628133015105, 6837.692303846239, 7279.781606551812, 7348.77953661391, 7374.299441553044, 7449.0, 7497.962510187414, 6836.350546698056, 6843.0, 6904.13698287714, 6939.6877140529805, 6948.9305106950305, 6530.640814755234, 6719.294474080151, 6769.849125648553, 6853.17761868579, 6864.965675171592, 6826.726930922906, 6831.6242606657115, 6855.5543889647015, 6924.238333783179, 6963.79108626742, 6153.446189842935, 6193.659348735682, 6219.315875253809, 6223.937760622336, 6276.246850377984, 5563.666180029211, 5848.883022339444, 5994.31065427464, 6206.782762603287, 6309.1167236586], "ext.html": [525.6031696069467, 526.4077912348608, 528.62995902868, 544.1266766839223, 552.5827999860105, 29583.852080739594, 30271.394572108544, 37110.25779484409, 37192.0, 37910.725356478564, 40416.79791601038, 40636.79681601588, 41169.382459263135, 41469.792651036776, 41516.37725434121, 7764.844703105934, 8831.95584022079, 8951.597178127, 9074.591643376063, 9088.182063614273, 7954.443188976774, 10451.634192803253, 10541.0, 10553.314034587765, 10769.62306319279, 10427.739306517322, 10517.421541815198, 10587.73530661732, 10616.840747388756, 10725.624603138891, 8042.758717238492, 8190.140035296327, 10344.896551034468, 10380.325278856888, 10410.791784164312, 10194.082532572103, 10357.585696572129, 10359.844602330972, 10396.584136634525, 10500.474976251156, 37121.44317835208, 37503.624963750284, 37698.05754856123, 37958.43062354067, 38011.61988380108, 2815.7747380209535, 2818.210900947738, 2826.0956493921954, 2871.3539453622975, 3067.9233019174476, 26027.73972260272, 26708.732912670817, 26743.19770406891, 26795.196144115707, 27022.5946610801, 2298.2300929188573, 2342.6251799711963, 2349.7180338359335, 2350.6356514740073, 2497.438076432806, 243906.0, 244468.0, 245452.0, 246022.0, 248556.75721621458, 48397.27404088942, 48793.268100978516, 55376.0, 55798.721006394706, 59237.0, 55472.445275547536, 55624.44375556274, 55718.72140639271, 56051.15923261154, 56586.71706641441, 15135.697286054217, 15262.08427494354, 15329.31018104188, 15356.462523811613, 15359.846401536066, 10478.476076196159, 10485.161187105014, 10487.94756026215, 10545.367277963347, 10552.0, 17518.29926802939, 17706.91146544259, 17741.911290443466, 17850.464486065437, 17873.19570619325, 7661.808454788675, 7787.610619469004, 7841.451098423056, 7846.0, 7888.960555197187, 876.2595606712318, 889.2397000564424, 1010.161565900301, 1027.6140118310186, 1035.0167341026056, 26672.733272667414, 27219.319517012234, 27488.58767118495, 28099.297517561816, 28758.568621470276, 971.6962328084428, 995.0745806399973, 1042.4683411460057, 1048.2976405808126, 1065.9626913058005, 13217.867821321855, 13402.798958015637, 13516.391762370717, 13591.184528928296, 14228.430862765581, 278481.0, 285176.0, 285891.0, 286456.0, 288223.0, 51809.99999999924, 51815.74092129515, 51923.22115168275, 51932.0, 51974.22038669423, 1303.1073714505594, 1312.5078095714107, 1313.4680454416168, 1315.4080663701372, 1329.6808765896308, 26925.865370673022, 27023.59464607993, 27572.44855102927, 27707.58438623382, 27800.0, 44637.55362446334, 45229.477052294504, 45266.773666131456, 45283.54716452793, 45305.546944530135, 248167.0, 250188.0, 252185.0, 252190.0, 253622.0, 25668.743312566636, 25748.8712556436, 26235.868820655774, 26262.4747505045, 27975.0, 30775.230619233804, 35980.10049748777, 35988.46017309795, 36037.45943810898, 36155.45766813447, 25247.99713734773, 30128.698713013466, 30500.694993049787, 30696.0, 30984.69015309818, 30083.69916300809, 30401.23996900095, 30537.847310763304, 30604.305006899474, 30966.0, 28194.2951426216, 28214.43571128607, 31795.52306715355, 33085.17287067843, 33109.33781324312, 24761.25716228516, 30353.62919495726, 30478.862271563597, 30602.693973059984, 30662.0, 21823.635272945157, 22003.889980549993, 22180.334589962327, 22198.667019995035, 22242.555148897256], "prototype.html": [298.80279015849544, 302.91518374855036, 308.1018830110229, 308.42170929507176, 308.74528513975974, 6064.818055458338, 6153.200083989081, 6201.565890387664, 6206.627602343857, 6208.286047104584, 5811.4479124483105, 5886.411358864122, 5970.910436343458, 6078.422549857756, 6154.107654390111, 4612.584867361937, 4632.5135860734645, 4649.163150632885, 4654.301854721802, 4703.600193983515, 4631.328457373679, 4632.3283123947, 4663.5336466353265, 4690.413698287714, 4708.0, 4431.756253406062, 4498.347739577759, 4564.634829213672, 4601.838935637254, 4629.398178236825, 4583.060472603109, 4608.4700259470255, 4635.165670179366, 4645.0, 4656.348111264426, 3964.1873415949663, 3971.205758848242, 3973.165635216608, 4039.939400908989, 4044.737092089005, 5829.4753472187285, 5944.227250457456, 5979.730912108966, 6052.364501727299, 6059.787907423219, 5257.579393648499, 5264.8683782905355, 5284.286621306152, 5311.920321195185, 5318.574514038906, 6377.457916077139, 6419.711112999927, 6422.967885160591, 6425.871482570369, 6447.580907241015, 4356.825726970949, 4358.063016451447, 4361.476622805252, 4387.451568553931, 4416.580424859633, 6483.341829849786, 6716.194056713226, 6719.361660642231, 6780.32196780318, 6816.829579260509, 4455.1980643484485, 4461.330800379904, 4463.2635615123145, 4514.977425112854, 4519.367288579601, 4522.751248681354, 4526.909461810746, 4546.65900057497, 4550.772461376918, 4567.132244873464, 5235.554977826851, 5237.5286224239235, 5255.159174532133, 5301.522862942354, 5318.175682769177, 6221.47117495018, 6391.744330226832, 6486.124373209651, 6509.772157974543, 6511.153550038464, 1567.8432156784231, 1583.073901767479, 1590.952271431859, 1594.8803839712068, 1596.345498345696, 1018.3228153278135, 1024.2727663359099, 1035.11497669493, 1043.5095505112586, 1054.3989925742253, 6058.27300723916, 6069.42049628906, 6126.479249263863, 6157.599756015845, 6181.907271390933, 6619.768308109289, 6636.369544893228, 6637.668116594151, 6643.368879956396, 6721.092652491851, 5975.342712301644, 6029.397060293935, 6058.182145410401, 6200.627962322275, 6213.378662133841, 3598.586162591283, 3611.476335931275, 3627.8186090695885, 3666.596674365871, 3672.7245456590863, 6912.928496083015, 6939.583624982517, 6989.37095661393, 7023.262557431498, 7034.824129396704, 6644.96677516619, 6905.447564194852, 6916.100906882174, 7001.894971575431, 7023.051887995055, 6924.723011079501, 6928.896066559006, 6983.336583024605, 7002.264762199998, 7047.189573199045, 6538.346165383614, 6734.292899245509, 6761.594304341756, 6765.019072234597, 6797.966010169917, 6560.0, 6579.144711187515, 6594.571352862049, 6679.0, 6681.465482761465, 6936.549124306904, 6961.443084553325, 7007.194172670208, 7017.894731579133, 7047.365737083687, 4455.977720111378, 4457.398251236172, 4471.888202794956, 4487.214737420873, 4509.9549004510845, 6479.5788273762055, 6701.631410272482, 6701.932980670131, 6740.460763138839, 6847.520673552804, 6480.254770701241, 6519.641419721961, 6568.113304703804, 6607.108040414675, 6609.0, 6341.778037768656, 6499.090127382265, 6515.543911926309, 6524.934750652433, 6601.636909969998, 6348.841278967878, 6350.079238510482, 6414.454771344488, 6445.291017988111, 6457.354264573693, 6510.316416776171, 6515.869682606227, 6551.279359270572, 6609.041688954979, 6610.966945165435, 6258.217722784652, 6396.776112836028, 6403.487720982217, 6435.388638079375, 6481.675916204076], "yui.html": [595.8173026542314, 600.3246347858659, 611.5902345428563, 622.2781573374884, 627.5920651576474, 11935.16453848231, 12245.693857653541, 12247.693807654812, 12260.81608775868, 12281.570145044925, 11216.607418740346, 11222.382768947704, 11306.03898668612, 11361.318320900751, 11514.827277590843, 833.4291010657719, 839.3159574946415, 846.1792061700172, 851.4252879306474, 859.4113032572676, 828.0477450931417, 843.2747836860295, 844.105248436656, 844.8901642786429, 844.907060223375, 867.3408209760596, 868.5743985447117, 871.4161511787086, 879.8064425826308, 882.294164668266, 864.1703964194412, 865.7143142762873, 866.6793286483978, 867.1848462445313, 867.2238346679686, 645.3739872323838, 650.7884937395318, 651.039716418284, 653.9084528166061, 655.5476721062452, 10267.691969240936, 10361.533730982124, 10386.844197337046, 10451.216158788122, 10515.84226236607, 9294.767630809216, 9311.76720581984, 9447.102525260088, 10138.6597708324, 10242.129418999393, 8056.355491560661, 8289.8342033159, 8483.44857584255, 8501.234888860032, 8664.78338041554, 2956.645202575705, 3024.2654930415233, 3057.2204087957653, 3090.2892334763133, 3090.3201295714907, 39995.40006899899, 40008.199836003114, 45191.54808451906, 45738.54261457376, 46122.308165377544, 8347.12355202695, 8525.957370213233, 8609.311255099703, 8722.956385218033, 9144.268458523302, 18078.5480362992, 18194.272229110687, 18220.63558728818, 18328.725069123975, 18397.724034139497, 6115.84710382244, 6259.7496100156395, 6298.433141017331, 6395.872082558323, 6576.901346479806, 3574.249407624428, 3594.6299250953352, 3596.118950857057, 3674.1365779041903, 3697.722670799647, 2791.190554739103, 2791.3021744563857, 2806.438712257516, 2819.7039310872474, 2819.9859000704864, 415.7505496701955, 415.75470472421415, 420.9284421648327, 421.5089420824766, 428.5136370219761, 462.7269910752672, 467.5091154288052, 472.1100725133149, 567.7870798450581, 575.8339362790383, 7330.135891286949, 7380.77857664271, 7411.6664750086375, 7458.73894413693, 7587.2412758723685, 486.59369426528536, 529.8622358186822, 577.8757567123089, 580.8132381583342, 590.2739630254811, 3377.6791204835995, 3852.7110466715108, 3890.980545097313, 3950.6049395060263, 4082.2243773682903, 56906.7154664224, 58004.0, 58324.0, 58378.0, 58482.707586461795, 49167.26249106266, 49552.50447495551, 49985.0, 50000.74999625052, 50005.49994500081, 40003.0, 41722.1655566887, 44605.55394446014, 44696.776516117214, 44771.55228447739, 7568.243175682388, 7789.64946577394, 7939.126696063313, 8007.199280071946, 8180.672773089248, 34091.14772130716, 34331.65668343285, 34673.0, 34817.65182348144, 35994.0, 36962.96703681216, 39868.60131398649, 44151.33772993343, 44245.33631995587, 45029.32456013228, 6862.0, 6997.475189360716, 7389.482736208413, 7479.58862262559, 7608.0, 10577.524011419351, 10864.402457864893, 10872.0, 10910.454477276264, 10981.61564345244, 10137.860215000434, 10225.181985440999, 10232.386056836614, 10473.31923424975, 10640.414777187329, 9561.139497445263, 10157.796844063225, 10333.793324133325, 10478.95210478946, 10492.0, 10381.792364152825, 10449.947750261505, 10471.371717696658, 10609.151267898395, 10690.19823513224, 7792.961035194788, 8098.056208988486, 8282.668693252203, 8836.0, 9092.227160691415, 7769.844603108019, 8312.293455056388, 8360.581970901309, 8420.536870471939, 8742.956285218534]}, "summary": {"lowerIsBetter": false, "suite": 6361.255143989602, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6402.775015227015, "unit": "ms", "value": 6402.775015227015}, "dojo.html": {"lowerIsBetter": false, "filtered": 5075.691620367559, "unit": "ms", "value": 5075.691620367559}, "mootools.html": {"lowerIsBetter": false, "filtered": 4358.285551474187, "unit": "ms", "value": 4358.285551474187}, "ext.html": {"lowerIsBetter": false, "filtered": 17183.237761392502, "unit": "ms", "value": 17183.237761392502}, "prototype.html": {"lowerIsBetter": false, "filtered": 4839.151093271065, "unit": "ms", "value": 4839.151093271065}, "yui.html": {"lowerIsBetter": false, "filtered": 5625.588190702931, "unit": "ms", "value": 5625.588190702931}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0015"}, "testrun": {"date": 1447765033, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117030105", "branch": "Firefox", "revision": "898c2c656e4b156c323416ef0c859915f3fd2308"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 163.0, 161.0, 160.0, 162.0, 162.0, 162.0, 163.0, 164.0, 161.0], "ai-astar": [105.0, 107.0, 101.0, 108.0, 107.0, 106.0, 94.0, 105.0, 98.0, 105.0], "imaging-gaussian-blur": [120.0, 119.0, 114.0, 119.0, 120.0, 120.0, 114.0, 114.0, 115.0, 120.0], "audio-beat-detection": [156.0, 129.0, 149.0, 161.0, 130.0, 152.0, 147.0, 124.0, 163.0, 126.0], "json-stringify-tinderbox": [68.0, 69.0, 68.0, 71.0, 70.0, 71.0, 70.0, 69.0, 70.0, 71.0], "stanford-crypto-pbkdf2": [140.0, 154.0, 155.0, 154.0, 159.0, 147.0, 153.0, 154.0, 155.0, 158.0], "json-parse-financial": [59.0, 58.0, 59.0, 59.0, 59.0, 59.0, 58.0, 68.0, 58.0, 58.0], "stanford-crypto-sha256-iterative": [71.0, 70.0, 71.0, 70.0, 72.0, 70.0, 71.0, 71.0, 69.0, 70.0], "audio-fft": [74.0, 79.0, 88.0, 84.0, 67.0, 69.0, 70.0, 79.0, 84.0, 80.0], "imaging-darkroom": [126.0, 126.0, 125.0, 125.0, 126.0, 126.0, 125.0, 125.0, 126.0, 126.0], "stanford-crypto-ccm": [136.0, 125.0, 127.0, 123.0, 136.0, 124.0, 133.0, 137.0, 135.0, 135.0], "audio-oscillator": [99.0, 97.0, 133.0, 88.0, 89.0, 88.0, 127.0, 88.0, 89.0, 135.0], "stanford-crypto-aes": [87.0, 85.0, 84.0, 86.0, 85.0, 86.0, 86.0, 87.0, 86.0, 85.0], "imaging-desaturate": [92.0, 94.0, 101.0, 95.0, 95.0, 95.0, 101.0, 93.0, 99.0, 104.0]}, "summary": {"lowerIsBetter": true, "suite": 1499.3, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 77.4, "unit": "ms", "value": 77.4}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 152.9, "unit": "ms", "value": 152.9}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 143.7, "unit": "ms", "value": 143.7}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 131.1, "unit": "ms", "value": 131.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 125.6, "unit": "ms", "value": 125.6}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 59.5, "unit": "ms", "value": 59.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.3, "unit": "ms", "value": 103.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 103.6, "unit": "ms", "value": 103.6}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.9, "unit": "ms", "value": 161.9}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 70.5, "unit": "ms", "value": 70.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.7, "unit": "ms", "value": 69.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 117.5, "unit": "ms", "value": 117.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.7, "unit": "ms", "value": 85.7}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.9, "unit": "ms", "value": 96.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0015"}, "testrun": {"date": 1447765033, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117030105", "branch": "Firefox", "revision": "898c2c656e4b156c323416ef0c859915f3fd2308"}}, {"talos_counters": {}, "results": {"DeltaBlue": [199.6007984031936], "Encrypt": [327.54667540124467], "NavierStokes": [5934.91124260355], "Decrypt": [5725.714285714285], "Splay": [1038.4215991692627], "Richards": [166.30633627141194], "RegExp": [30969.696969696968], "Earley": [1022.4719101123595], "Boyer": [14211.267605633802], "RayTrace": [1930.5019305019305]}, "summary": {"lowerIsBetter": false, "suite": 16883.574871445828, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 331.25118, "unit": "score", "value": 331.25118}, "Encrypt": {"lowerIsBetter": false, "filtered": 812.6505930000002, "unit": "score", "value": 812.6505930000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 250.04586241276166, "unit": "score", "value": 250.04586241276166}, "Decrypt": {"lowerIsBetter": false, "filtered": 46.488697604790445, "unit": "score", "value": 46.488697604790445}, "Splay": {"lowerIsBetter": false, "filtered": 78.47583300000001, "unit": "score", "value": 78.47583300000001}, "RegExp": {"lowerIsBetter": false, "filtered": 29.415366927592935, "unit": "score", "value": 29.415366927592935}, "Richards": {"lowerIsBetter": false, "filtered": 212.27092600000003, "unit": "score", "value": 212.27092600000003}, "Earley": {"lowerIsBetter": false, "filtered": 651.8154615384614, "unit": "score", "value": 651.8154615384614}, "Boyer": {"lowerIsBetter": false, "filtered": 46.896801783944476, "unit": "score", "value": 46.896801783944476}, "RayTrace": {"lowerIsBetter": false, "filtered": 383.31430199999994, "unit": "score", "value": 383.31430199999994}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0015"}, "testrun": {"date": 1447765033, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117030105", "branch": "Firefox", "revision": "898c2c656e4b156c323416ef0c859915f3fd2308"}}] 05:17:25 INFO - RETURN: dromaeo_css: 6361.26 05:17:25 INFO - RETURN: kraken: 1499.30 05:17:25 INFO - RETURN: v8_7: 16883.57 05:17:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "16883.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1499.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "6361.26"}}} 05:17:25 INFO - Return code: 0 05:17:25 INFO - # TBPL SUCCESS # 05:17:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:17:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:17:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:17:25 INFO - 2015-11-17 05:17:25.272 screenresolution[1658:9920] starting screenresolution argv=screenresolution get 05:17:25 INFO - 2015-11-17 05:17:25.275 screenresolution[1658:9920] Display 0: 1600x1200x32@60 05:17:25 INFO - 2015-11-17 05:17:25.281 screenresolution[1659:9923] starting screenresolution argv=screenresolution list 05:17:25 INFO - Available Modes on Display 0 05:17:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:17:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:17:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:17:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:17:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:17:25 INFO - Intel HD Graphics 3000: 05:17:25 INFO - Chipset Model: Intel HD Graphics 3000 05:17:25 INFO - Type: GPU 05:17:25 INFO - Bus: Built-In 05:17:25 INFO - VRAM (Total): 512 MB 05:17:25 INFO - VRAM (Dynamic, Max): 10 05:17:25 INFO - Vendor: Intel (0x8086) 05:17:25 INFO - Device ID: 0x0116 05:17:25 INFO - Revision ID: 0x0009 05:17:25 INFO - Displays: 05:17:25 INFO - Display: 05:17:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:17:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:17:25 INFO - Display Serial Number: 1600x1200 60 05:17:25 INFO - Main Display: Yes 05:17:25 INFO - Mirror: Off 05:17:25 INFO - Online: Yes 05:17:25 INFO - Rotation: Supported 05:17:25 INFO - Return code: 0 05:17:25 INFO - Running post-action listener: _resource_record_post_action 05:17:25 INFO - Running post-run listener: _resource_record_post_run 05:17:26 INFO - Total resource usage - Wall time: 1250s; CPU: 30.0%; Read bytes: 40866816; Write bytes: 682796032; Read time: 5227; Write time: 44033 05:17:26 INFO - install - Wall time: 37s; CPU: 30.0%; Read bytes: 337140224; Write bytes: 334075904; Read time: 31970; Write time: 4116 05:17:26 INFO - run-tests - Wall time: 1213s; CPU: 30.0%; Read bytes: 39912448; Write bytes: 338349056; Read time: 4921; Write time: 39360 05:17:26 INFO - Running post-run listener: _upload_blobber_files 05:17:26 INFO - Blob upload gear active. 05:17:26 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:17:26 INFO - Copying logs to upload dir... 05:17:26 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1305.892641 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 45 secs) (at 2015-11-17 05:17:26.685245) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 05:17:26.689191) ========= 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.12Tcf6lJiV/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.X9NGmqzz0D/Listeners TMPDIR=/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/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:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010151 build_url: 'https://queue.taskcluster.net/v1/task/yduO-oZMSwifDsAJ_iCmRg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 05:17:26.715499) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:17:26.715883) ========= 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.12Tcf6lJiV/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.X9NGmqzz0D/Listeners TMPDIR=/var/folders/xh/9d_zpw4j105621_zjfk7wn4400000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005193 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:17:26.765818) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 05:17:26.766182) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 05:17:26.766634) ========= ========= Total master_lag: 0.50 =========