builder: mozilla-central_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0003 starttime: 1447766960.6 results: success (0) buildid: 20151117030242 builduid: c1d8921f683d4290acceb8d8d0acf1d7 revision: 898c2c656e4b156c323416ef0c859915f3fd2308 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:20.599520) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:20.600049) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:20.600454) ========= 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.7kXCoV3lzL/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.AqIKPrrmyy/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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.006336 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:20.669900) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:20.670344) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:20.689816) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:20.690251) ========= 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.7kXCoV3lzL/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.AqIKPrrmyy/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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.033832 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:20.746917) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:20.747355) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:20.747849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:20.748235) ========= 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.7kXCoV3lzL/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.AqIKPrrmyy/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 05:29:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.73M=0.001s 2015-11-17 05:29:20 (9.73 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193610 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:20.962234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:20.962676) ========= 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.7kXCoV3lzL/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.AqIKPrrmyy/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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.139260 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:21.122969) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:21.123480) ========= 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.7kXCoV3lzL/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.AqIKPrrmyy/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 05:29:21,216 truncating revision to first 12 chars 2015-11-17 05:29:21,216 Setting DEBUG logging. 2015-11-17 05:29:21,216 attempt 1/10 2015-11-17 05:29:21,216 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 05:29:21,514 unpacking tar archive at: mozilla-central-898c2c656e4b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586741 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:21.730638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:21.731330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:21.746838) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:21.747301) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 05:29:21.747917) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2015-11-17 05:29:21.748441) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.7kXCoV3lzL/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.AqIKPrrmyy/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 05:29:22 INFO - MultiFileLogger online at 20151117 05:29:22 in /builds/slave/test 05:29:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 05:29:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:29:22 INFO - {'append_to_log': False, 05:29:22 INFO - 'base_work_dir': '/builds/slave/test', 05:29:22 INFO - 'blob_upload_branch': 'Firefox', 05:29:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:29:22 INFO - 'branch': 'Firefox', 05:29:22 INFO - 'buildbot_json_path': 'buildprops.json', 05:29:22 INFO - 'config_files': ('talos/mac_config.py',), 05:29:22 INFO - 'default_actions': ('clobber', 05:29:22 INFO - 'read-buildbot-config', 05:29:22 INFO - 'download-and-extract', 05:29:22 INFO - 'populate-webroot', 05:29:22 INFO - 'create-virtualenv', 05:29:22 INFO - 'install', 05:29:22 INFO - 'run-tests'), 05:29:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:29:22 INFO - 'download_minidump_stackwalk': True, 05:29:22 INFO - 'download_symbols': 'ondemand', 05:29:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:29:22 INFO - 'tooltool.py': '/tools/tooltool.py', 05:29:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:29:22 INFO - '/tools/misc-python/virtualenv.py')}, 05:29:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:29:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:29:22 INFO - 'installer_path': 'installer.exe', 05:29:22 INFO - 'log_level': 'info', 05:29:22 INFO - 'log_name': 'talos', 05:29:22 INFO - 'log_to_console': True, 05:29:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:29:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:29:22 INFO - 'opt_config_files': (), 05:29:22 INFO - 'pip_index': False, 05:29:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:29:22 INFO - 'cmd': ('bash', 05:29:22 INFO - '-c', 05:29:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:29:22 INFO - 'enabled': True, 05:29:22 INFO - 'halt_on_failure': False, 05:29:22 INFO - 'name': 'check_screen_resolution'},), 05:29:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:29:22 INFO - 'cmd': ('bash', 05:29:22 INFO - '-c', 05:29:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:29:22 INFO - 'enabled': True, 05:29:22 INFO - 'halt_on_failure': False, 05:29:22 INFO - 'name': 'check_screen_resolution'},), 05:29:22 INFO - 'run_cmd_checks_enabled': True, 05:29:22 INFO - 'sps_profile': False, 05:29:22 INFO - 'sps_profile_interval': 0, 05:29:22 INFO - 'suite': 'dromaeojs-e10s', 05:29:22 INFO - 'system_bits': '64', 05:29:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:29:22 INFO - 'title': 't-yosemite-r5-0003', 05:29:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:29:22 INFO - 'use_talos_json': True, 05:29:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:29:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:29:22 INFO - 'work_dir': 'build'} 05:29:22 INFO - ##### 05:29:22 INFO - ##### Running clobber step. 05:29:22 INFO - ##### 05:29:22 INFO - Running pre-action listener: _resource_record_pre_action 05:29:22 INFO - Running main action method: clobber 05:29:22 INFO - rmtree: /builds/slave/test/build 05:29:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:29:27 INFO - Running post-action listener: _resource_record_post_action 05:29:27 INFO - ##### 05:29:27 INFO - ##### Running read-buildbot-config step. 05:29:27 INFO - ##### 05:29:27 INFO - Running pre-action listener: _resource_record_pre_action 05:29:27 INFO - Running main action method: read_buildbot_config 05:29:27 INFO - Using buildbot properties: 05:29:27 INFO - { 05:29:27 INFO - "properties": { 05:29:27 INFO - "buildnumber": 19, 05:29:27 INFO - "product": "firefox", 05:29:27 INFO - "script_repo_revision": "production", 05:29:27 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs-e10s", 05:29:27 INFO - "repository": "", 05:29:27 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs-e10s", 05:29:27 INFO - "buildid": "20151117030242", 05:29:27 INFO - "slavename": "t-yosemite-r5-0003", 05:29:27 INFO - "stage_platform": "macosx64", 05:29:27 INFO - "basedir": "/builds/slave/test", 05:29:27 INFO - "nightly_build": "True", 05:29:27 INFO - "project": "", 05:29:27 INFO - "platform": "yosemite", 05:29:27 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:29:27 INFO - "slavebuilddir": "test", 05:29:27 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:29:27 INFO - "branch": "mozilla-central", 05:29:27 INFO - "repo_path": "mozilla-central", 05:29:27 INFO - "pgo_build": "False", 05:29:27 INFO - "builduid": "c1d8921f683d4290acceb8d8d0acf1d7", 05:29:27 INFO - "revision": "898c2c656e4b156c323416ef0c859915f3fd2308" 05:29:27 INFO - }, 05:29:27 INFO - "sourcestamp": { 05:29:27 INFO - "repository": "", 05:29:27 INFO - "hasPatch": false, 05:29:27 INFO - "project": "", 05:29:27 INFO - "branch": "mozilla-central-macosx64-talos", 05:29:27 INFO - "changes": [ 05:29:27 INFO - { 05:29:27 INFO - "category": null, 05:29:27 INFO - "files": [ 05:29:27 INFO - { 05:29:27 INFO - "url": null, 05:29:27 INFO - "name": "https://queue.taskcluster.net/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:29:27 INFO - } 05:29:27 INFO - ], 05:29:27 INFO - "repository": "", 05:29:27 INFO - "rev": "898c2c656e4b156c323416ef0c859915f3fd2308", 05:29:27 INFO - "who": "sendchange", 05:29:27 INFO - "when": 1447766204, 05:29:27 INFO - "number": 6671742, 05:29:27 INFO - "comments": "", 05:29:27 INFO - "project": "", 05:29:27 INFO - "at": "Tue 17 Nov 2015 05:16:44", 05:29:27 INFO - "branch": "mozilla-central-macosx64-talos", 05:29:27 INFO - "revlink": "", 05:29:27 INFO - "properties": [ 05:29:27 INFO - [ 05:29:27 INFO - "buildid", 05:29:27 INFO - "20151117030242", 05:29:27 INFO - "Change" 05:29:27 INFO - ], 05:29:27 INFO - [ 05:29:27 INFO - "builduid", 05:29:27 INFO - "c1d8921f683d4290acceb8d8d0acf1d7", 05:29:27 INFO - "Change" 05:29:27 INFO - ], 05:29:27 INFO - [ 05:29:27 INFO - "nightly_build", 05:29:27 INFO - "True", 05:29:27 INFO - "Change" 05:29:27 INFO - ], 05:29:27 INFO - [ 05:29:27 INFO - "pgo_build", 05:29:27 INFO - "False", 05:29:27 INFO - "Change" 05:29:27 INFO - ] 05:29:27 INFO - ], 05:29:27 INFO - "revision": "898c2c656e4b156c323416ef0c859915f3fd2308" 05:29:27 INFO - } 05:29:27 INFO - ], 05:29:27 INFO - "revision": "898c2c656e4b156c323416ef0c859915f3fd2308" 05:29:27 INFO - } 05:29:27 INFO - } 05:29:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:29:27 INFO - Running post-action listener: _resource_record_post_action 05:29:27 INFO - ##### 05:29:27 INFO - ##### Running download-and-extract step. 05:29:27 INFO - ##### 05:29:27 INFO - Running pre-action listener: _resource_record_pre_action 05:29:27 INFO - Running main action method: download_and_extract 05:29:27 INFO - mkdir: /builds/slave/test/build/tests 05:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:27 INFO - https://queue.taskcluster.net/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:29:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/test_packages.json 05:29:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/test_packages.json 05:29:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:29:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:29:28 INFO - Downloaded 1149 bytes. 05:29:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:29:28 INFO - Using the following test package requirements: 05:29:28 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:29:28 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:28 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:29:28 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:28 INFO - u'jsshell-mac.zip'], 05:29:28 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:28 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:29:28 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:29:28 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:28 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:29:28 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:28 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:29:28 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:28 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:29:28 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:29:28 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:29:28 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:29:28 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:29:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:28 INFO - https://queue.taskcluster.net/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:29:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/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 05:29:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/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 05:29:29 INFO - Downloaded 17464202 bytes. 05:29:29 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 05:29:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:29:35 INFO - Return code: 0 05:29:35 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 05:29: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')]} 05:29:35 INFO - https://queue.taskcluster.net/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:29:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/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 05:29:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/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 05:29:36 INFO - Downloaded 17464202 bytes. 05:29:36 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 05:29:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:29:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:29:42 INFO - Return code: 0 05:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:42 INFO - https://queue.taskcluster.net/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:29:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:29:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:29:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/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 05:29:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/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 05:29:43 INFO - Downloaded 11131693 bytes. 05:29:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 05:29:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:29:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:29:43 INFO - Return code: 0 05:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:29:43 INFO - https://queue.taskcluster.net/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:29:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:29:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:29:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:29:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/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 05:29:47 INFO - Downloaded 108888631 bytes. 05:29:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:29:47 INFO - mkdir: /builds/slave/test/properties 05:29:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:29:47 INFO - Writing to file /builds/slave/test/properties/build_url 05:29:47 INFO - Contents: 05:29:47 INFO - build_url:https://queue.taskcluster.net/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:29:47 INFO - Running post-action listener: _resource_record_post_action 05:29:47 INFO - Running post-action listener: set_extra_try_arguments 05:29:47 INFO - ##### 05:29:47 INFO - ##### Running populate-webroot step. 05:29:47 INFO - ##### 05:29:47 INFO - Running pre-action listener: _resource_record_pre_action 05:29:47 INFO - Running main action method: populate_webroot 05:29:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:29:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:29:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:29:47 INFO - '../fennec_ids.txt'], 05:29:47 INFO - 'tests': ['tcheck2']}, 05:29:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:29:47 INFO - '--tppagecycles', 05:29:47 INFO - '7'], 05:29:47 INFO - 'tests': ['tsvgm']}}, 05:29:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:29:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:29:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:29:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:29:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:29:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:29:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:47 INFO - 'talos_options': ['--e10s'], 05:29:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:29:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:47 INFO - 'tests': ['damp', 'tps']}, 05:29:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:47 INFO - 'talos_options': ['--e10s'], 05:29:47 INFO - 'tests': ['damp', 'tps']}, 05:29:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:29:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:29:47 INFO - 'other': {'tests': ['a11yr', 05:29:47 INFO - 'ts_paint', 05:29:47 INFO - 'tpaint', 05:29:47 INFO - 'sessionrestore', 05:29:47 INFO - 'sessionrestore_no_auto_restore']}, 05:29:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:29:47 INFO - 'tests': ['a11yr', 05:29:47 INFO - 'ts_paint', 05:29:47 INFO - 'tpaint', 05:29:47 INFO - 'sessionrestore', 05:29:47 INFO - 'sessionrestore_no_auto_restore']}, 05:29:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:29:47 INFO - 'tests': ['a11yr', 05:29:47 INFO - 'ts_paint', 05:29:47 INFO - 'tpaint', 05:29:47 INFO - 'sessionrestore', 05:29:47 INFO - 'sessionrestore_no_auto_restore']}, 05:29:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:29:47 INFO - 'tests': ['a11yr', 05:29:47 INFO - 'ts_paint', 05:29:47 INFO - 'tpaint', 05:29:47 INFO - 'sessionrestore', 05:29:47 INFO - 'sessionrestore_no_auto_restore']}, 05:29:47 INFO - 'other_l64': {'tests': ['a11yr', 05:29:47 INFO - 'ts_paint', 05:29:47 INFO - 'tpaint', 05:29:47 INFO - 'sessionrestore', 05:29:47 INFO - 'sessionrestore_no_auto_restore']}, 05:29:47 INFO - 'other_nol64': {'tests': ['a11yr', 05:29:47 INFO - 'ts_paint', 05:29:47 INFO - 'tpaint', 05:29:47 INFO - 'sessionrestore', 05:29:47 INFO - 'sessionrestore_no_auto_restore']}, 05:29:47 INFO - 'svgr': {'tests': ['tsvgx', 05:29:47 INFO - 'tsvgr_opacity', 05:29:47 INFO - 'tart', 05:29:47 INFO - 'tscrollx', 05:29:47 INFO - 'cart']}, 05:29:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:29:47 INFO - 'tests': ['tsvgx', 05:29:47 INFO - 'tsvgr_opacity', 05:29:47 INFO - 'tart', 05:29:47 INFO - 'tscrollx', 05:29:47 INFO - 'cart']}, 05:29:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:47 INFO - 'tests': ['tp5o']}, 05:29:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:47 INFO - 'talos_options': ['--e10s'], 05:29:47 INFO - 'tests': ['tp5o']}, 05:29:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:47 INFO - 'talos_options': ['--xperf_path', 05:29:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:47 INFO - 'tests': ['tp5n']}, 05:29:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:29:47 INFO - 'talos_options': ['--e10s', 05:29:47 INFO - '--xperf_path', 05:29:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:29:47 INFO - 'tests': ['tp5n']}}, 05:29:47 INFO - 'talos.zip': {'path': '', 05:29:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:29:47 INFO - Running post-action listener: _resource_record_post_action 05:29:47 INFO - ##### 05:29:47 INFO - ##### Running create-virtualenv step. 05:29:47 INFO - ##### 05:29:47 INFO - Running pre-action listener: _resource_record_pre_action 05:29:47 INFO - Running main action method: create_virtualenv 05:29:47 INFO - Creating virtualenv /builds/slave/test/build/venv 05:29:47 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 05:29:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:29:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:29:47 INFO - Using real prefix '/tools/python27' 05:29:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:29:48 INFO - Installing distribute.............................................................................................................................................................................................done. 05:29:52 INFO - Installing pip.................done. 05:29:52 INFO - Return code: 0 05:29:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:29: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')]} 05:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29: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')]} 05:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:52 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 0x10deac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de89228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9513f331a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddcf9f0>, '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 0x10db2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddc38c8>, '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.7kXCoV3lzL/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.AqIKPrrmyy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 05:29:52 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 05:29:52 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 05:29:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7kXCoV3lzL/Render', 05:29:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:52 INFO - 'HOME': '/Users/cltbld', 05:29:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:52 INFO - 'LOGNAME': 'cltbld', 05:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:52 INFO - 'MOZ_NO_REMOTE': '1', 05:29:52 INFO - 'NO_EM_RESTART': '1', 05:29:52 INFO - 'PAGER': '/bin/cat', 05:29:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:52 INFO - 'PWD': '/builds/slave/test', 05:29:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:52 INFO - 'SHELL': '/bin/bash', 05:29:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqIKPrrmyy/Listeners', 05:29:52 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 05:29:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:52 INFO - 'USER': 'cltbld', 05:29:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:52 INFO - 'XPC_FLAGS': '0x0', 05:29:52 INFO - 'XPC_SERVICE_NAME': '0', 05:29:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:53 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 05:29:53 INFO - Cleaning up... 05:29:53 INFO - Return code: 0 05:29:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:29:53 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')]} 05:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:53 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')]} 05:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:29:53 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 0x10deac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de89228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9513f331a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddcf9f0>, '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 0x10db2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddc38c8>, '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.7kXCoV3lzL/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.AqIKPrrmyy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 05:29:53 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 05:29:53 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 05:29:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7kXCoV3lzL/Render', 05:29:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:53 INFO - 'HOME': '/Users/cltbld', 05:29:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:53 INFO - 'LOGNAME': 'cltbld', 05:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:53 INFO - 'MOZ_NO_REMOTE': '1', 05:29:53 INFO - 'NO_EM_RESTART': '1', 05:29:53 INFO - 'PAGER': '/bin/cat', 05:29:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:53 INFO - 'PWD': '/builds/slave/test', 05:29:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:53 INFO - 'SHELL': '/bin/bash', 05:29:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqIKPrrmyy/Listeners', 05:29:53 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 05:29:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:53 INFO - 'USER': 'cltbld', 05:29:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:53 INFO - 'XPC_FLAGS': '0x0', 05:29:53 INFO - 'XPC_SERVICE_NAME': '0', 05:29:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:54 INFO - Downloading/unpacking psutil>=0.7.1 05:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:29:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:29:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:29:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:29:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:29:57 INFO - Installing collected packages: psutil 05:29:57 INFO - Running setup.py install for psutil 05:29:57 INFO - building 'psutil._psutil_osx' extension 05:29:57 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 05:29:59 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 05:29:59 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 05:29:59 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 05:29:59 INFO - building 'psutil._psutil_posix' extension 05:29:59 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 05:29:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:29:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:29:59 INFO - ^ 05:29:59 INFO - 1 warning generated. 05:29:59 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 05:30:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:00 INFO - Successfully installed psutil 05:30:00 INFO - Cleaning up... 05:30:00 INFO - Return code: 0 05:30:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:00 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 0x10deac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de89228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9513f331a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddcf9f0>, '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 0x10db2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddc38c8>, '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.7kXCoV3lzL/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.AqIKPrrmyy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 05:30:00 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 05:30:00 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 05:30:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7kXCoV3lzL/Render', 05:30:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:00 INFO - 'HOME': '/Users/cltbld', 05:30:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:00 INFO - 'LOGNAME': 'cltbld', 05:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:00 INFO - 'MOZ_NO_REMOTE': '1', 05:30:00 INFO - 'NO_EM_RESTART': '1', 05:30:00 INFO - 'PAGER': '/bin/cat', 05:30:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:00 INFO - 'PWD': '/builds/slave/test', 05:30:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:00 INFO - 'SHELL': '/bin/bash', 05:30:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqIKPrrmyy/Listeners', 05:30:00 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 05:30:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:00 INFO - 'USER': 'cltbld', 05:30:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:00 INFO - 'XPC_FLAGS': '0x0', 05:30:00 INFO - 'XPC_SERVICE_NAME': '0', 05:30:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:30:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:30:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:30:03 INFO - Installing collected packages: mozsystemmonitor 05:30:03 INFO - Running setup.py install for mozsystemmonitor 05:30:03 INFO - Successfully installed mozsystemmonitor 05:30:03 INFO - Cleaning up... 05:30:03 INFO - Return code: 0 05:30:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:03 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 0x10deac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de89228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9513f331a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddcf9f0>, '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 0x10db2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddc38c8>, '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.7kXCoV3lzL/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.AqIKPrrmyy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 05:30:03 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 05:30:03 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 05:30:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7kXCoV3lzL/Render', 05:30:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:04 INFO - 'HOME': '/Users/cltbld', 05:30:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:04 INFO - 'LOGNAME': 'cltbld', 05:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:04 INFO - 'MOZ_NO_REMOTE': '1', 05:30:04 INFO - 'NO_EM_RESTART': '1', 05:30:04 INFO - 'PAGER': '/bin/cat', 05:30:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:04 INFO - 'PWD': '/builds/slave/test', 05:30:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:04 INFO - 'SHELL': '/bin/bash', 05:30:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqIKPrrmyy/Listeners', 05:30:04 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 05:30:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:04 INFO - 'USER': 'cltbld', 05:30:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:04 INFO - 'XPC_FLAGS': '0x0', 05:30:04 INFO - 'XPC_SERVICE_NAME': '0', 05:30:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:04 INFO - Downloading/unpacking blobuploader==1.2.4 05:30:04 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 05:30:04 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 05:30:04 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 05:30:04 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 05:30:04 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 05:30:04 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 05:30:07 INFO - Downloading blobuploader-1.2.4.tar.gz 05:30:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:30:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:30:07 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 05:30:07 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 05:30:07 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 05:30:07 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 05:30:07 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 05:30:07 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 05:30:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:30:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:30:07 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 05:30:07 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 05:30:07 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 05:30:07 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 05:30:07 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 05:30:07 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 05:30:08 INFO - Downloading docopt-0.6.1.tar.gz 05:30:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:30:08 INFO - Installing collected packages: blobuploader, requests, docopt 05:30:08 INFO - Running setup.py install for blobuploader 05:30:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:30:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:30:08 INFO - Running setup.py install for requests 05:30:09 INFO - Running setup.py install for docopt 05:30:09 INFO - Successfully installed blobuploader requests docopt 05:30:09 INFO - Cleaning up... 05:30:09 INFO - Return code: 0 05:30:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:09 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 0x10deac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de89228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9513f331a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddcf9f0>, '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 0x10db2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddc38c8>, '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.7kXCoV3lzL/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.AqIKPrrmyy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 05:30:09 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 05:30:09 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 05:30:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7kXCoV3lzL/Render', 05:30:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:09 INFO - 'HOME': '/Users/cltbld', 05:30:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:09 INFO - 'LOGNAME': 'cltbld', 05:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:09 INFO - 'MOZ_NO_REMOTE': '1', 05:30:09 INFO - 'NO_EM_RESTART': '1', 05:30:09 INFO - 'PAGER': '/bin/cat', 05:30:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:09 INFO - 'PWD': '/builds/slave/test', 05:30:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:09 INFO - 'SHELL': '/bin/bash', 05:30:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqIKPrrmyy/Listeners', 05:30:09 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 05:30:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:09 INFO - 'USER': 'cltbld', 05:30:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:09 INFO - 'XPC_FLAGS': '0x0', 05:30:09 INFO - 'XPC_SERVICE_NAME': '0', 05:30:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:10 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-87_K9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:10 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-lhK0_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:10 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-ze6ARq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:10 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-AqnMfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:10 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-M_JsQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:10 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-1BMheP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:10 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-Sk91eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:10 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-5_vToy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:11 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-6tal4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:11 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-8QS_ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:11 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-6OIFkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:11 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-wmYwoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:11 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-42ItKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:11 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-27Wf5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:11 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-yzvVcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:12 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-HDJRqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:12 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-GHpizn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:30:12 INFO - Running setup.py install for manifestparser 05:30:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:30:12 INFO - Running setup.py install for mozcrash 05:30:12 INFO - Running setup.py install for mozdebug 05:30:12 INFO - Running setup.py install for mozdevice 05:30:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:30:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:30:13 INFO - Running setup.py install for mozfile 05:30:13 INFO - Running setup.py install for mozhttpd 05:30:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:30:13 INFO - Running setup.py install for mozinfo 05:30:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:30:13 INFO - Running setup.py install for mozInstall 05:30:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:30:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:30:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:30:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:30:13 INFO - Running setup.py install for mozleak 05:30:14 INFO - Running setup.py install for mozlog 05:30:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:30:14 INFO - Running setup.py install for moznetwork 05:30:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:30:14 INFO - Running setup.py install for mozprocess 05:30:14 INFO - Running setup.py install for mozprofile 05:30:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:30:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:30:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:30:14 INFO - Running setup.py install for mozrunner 05:30:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:30:15 INFO - Running setup.py install for mozscreenshot 05:30:15 INFO - Running setup.py install for moztest 05:30:15 INFO - Running setup.py install for mozversion 05:30:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:30:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:15 INFO - Cleaning up... 05:30:15 INFO - Return code: 0 05:30:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10deac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de89228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9513f331a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddcf9f0>, '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 0x10db2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddc38c8>, '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.7kXCoV3lzL/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.AqIKPrrmyy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 05:30:15 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 05:30:15 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 05:30:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7kXCoV3lzL/Render', 05:30:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:15 INFO - 'HOME': '/Users/cltbld', 05:30:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:15 INFO - 'LOGNAME': 'cltbld', 05:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:15 INFO - 'MOZ_NO_REMOTE': '1', 05:30:15 INFO - 'NO_EM_RESTART': '1', 05:30:15 INFO - 'PAGER': '/bin/cat', 05:30:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:15 INFO - 'PWD': '/builds/slave/test', 05:30:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:15 INFO - 'SHELL': '/bin/bash', 05:30:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqIKPrrmyy/Listeners', 05:30:15 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 05:30:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:15 INFO - 'USER': 'cltbld', 05:30:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:15 INFO - 'XPC_FLAGS': '0x0', 05:30:15 INFO - 'XPC_SERVICE_NAME': '0', 05:30:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:16 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-v444gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:16 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)) 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:16 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-sH6My6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:16 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)) 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:16 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-6NkbIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:16 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)) 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:16 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-rkUakG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:16 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)) 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:16 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-lz6m7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:16 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)) 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:16 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-Hre9d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:17 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)) 05:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:17 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-8iL8XC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:17 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)) 05:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:17 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-PoVTxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:17 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)) 05:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:17 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-Di49fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:17 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)) 05:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:17 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-qlDLSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:17 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)) 05:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:17 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-k78sjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:17 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)) 05:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:17 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-d7nfkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:17 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)) 05:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:17 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-EjGHIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:18 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)) 05:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:18 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-zaQemc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:18 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)) 05:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:18 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-Fe11ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:18 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)) 05:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:18 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-jT2lIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:18 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)) 05:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:18 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-oLnAZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:18 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)) 05:30:18 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)) 05:30:18 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)) 05:30:18 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)) 05:30:18 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)) 05:30:18 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)) 05:30:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:21 INFO - Downloading blessings-1.5.1.tar.gz 05:30:21 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 05:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:30:21 INFO - Installing collected packages: blessings 05:30:21 INFO - Running setup.py install for blessings 05:30:21 INFO - Successfully installed blessings 05:30:21 INFO - Cleaning up... 05:30:21 INFO - Return code: 0 05:30:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:30:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:22 INFO - Reading from file tmpfile_stdout 05:30:22 INFO - Current package versions: 05:30:22 INFO - blessings == 1.5.1 05:30:22 INFO - blobuploader == 1.2.4 05:30:22 INFO - docopt == 0.6.1 05:30:22 INFO - manifestparser == 1.1 05:30:22 INFO - mozInstall == 1.12 05:30:22 INFO - mozcrash == 0.16 05:30:22 INFO - mozdebug == 0.1 05:30:22 INFO - mozdevice == 0.47 05:30:22 INFO - mozfile == 1.2 05:30:22 INFO - mozhttpd == 0.7 05:30:22 INFO - mozinfo == 0.9 05:30:22 INFO - mozleak == 0.1 05:30:22 INFO - mozlog == 3.0 05:30:22 INFO - moznetwork == 0.27 05:30:22 INFO - mozprocess == 0.22 05:30:22 INFO - mozprofile == 0.27 05:30:22 INFO - mozrunner == 6.11 05:30:22 INFO - mozscreenshot == 0.1 05:30:22 INFO - mozsystemmonitor == 0.0 05:30:22 INFO - moztest == 0.7 05:30:22 INFO - mozversion == 1.4 05:30:22 INFO - psutil == 3.1.1 05:30:22 INFO - requests == 1.2.3 05:30:22 INFO - wsgiref == 0.1.2 05:30:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10deac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de89228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9513f331a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddcf9f0>, '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 0x10db2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddc38c8>, '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.7kXCoV3lzL/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.AqIKPrrmyy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 05:30:22 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 05:30:22 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 05:30:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7kXCoV3lzL/Render', 05:30:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:22 INFO - 'HOME': '/Users/cltbld', 05:30:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:22 INFO - 'LOGNAME': 'cltbld', 05:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:22 INFO - 'MOZ_NO_REMOTE': '1', 05:30:22 INFO - 'NO_EM_RESTART': '1', 05:30:22 INFO - 'PAGER': '/bin/cat', 05:30:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:22 INFO - 'PWD': '/builds/slave/test', 05:30:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:22 INFO - 'SHELL': '/bin/bash', 05:30:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqIKPrrmyy/Listeners', 05:30:22 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 05:30:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:22 INFO - 'USER': 'cltbld', 05:30:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:22 INFO - 'XPC_FLAGS': '0x0', 05:30:22 INFO - 'XPC_SERVICE_NAME': '0', 05:30:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:30:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:22 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)) 05:30:22 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)) 05:30:22 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)) 05:30:22 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)) 05:30:22 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)) 05:30:22 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)) 05:30:22 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)) 05:30:22 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)) 05:30:22 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)) 05:30:22 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)) 05:30:22 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)) 05:30:22 INFO - Cleaning up... 05:30:22 INFO - Return code: 0 05:30:22 INFO - Running post-action listener: _resource_record_post_action 05:30:22 INFO - Running post-action listener: _start_resource_monitoring 05:30:22 INFO - Starting resource monitoring. 05:30:22 INFO - ##### 05:30:22 INFO - ##### Running install step. 05:30:22 INFO - ##### 05:30:22 INFO - Running pre-action listener: _resource_record_pre_action 05:30:22 INFO - Running main action method: install 05:30:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:22 INFO - Reading from file tmpfile_stdout 05:30:22 INFO - Detecting whether we're running mozinstall >=1.0... 05:30:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:30:23 INFO - Reading from file tmpfile_stdout 05:30:23 INFO - Output received: 05:30:23 INFO - Usage: mozinstall [options] installer 05:30:23 INFO - Options: 05:30:23 INFO - -h, --help show this help message and exit 05:30:23 INFO - -d DEST, --destination=DEST 05:30:23 INFO - Directory to install application into. [default: 05:30:23 INFO - "/builds/slave/test"] 05:30:23 INFO - --app=APP Application being installed. [default: firefox] 05:30:23 INFO - mkdir: /builds/slave/test/build/application 05:30:23 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'] 05:30:23 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 05:31:05 INFO - Reading from file tmpfile_stdout 05:31:05 INFO - Output received: 05:31:05 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:31:05 INFO - Running post-action listener: _resource_record_post_action 05:31:05 INFO - ##### 05:31:05 INFO - ##### Running run-tests step. 05:31:05 INFO - ##### 05:31:05 INFO - Running pre-action listener: _resource_record_pre_action 05:31:05 INFO - Running main action method: run_tests 05:31:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:31:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:31:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:31:05 INFO - 2015-11-17 05:31:05.713 screenresolution[1631:7613] starting screenresolution argv=screenresolution get 05:31:05 INFO - 2015-11-17 05:31:05.716 screenresolution[1631:7613] Display 0: 1600x1200x32@60 05:31:05 INFO - 2015-11-17 05:31:05.724 screenresolution[1632:7615] starting screenresolution argv=screenresolution list 05:31:05 INFO - Available Modes on Display 0 05:31:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:31:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:31:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:31:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:31:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:31:06 INFO - Intel HD Graphics 3000: 05:31:06 INFO - Chipset Model: Intel HD Graphics 3000 05:31:06 INFO - Type: GPU 05:31:06 INFO - Bus: Built-In 05:31:06 INFO - VRAM (Total): 512 MB 05:31:06 INFO - VRAM (Dynamic, Max): 10 05:31:06 INFO - Vendor: Intel (0x8086) 05:31:06 INFO - Device ID: 0x0116 05:31:06 INFO - Revision ID: 0x0009 05:31:06 INFO - Displays: 05:31:06 INFO - Display: 05:31:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:31:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:31:06 INFO - Display Serial Number: 1600x1200 60 05:31:06 INFO - Main Display: Yes 05:31:06 INFO - Mirror: Off 05:31:06 INFO - Online: Yes 05:31:06 INFO - Rotation: Supported 05:31:06 INFO - Return code: 0 05:31:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:31:06 INFO - Python 2.7.3 05:31:06 INFO - Return code: 0 05:31:06 INFO - grabbing minidump binary from tooltool 05:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:06 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 0x10ddcf9f0>, '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 0x10db2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddc38c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:31:06 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 05:31:06 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 05:31:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:31:06 INFO - Return code: 0 05:31:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:31:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:31:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:31:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:31:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:31:06 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0003', '--webServer', 'localhost'] in /builds/slave/test/build 05:31:06 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-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0003 --webServer localhost 05:31:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7kXCoV3lzL/Render', 05:31:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:06 INFO - 'HOME': '/Users/cltbld', 05:31:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:06 INFO - 'LOGNAME': 'cltbld', 05:31:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:31:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:06 INFO - 'MOZ_NO_REMOTE': '1', 05:31:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:31:06 INFO - 'NO_EM_RESTART': '1', 05:31:06 INFO - 'PAGER': '/bin/cat', 05:31:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:06 INFO - 'PWD': '/builds/slave/test', 05:31:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:31:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:06 INFO - 'SHELL': '/bin/bash', 05:31:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqIKPrrmyy/Listeners', 05:31:06 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 05:31:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:06 INFO - 'USER': 'cltbld', 05:31:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:06 INFO - 'XPC_FLAGS': '0x0', 05:31:06 INFO - 'XPC_SERVICE_NAME': '0', 05:31:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:31:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0003', '--webServer', 'localhost'] with output_timeout 3600 05:31:06 INFO - mozversion INFO | application_buildid: 20151117030242 05:31:06 INFO - mozversion INFO | application_changeset: 898c2c656e4b156c323416ef0c859915f3fd2308 05:31:06 INFO - mozversion INFO | application_display_name: Nightly 05:31:06 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:31:06 INFO - mozversion INFO | application_name: Firefox 05:31:06 INFO - mozversion INFO | application_remotingname: firefox 05:31:06 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:31:06 INFO - mozversion INFO | application_vendor: Mozilla 05:31:06 INFO - mozversion INFO | application_version: 45.0a1 05:31:06 INFO - mozversion INFO | platform_buildid: 20151117030242 05:31:06 INFO - mozversion INFO | platform_changeset: 898c2c656e4b156c323416ef0c859915f3fd2308 05:31:06 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:31:06 INFO - mozversion INFO | platform_version: 45.0a1 05:31:06 INFO - 2015-11-17 05:31:06,479 DEBUG : using testdate: 1447767066 05:31:06 INFO - 2015-11-17 05:31:06,479 DEBUG : actual date: 1447767066 05:31:06 INFO - 2015-11-17 05:31:06,489 INFO : starting webserver on 'localhost:49267' 05:31:06 INFO - 2015-11-17 05:31:06,490 INFO : Starting test suite t-yosemite-r5-0003.e 05:31:06 INFO - 2015-11-17 05:31:06,491 INFO : Starting test dromaeo_css 05:31:06 INFO - 2015-11-17 05:31:06,491 DEBUG : operating with platform_type : mac_ 05:31:06 INFO - 2015-11-17 05:31:06,492 INFO : Initialising browser for dromaeo_css test... 05:31:06 INFO - 2015-11-17 05:31:06,514 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmpPuCTig/profile http://localhost:49267/getInfo.html 05:31:11 INFO - 2015-11-17 05:31:11,355 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:31:11 INFO - 2015-11-17 05:31:11,356 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:31:11 INFO - 2015-11-17 05:31:11,356 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 05:31:11 INFO - 2015-11-17 05:31:11,356 DEBUG : BROWSER_OUTPUT: __metrics 05:31:12 INFO - 2015-11-17 05:31:12,115 INFO : Browser initialized. 05:31:12 INFO - 2015-11-17 05:31:12,115 INFO : Running cycle 1/1 for dromaeo_css test... 05:31:12 INFO - 2015-11-17 05:31:12,115 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmpPuCTig/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:31:24 INFO - 2015-11-17 05:31:24,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 240861184 05:31:24 INFO - 2015-11-17 05:31:24,482 DEBUG : BROWSER_OUTPUT: 05:32:14 INFO - 2015-11-17 05:32:14,336 DEBUG : BROWSER_OUTPUT: 1447767134335 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:34:24 INFO - 2015-11-17 05:34:24,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 05:34:26 INFO - 2015-11-17 05:34:26,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 268419072 05:34:26 INFO - 2015-11-17 05:34:26,541 DEBUG : BROWSER_OUTPUT: 05:37:28 INFO - 2015-11-17 05:37:28,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 05:37:29 INFO - 2015-11-17 05:37:29,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 273231872 05:37:29 INFO - 2015-11-17 05:37:29,123 DEBUG : BROWSER_OUTPUT: 05:40:30 INFO - 2015-11-17 05:40:30,880 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 05:40:31 INFO - 2015-11-17 05:40:31,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 277594112 05:40:31 INFO - 2015-11-17 05:40:31,472 DEBUG : BROWSER_OUTPUT: 05:43:33 INFO - 2015-11-17 05:43:33,173 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 05:43:33 INFO - 2015-11-17 05:43:33,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 281915392 05:43:33 INFO - 2015-11-17 05:43:33,780 DEBUG : BROWSER_OUTPUT: 05:46:36 INFO - 2015-11-17 05:46:36,399 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 05:46:37 INFO - 2015-11-17 05:46:37,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 286748672 05:46:37 INFO - 2015-11-17 05:46:37,023 DEBUG : BROWSER_OUTPUT: 05:49:39 INFO - 2015-11-17 05:49:39,552 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 05:49:39 INFO - 2015-11-17 05:49:39,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 292696064 05:49:39 INFO - 2015-11-17 05:49:39,812 DEBUG : BROWSER_OUTPUT: 05:49:39 INFO - 2015-11-17 05:49:39,812 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:49:39 INFO - 2015-11-17 05:49:39,812 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:49:39 INFO - 2015-11-17 05:49:39,812 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:49:39 INFO - 2015-11-17 05:49:39,812 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:49:39 INFO - 2015-11-17 05:49:39,813 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2541.9110331138413;2571.6656834611504;2596.7013793413753;2696.528107581174;2711.3492761737166;4326.84856030039;4388.9341659875045;4426.800793964276;4442.755648439334;4540.3189521571785;4261.701680882339;4368.410264614284;4422.955770442302;4505.076459325838;4556.316552517116;3933.5476420211685;4088.2028004539125;4113.547509773923;4153.813078411479;4197.538270790211;4066.146109317047;4135.751854888701;4149.605787450188;4156.147989662112;4210.263203939314;3906.3945088511327;3983.2630963271886;4049.5747946465785;4089.7137200395982;4130.318497447917;4084.979575102135;4091.85678501254;4092.5702801205744;4103.692223083281;4113.074558224405;4059.303892809003;4067.877963661095;4092.0179157002403;4098.446709694183;4129.318662420727;4042.2319759245943;4156.376543518466;4309.82760689572;4334.739915605074;4443.133588950156;4600.263957766741;4618.076384723069;4622.329762184498;4669.766511674403;4689.460712018127;4651.767411629405;4665.2535594304745;4683.765811709401;4735.1713450146435;4744.810207591692;4330.39374487572;4332.241857674894;4379.693421460531;4443.178012067746;4512.661550383735;4820.662553621283;4857.149998750205;4880.804767809319;4883.02339532095;4912.533309335608;4432.29083346663;4649.163150632919;4668.183067963093;4697.95302046982;4701.059788042337;4440.378347031418;4555.63554915606;4675.555822196886;4681.32120842476;4750.95249047512;4573.954260457353;4606.976965115153;4681.789319480631;4686.250199968057;4686.297055441711;4521.977390113028;4603.976980115078;4663.813447462131;4666.510016448224;4672.486026537078;3581.94627080594;3650.3429382710838;3651.634836516327;3684.060564556021;3693.649103335179;3350.4136776064092;3355.832208389571;3357.5970883494138;3359.277755282626;3377.594688637379;4288.120935208275;4294.527601963781;4391.033972526039;4462.352958821018;4531.682782205214;4656.534346565317;4663.137319595886;4697.600703940135;4701.271302948048;4740.1230772307235;4385.495667998221;4403.625691816167;4407.537208593116;4451.421315228999;4463.977680111579;3999.580044095328;4077.3883917412627;4082.795860206978;4129.855455059059;4132.132252227006;4787.712737235777;4800.807967681323;4806.663533552688;4846.418429788378;4846.781894814671;4569.360289559398;4667.043256132552;4680.134175177603;4745.074710431432;4765.332853400596;4648.767561621973;4749.501302363202;4750.596199323097;4791.113643975876;4817.566419022305;4641.559051890065;4650.395448591797;4655.441347038377;4697.295405689174;4698.436187657503;4610.377599024089;4716.834910778106;4737.099951009297;4772.594329482033;4854.708717476963;4500.122476117126;4546.272596384562;4644.628429725546;4666.323383109498;4674.929876051794;4623.745693986863;4644.489106198383;4667.766611669471;4684.0866031123605;4704.835330763407;4425.845095421645;4493.865184044484;4508.594226519629;4521.683482156218;4634.443866736014;4469.709468884512;4542.159700455426;4570.520095390069;4629.722216667011;4634.490206077261;4521.457425109008;4535.251683472322;4547.386102876069;4618.838340658061;4626.074785042938 05:49:39 INFO - 2015-11-17 05:49:39,813 DEBUG : BROWSER_OUTPUT: |1;ext.html;443.2088721631888;453.4128303846519;477.46762359968636;485.4829606469108;488.2285988138741;30313;30943.690563094362;31288.843555782245;32037.43700503957;32192.03423897287;32040.839795801046;32050.198745031328;32253.838730806372;32289.35421291573;32844.67155328452;7306.963465182666;7455.0681164854395;7460.179380268166;7476.887846682304;7587.393008559302;7259.60072196029;7366.15289241736;7380.74167404141;7391.186969433385;7514.361279291267;7308.378787803043;7410.70357185712;7413.851722965537;7455.888161677579;7521.022267105296;7425.034745483053;7428.257174282582;7475.0656167979005;7496.925030749677;7596.3163315301335;7318.085239345082;7336.266373362621;7350.191478937312;7356.742514011984;7484.101907771103;30655.233619159477;30662.84668576665;30850.69149308523;30965.0710478686;31388.686113139032;2289.095807156164;2321.5008773113864;2403.134871446278;2429;2481.838680485763;21649.242276520246;21889.67165492519;22540.887295563418;22701.54596908069;22835;1883.1714045819795;1888.0748433267738;1907.656621808074;1916.4729699332656;1934.0523143659645;215178;216155;216596;217478;217763;39855.40216896749;40158.59841401548;43969.560304397186;44553.33170002452;45106.32340514895;46553.53446465492;46676.29985550219;47039;47402.288965665546;47466.67733258639;11782.057435405148;11852.525898964117;11894.82157767634;11901.821472677917;11971.221870578385;10123.291369604205;10191.133753631024;10193.388396696073;10199.235057370726;10203.540840662039;14903.403863845542;14910.850891490947;14967.401303947938;15076.698466030617;15197.088174709554;6600.636964966877;6850.760223392157;6854.485913556404;6875.174979002451;6914.274001229899;772.7836205862255;776.8640487914593;790.4506368074249;799.0641234088055;921.576075005505;23040.769592303863;23042.8847855763;23096.4225894354;23160.4209894754;23405;837;871.4684042734054;878.1131057631837;882.5410786391169;913.182701482183;11885.821712674317;11891.167618266638;11992.400379980965;12071.577494787816;12140;243635;250957;253008;253630;256017;43361.34957975633;43467.34798978018;43671.56328436739;43865.78067109644;43976.56023439789;1000.5747557288123;1015.2487159501916;1024.206240163864;1027.4759872465097;1098.5001824169983;22701.545969080194;22732.65901011453;22830;22985.770142298363;23183.76816231816;37096.258074838894;37441.625583743815;37577;38131.42802857904;38456.23087538178;222197;224975;226341;229455;229698;25113.87443062773;25124;25192;25250.242492725247;25704.74295257098;29574.40851183007;30680.693193068677;30733.846330768203;30950.0714978551;30962.665226868707;25027;26090.73909260883;26451.867740661175;26672.59991100174;27384.863075684494;25632.743672563036;25854.612180816926;25886.35284117912;25947.481050379265;26431;27807.582886256318;28124.43751125007;29094.854525727234;29100;29300.853495732386;24030.51938961246;24966.50066998686;25062.498750024533;25226.873865630554;25813.096541621704;19430.2227910882;19433.902830485757;19484;19577.51056223549;19649.31227407034 05:49:39 INFO - 2015-11-17 05:49:39,814 DEBUG : BROWSER_OUTPUT: |2;jquery.html;271.2148330582961;274.67588245869877;275.1484156535522;280.3370029879335;283.78999540340146;11098.334099954009;13701.931490342547;14386.568402947914;14464.566063018114;14483.203423811687;9370.906290937088;9579;9642.566084526195;14357.425702971896;14754;3584.139806446454;3699.46357778122;3728.757630753992;3758.267137908109;3766.020834583014;3671.1556342041345;3679.9880032990873;3696.20531585709;3713.3501637213517;3713.4058550631903;2777.8333300001964;2847.2454799478155;3629.9274014519824;3636.672699457048;3867.845286188563;3823.1397935464574;3909.8045097745285;3961.4652021977095;4010.6189911958318;4017;3346.1467325832;3351.916202094943;3354.815485148316;3356.228067544454;3356.9664303357144;10508.632197873114;10899.782004359948;10916.945415272952;11042.227044106916;11086.501107450184;1515.6210947263185;1548.7212301785673;1557.4159690116207;1656.9171541422882;1670.5656529302348;7737.148913619498;7761.805954851117;8091.959540202321;8127.5529845858455;8140.633671484798;1274.898008159345;1287.851897031844;1306.9738605227938;1309.6267563744286;1310.3710219094887;44579;45990.54009459896;47613;47840.76079619615;48067.51932480666;5240.711760853113;5299.761510732026;5378.91931621026;5383.919241211385;5450.427705090988;6120.78577249803;6123.877522449615;6159.1069294951985;6165.84585385369;6180.443760061616;4395.120975804852;4484.529124441887;4509.909801803946;4520.095980803787;4578.656600754956;4757.310190022427;4766.165920963817;4794.304825800239;4799.400074990626;4832.251001094836;2340.3564019894666;2345.425370784169;2354.6350315701093;2396.74834142416;2406.6630671705975;858.52780970466;862.1895418306772;868.9869651955225;879.5162660536679;914.970658009739;347.7723635566455;352.1706381471649;365.43540230344183;371.0926784013116;377.7638975640225;9192.816143677222;9632.32573719847;9801.16690081351;9901.504924753734;9974.501274936225;375.15964240101977;382.4836470764446;383.1780830119378;390.9921801563953;393.22142158526276;4817.975910120427;5182.378114626269;5224.608154388436;5261.316028916293;5383.192521121863;518225;524623;533683;550250;554649;56435;56803.43196567981;57795.422045779844;58243;59414.10878836821;414.3867076726462;414.80089557012803;415.41219174867825;421.3490157706351;424.16439613959835;8994.865077023718;9054.954725226595;9132.817343652956;9238.353315268136;9375.624975001196;28046.719532805226;28435.857820710764;28445.573316399856;28834;29318.853405733687;35227;36509;36822.8158859204;39183.2163356737;39207.41188882112;4937.530934561211;5021.84934451967;5109.795608175631;5163.535281824654;5198.116320225495;9424.293178011814;9516.33385662997;9631.807363852824;9739.123478886651;9744;8138.755837324889;8389.161083891562;8402.957985210034;8407.537585432616;8531.402801803813;6547.672616369257;7702.961485192538;8055.798605034921;8093;8362.080171181287;8620.827583448421;8706.651733930572;8725.781855453664;8756.124387561193;8850.026497085186;4918.114739346809;5031.597472202288;5188.143956247177;5226.216067589892;5235.816746413857;8177.100518943031;8385.74842754694;8444.366672499464;8444.408891377545;8462.492250464991 05:49:39 INFO - 2015-11-17 05:49:39,818 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1404.6137312239132;1412.3503188533275;1421.5948454690415;1434.992825035874;1458.1469840143516;5917.970410147954;5975.073863551145;6031.517478601712;6193.597416167951;6214.84462888428;6256.186695729549;6349.238091429035;6353.205849268841;6492.091107244978;6559.639219842907;1871.2608519634737;1884.9246030158777;1891.508207865958;1897.6868816645238;1904.552430178907;1866.3001374484568;1880.8025157358486;1881.4543782303115;1884.547708549945;1916.4633902507321;1868.2993877296014;1870.055621910933;1871.644387566365;1873.4660621722812;1897.222138923042;1810.9637807243848;1834.899080550576;1854.0822292964933;1855.8144185581468;1859.0425930645729;1878.5585387433941;1880.8025157358554;1882.3505890467766;1904.552430178907;1939.3697048459308;6433.774817881398;6498.447631951242;6548.050532672783;6557.147570815811;6565.737370505174;3935.763854168759;4051.149258655686;4051.7974101295113;4086.6117718816663;4090.6931980101613;2337.0885354711677;2355.234548771656;2406.1818981546185;2440.5362981033722;2452.570800109974;689.2452764223168;690.8927770300613;698.2982102986466;709.1313141401793;717.4654882112859;8582.570871456403;8584.313254939652;8617.827643447159;8657.961044674616;8705.303575713991;3520.718416866112;3524.136586536315;3595.9640403596154;3619.4027985382645;3692.390755525308;7539.359154471931;7543.509671871311;7546.20764819697;7551.509151905108;7593.5823529706395;3994.2810294147334;4015.1768887378603;4017.5781542938157;4018.959810401917;4019.2363450944226;3163.225009872596;3333.4166520858753;3633.400488919299;3668.679275460832;3675.7978311192605;3039.3313471036777;3081.0910781319117;3107.502799552106;3124.3595063012026;3184.0607020928883;1007.8891321954579;1022.9795404091876;1034.524118905312;1034.5913364221242;1048.224314007629;797.8803179523118;799.2327365728966;808.296781799838;876.5573385440312;1015.0661391519671;5997;6062.333143354227;6062.969685151546;6066.029435290332;6085.2393450818645;870.7083127152475;920.8342498350361;926.1942110364026;928.5682157796657;930.3394589841289;4627.305904114342;4746.359241502422;4759.547842954914;4842.007388485423;4876.926846097312;7575.204603516661;7601;7739.148693643695;7771.883421748678;7882.802929926683;7505.174430812606;7739.458237923292;7766.8058298541855;7775.844483110419;7784.455088143889;5732.914006289826;5821.79623713168;5902.203202567598;5912.46787789101;5924.20023296858;5819.883602327845;5916.645001299936;5982.970085149546;6038.69806509664;6041.909371359346;6658.167729033871;6753.864922701617;6829.795106146824;6917.550359226835;6924.4114250289285;6901.102856628606;6970.337817907291;7037.683304251219;7042.753503627348;7173.0675012248075;4881.58506526935;5486.094794359045;5672.517835983987;5722.62802917809;5728.598998070095;5821.534277257724;6239.7504099837315;6277.780277690259;6312.179416675803;6412.23053233615;5775.075987841925;5828.94171058301;5899.351071382231;6023.27720673522;6062.969685151546;5683.914741278802;5739.110437882135;5806.303243610625;5857.970710146422;5976.073708575178;5839.386864379179;5892.234009578728;5895.852603684943;5952.8809423812145;6042.335343112342;5312.150055991023;5336.119540275966;5349.919751203813;5381.058314794974;5404.918926216032;5405.540529054917;5416.160495123262;5489.505944465017;5496;5499.065158922913 05:49:39 INFO - 2015-11-17 05:49:39,818 DEBUG : BROWSER_OUTPUT: |4;prototype.html;256.2019309849818;259.8674675915284;265.15680137163815;266.87056777462936;270.7454992307231;5234.319538459995;5289.92065119023;5305.363356397228;5313.78744850206;5320.733963301839;5231;5267.499587539187;5330.333708286465;5384.865378365543;5418.187271909215;4029.556748757649;4038.737482063671;4066.6949978751563;4072.063425412157;4109.97945010276;4036.3340048891896;4040.9797951010205;4071.4503542021894;4099.754014759124;4100.63094321511;3787.110029143149;4012.1975604878994;4021.6380525752675;4056.594340565949;4065.166640838636;3923.5880232575596;3924.725269231155;3926.6466018058513;3943.605639436062;3947.467091942594;3337.8998630041137;3368.0401085690705;3371.612264589579;3385;3386.847591858372;5090.33825602673;5103.336566246364;5237.16205407133;5290.100682883919;5295.364556253275;4467.173572889026;4476.61948734358;4537.705049171794;4541.43232095988;4549.977250113761;5546.889062218774;5617.775288988436;5618.831435056954;5624.775008999635;5641.323041235037;3530.4351303791527;3613.6205698401814;3686.152184997439;3694.556653201606;3726.981365093184;5731.914021289684;5780.1907732917425;5823.941760582382;5900.645961242296;5946.048632218867;3684.281565094781;3714.201446688975;3745.5318085239346;3754.192848537523;3764.5858955514873;3746.7751934883995;3760.9435858462143;3785.413260944503;3832.1952389997855;3842.3852183650483;4468.352088947149;4480.686351955332;4491.618212451978;4496;4523;5263.6578622389425;5309.787608495694;5519.172124181405;5637.379888212294;5675.858103547444;1332.9066965312336;1340.544214966916;1346.2528296795372;1356.4641966423405;1365.5357178559138;855.9572021398906;857.7726902370877;863.5897948474425;864.5201912938379;870.9825803483894;5295.232191332235;5371.838844834661;5392.892142157135;5399.973000134974;5466.972665136649;5751.712414379348;5850.61970971894;5867.735951882176;5884.617499862496;5919.408059194132;5319.946800532022;5340.145576707708;5374.247605335257;5401.054815407288;5446.564274858002;3029;3089.81461112334;3102.751779857606;3117.314190878003;3153.495440729472;5919.082542205965;5946.762129514857;5993.340732519419;6029.397060293935;6031.939680603138;5912.940870591325;5956.52347812174;5958.553108516879;6006.729697163638;6063.9090413643835;5724.4561766632105;5933.851653708605;5943.10853371989;5957.434043765836;5986.850328741816;5792.855178620568;5797.565182611405;5801.622894511843;5826.126081087701;5841.94158058431;5620.578456615688;5640.464155905182;5682.431756824284;5715.2855893013375;5724.484796368347;5992.5205983520345;5995.850103747442;6005.39946005396;6010.3088144863905;6017.849553761191;3604.3692353838496;3752.2307926874378;3792.7534710243744;3810.1236715555024;3810.847566097436;5637.9718101409235;5725.341585717696;5738.512226460798;5797.275340582427;5818.44724751148;5575.275214222125;5626.549876009827;5717.771289148387;5726.570507211893;5739.282589676291;5648.830535083954;5740.167675686918;5751.712414379181;5761.827145185651;5765.423457654201;5512.862178445571;5577;5581.5255703265675;5595.776168953196;5606.27118474612;5513.393526712139;5660.915086273627;5719.656820590778;5754.827355179351;5787;5577.916331255115;5642.238297829905;5651.632643878134;5664;5672.03575392176 05:49:39 INFO - 2015-11-17 05:49:39,822 DEBUG : BROWSER_OUTPUT: |5;yui.html;492.8399655605808;500.87227756922005;519.138230537308;539.2262103880929;549.3846891481542;10902.672919812409;11183.496742646581;11260.268082574627;11273.774524509505;11365.261258018234;10113.938036506172;10116.39301641902;10184.388936663805;10218.591256349737;10432.16542676586;531.5349069564131;550.4138092931036;653.398873036805;686.7459040155125;690.2821066091259;678.7827895073578;688.5180373738403;694.4236283884389;696.9372756451918;697.0102454514576;714.8034290570083;714.9356557909787;717.0534893940002;720.531654424623;733.9889901651479;714.1465948191939;715.6207210178613;716.0941409117471;718.4719231364943;724.6521669598595;519.7764961066778;524.281734024389;524.6039240373532;524.7795925711172;525.4482793067302;8986.55067246635;9081.863772043425;9130.223930965809;9222;9233.6306547738;6163.568550201488;6323.27282362525;7370.373518250955;7385.003024591665;7675.309222170032;6932.3760861522205;7133.89299160513;7134.464915131334;7300.306470885257;7397.2602739726135;2439.524292762912;2449.1795248591743;2477.913273035435;2485.2047344849657;2496.2636022373445;34293.142671433416;34823.477647835556;38625.22749544994;39154.412683809765;39486;5217.739113044333;5509.118541033416;5550.389457159709;5558.527525160407;5856.795012174639;9169.449833009907;9269.119433653792;9470.90529094714;9541.284403669753;9561.808763824823;4466.3523789050405;4625.190591646448;4639.211334073216;4687.67186296956;4880.92678609814;2821.7460428561117;2951.985240073786;3064.233941514621;3073.1548824073557;3087.1818967973504;2080.6150862090562;2084.5622419292117;2197.4726065744107;2213.878236696997;2230.286308381302;371.6228028551023;380.9390497520439;381.95416550014176;385.39108209029666;385.91509867829035;373.2385932697267;398.40836358008335;411.2515222295394;412.9710920235615;446.0343356632918;5868.941310586925;6259.812205633838;6511.28375878653;6689.866202675919;6734;319.0412809507415;363.8253638253653;397.1461358080093;425.62970215912355;442.6635756824772;2833.7591304738917;2926.268432891777;2952.129121909042;2973.628296462942;2978.3447641518833;44223;44496.110077798265;45216.547834521894;46838.29742553864;47404.288935665994;41066.38400423996;41972.37041444381;42034.369484457755;42094.1581168381;42925.78537107295;39019.41470877882;39224.215515689524;39532;39704.801475993016;40257.396139057935;6232.657203853832;6435.22777266731;6490.513211509061;6540.738370465128;6574.408303252731;29727.702722973358;29816.403671926873;30196.396072078875;30261.394772104875;30330.848345759012;36250.456243155844;39342.40986385149;39385.60614393934;39424;39700.40449393204;5787.797427090031;5824.650520968756;6012.128241405059;6077.604955677867;6161.199044124235;7917.168697286702;8422.410431269753;8540.786480338042;8714.215720585178;8720.607572659119;7676.424268179797;7786.727464538714;7867.803304917423;8396.706115285935;8454.239118479367;8036.437449378487;8297.294729948022;8304.87542686848;8305.46014509055;8433.578321083798;7936.761897143095;7960.960195198987;8047.919520804951;8065.919340806517;8228.670853166046;6461.321561236191;6738;6753.425958793361;6786.253512113565;6827.214870289781;6931.306869313028;6942.965285173542;6946.548474349152;7082.964585177041;7195.388391986739 05:49:39 INFO - 2015-11-17 05:49:39,822 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:49:39 INFO - 2015-11-17 05:49:39,822 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:49:39 INFO - 2015-11-17 05:49:39,822 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,306 05:49:39 INFO - 2015-11-17 05:49:39,823 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:49:39 INFO - 2015-11-17 05:49:39,823 DEBUG : BROWSER_OUTPUT: __startTimestamp1447768179807__endTimestamp 05:49:39 INFO - 2015-11-17 05:49:39,823 DEBUG : BROWSER_OUTPUT: 05:49:39 INFO - 2015-11-17 05:49:39,823 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:49:39 INFO - 2015-11-17 05:49:39,823 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:49:39 INFO - 2015-11-17 05:49:39,823 DEBUG : BROWSER_OUTPUT: 05:49:39 INFO - 2015-11-17 05:49:39,824 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4379.14 Median:4531.68 stddev:459.97 (10.2%) stddev-sans-first:438.22 05:49:39 INFO - 2015-11-17 05:49:39,824 DEBUG : BROWSER_OUTPUT: Values: 2541.9 2571.7 2596.7 2696.5 2711.3 4326.8 4388.9 4426.8 4442.8 4540.3 4261.7 4368.4 4423.0 4505.1 4556.3 3933.5 4088.2 4113.5 4153.8 4197.5 4066.1 4135.8 4149.6 4156.1 4210.3 3906.4 3983.3 4049.6 4089.7 4130.3 4085.0 4091.9 4092.6 4103.7 4113.1 4059.3 4067.9 4092.0 4098.4 4129.3 4042.2 4156.4 4309.8 4334.7 4443.1 4600.3 4618.1 4622.3 4669.8 4689.5 4651.8 4665.3 4683.8 4735.2 4744.8 4330.4 4332.2 4379.7 4443.2 4512.7 4820.7 4857.1 4880.8 4883.0 4912.5 4432.3 4649.2 4668.2 4698.0 4701.1 4440.4 4555.6 4675.6 4681.3 4751.0 4574.0 4607.0 4681.8 4686.3 4686.3 4522.0 4604.0 4663.8 4666.5 4672.5 3581.9 3650.3 3651.6 3684.1 3693.6 3350.4 3355.8 3357.6 3359.3 3377.6 4288.1 4294.5 4391.0 4462.4 4531.7 4656.5 4663.1 4697.6 4701.3 4740.1 4385.5 4403.6 4407.5 4451.4 4464.0 3999.6 4077.4 4082.8 4129.9 4132.1 4787.7 4800.8 4806.7 4846.4 4846.8 4569.4 4667.0 4680.1 4745.1 4765.3 4648.8 4749.5 4750.6 4791.1 4817.6 4641.6 4650.4 4655.4 4697.3 4698.4 4610.4 4716.8 4737.1 4772.6 4854.7 4500.1 4546.3 4644.6 4666.3 4674.9 4623.7 4644.5 4667.8 4684.1 4704.8 4425.8 4493.9 4508.6 4521.7 4634.4 4469.7 4542.2 4570.5 4629.7 4634.5 4521.5 4535.3 4547.4 4618.8 4626.1 05:49:39 INFO - 2015-11-17 05:49:39,824 DEBUG : BROWSER_OUTPUT: 05:49:39 INFO - 2015-11-17 05:49:39,824 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36403.78 Median:27966.01 stddev:60589.98 (216.7%) stddev-sans-first:60699.79 05:49:39 INFO - 2015-11-17 05:49:39,827 DEBUG : BROWSER_OUTPUT: Values: 443.2 453.4 477.5 485.5 488.2 30313.0 30943.7 31288.8 32037.4 32192.0 32040.8 32050.2 32253.8 32289.4 32844.7 7307.0 7455.1 7460.2 7476.9 7587.4 7259.6 7366.2 7380.7 7391.2 7514.4 7308.4 7410.7 7413.9 7455.9 7521.0 7425.0 7428.3 7475.1 7496.9 7596.3 7318.1 7336.3 7350.2 7356.7 7484.1 30655.2 30662.8 30850.7 30965.1 31388.7 2289.1 2321.5 2403.1 2429.0 2481.8 21649.2 21889.7 22540.9 22701.5 22835.0 1883.2 1888.1 1907.7 1916.5 1934.1 215178.0 216155.0 216596.0 217478.0 217763.0 39855.4 40158.6 43969.6 44553.3 45106.3 46553.5 46676.3 47039.0 47402.3 47466.7 11782.1 11852.5 11894.8 11901.8 11971.2 10123.3 10191.1 10193.4 10199.2 10203.5 14903.4 14910.9 14967.4 15076.7 15197.1 6600.6 6850.8 6854.5 6875.2 6914.3 772.8 776.9 790.5 799.1 921.6 23040.8 23042.9 23096.4 23160.4 23405.0 837.0 871.5 878.1 882.5 913.2 11885.8 11891.2 11992.4 12071.6 12140.0 243635.0 250957.0 253008.0 253630.0 256017.0 43361.3 43467.3 43671.6 43865.8 43976.6 1000.6 1015.2 1024.2 1027.5 1098.5 22701.5 22732.7 22830.0 22985.8 23183.8 37096.3 37441.6 37577.0 38131.4 38456.2 222197.0 224975.0 226341.0 229455.0 229698.0 25113.9 25124.0 25192.0 25250.2 25704.7 29574.4 30680.7 30733.8 30950.1 30962.7 25027.0 26090.7 26451.9 26672.6 27384.9 25632.7 25854.6 25886.4 25947.5 26431.0 27807.6 28124.4 29094.9 29100.0 29300.9 24030.5 24966.5 25062.5 25226.9 25813.1 19430.2 19433.9 19484.0 19577.5 19649.3 05:49:39 INFO - 2015-11-17 05:49:39,828 DEBUG : BROWSER_OUTPUT: 05:49:39 INFO - 2015-11-17 05:49:39,828 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24288.53 Median:26189.58 stddev:87745.71 (335.0%) stddev-sans-first:87973.32 05:49:39 INFO - 2015-11-17 05:49:39,828 DEBUG : BROWSER_OUTPUT: Values: 271.2 274.7 275.1 280.3 283.8 11098.3 13701.9 14386.6 14464.6 14483.2 9370.9 9579.0 9642.6 14357.4 14754.0 3584.1 3699.5 3728.8 3758.3 3766.0 3671.2 3680.0 3696.2 3713.4 3713.4 2777.8 2847.2 3629.9 3636.7 3867.8 3823.1 3909.8 3961.5 4010.6 4017.0 3346.1 3351.9 3354.8 3356.2 3357.0 10508.6 10899.8 10916.9 11042.2 11086.5 1515.6 1548.7 1557.4 1656.9 1670.6 7737.1 7761.8 8092.0 8127.6 8140.6 1274.9 1287.9 1307.0 1309.6 1310.4 44579.0 45990.5 47613.0 47840.8 48067.5 5240.7 5299.8 5378.9 5383.9 5450.4 6120.8 6123.9 6159.1 6165.8 6180.4 4395.1 4484.5 4509.9 4520.1 4578.7 4757.3 4766.2 4794.3 4799.4 4832.3 2340.4 2345.4 2354.6 2396.7 2406.7 858.5 862.2 869.0 879.5 915.0 347.8 352.2 365.4 371.1 377.8 9192.8 9632.3 9801.2 9901.5 9974.5 375.2 382.5 383.2 391.0 393.2 4818.0 5182.4 5224.6 5261.3 5383.2 518225.0 524623.0 533683.0 550250.0 554649.0 56435.0 56803.4 57795.4 58243.0 59414.1 414.4 414.8 415.4 421.3 424.2 8994.9 9055.0 9132.8 9238.4 9375.6 28046.7 28435.9 28445.6 28834.0 29318.9 35227.0 36509.0 36822.8 39183.2 39207.4 4937.5 5021.8 5109.8 5163.5 5198.1 9424.3 9516.3 9631.8 9739.1 9744.0 8138.8 8389.2 8403.0 8407.5 8531.4 6547.7 7703.0 8055.8 8093.0 8362.1 8620.8 8706.7 8725.8 8756.1 8850.0 4918.1 5031.6 5188.1 5226.2 5235.8 8177.1 8385.7 8444.4 8444.4 8462.5 05:49:39 INFO - 2015-11-17 05:49:39,828 DEBUG : BROWSER_OUTPUT: 05:49:39 INFO - 2015-11-17 05:49:39,828 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4506.75 Median:5813.09 stddev:2316.61 (39.9%) stddev-sans-first:2311.38 05:49:39 INFO - 2015-11-17 05:49:39,830 DEBUG : BROWSER_OUTPUT: Values: 1404.6 1412.4 1421.6 1435.0 1458.1 5918.0 5975.1 6031.5 6193.6 6214.8 6256.2 6349.2 6353.2 6492.1 6559.6 1871.3 1884.9 1891.5 1897.7 1904.6 1866.3 1880.8 1881.5 1884.5 1916.5 1868.3 1870.1 1871.6 1873.5 1897.2 1811.0 1834.9 1854.1 1855.8 1859.0 1878.6 1880.8 1882.4 1904.6 1939.4 6433.8 6498.4 6548.1 6557.1 6565.7 3935.8 4051.1 4051.8 4086.6 4090.7 2337.1 2355.2 2406.2 2440.5 2452.6 689.2 690.9 698.3 709.1 717.5 8582.6 8584.3 8617.8 8658.0 8705.3 3520.7 3524.1 3596.0 3619.4 3692.4 7539.4 7543.5 7546.2 7551.5 7593.6 3994.3 4015.2 4017.6 4019.0 4019.2 3163.2 3333.4 3633.4 3668.7 3675.8 3039.3 3081.1 3107.5 3124.4 3184.1 1007.9 1023.0 1034.5 1034.6 1048.2 797.9 799.2 808.3 876.6 1015.1 5997.0 6062.3 6063.0 6066.0 6085.2 870.7 920.8 926.2 928.6 930.3 4627.3 4746.4 4759.5 4842.0 4876.9 7575.2 7601.0 7739.1 7771.9 7882.8 7505.2 7739.5 7766.8 7775.8 7784.5 5732.9 5821.8 5902.2 5912.5 5924.2 5819.9 5916.6 5983.0 6038.7 6041.9 6658.2 6753.9 6829.8 6917.6 6924.4 6901.1 6970.3 7037.7 7042.8 7173.1 4881.6 5486.1 5672.5 5722.6 5728.6 5821.5 6239.8 6277.8 6312.2 6412.2 5775.1 5828.9 5899.4 6023.3 6063.0 5683.9 5739.1 5806.3 5858.0 5976.1 5839.4 5892.2 5895.9 5952.9 6042.3 5312.2 5336.1 5349.9 5381.1 5404.9 5405.5 5416.2 5489.5 5496.0 5499.1 05:49:39 INFO - 2015-11-17 05:49:39,830 DEBUG : BROWSER_OUTPUT: 05:49:39 INFO - 2015-11-17 05:49:39,830 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4659.04 Median:5388.88 stddev:1458.28 (27.1%) stddev-sans-first:1424.44 05:49:39 INFO - 2015-11-17 05:49:39,830 DEBUG : BROWSER_OUTPUT: Values: 256.2 259.9 265.2 266.9 270.7 5234.3 5289.9 5305.4 5313.8 5320.7 5231.0 5267.5 5330.3 5384.9 5418.2 4029.6 4038.7 4066.7 4072.1 4110.0 4036.3 4041.0 4071.5 4099.8 4100.6 3787.1 4012.2 4021.6 4056.6 4065.2 3923.6 3924.7 3926.6 3943.6 3947.5 3337.9 3368.0 3371.6 3385.0 3386.8 5090.3 5103.3 5237.2 5290.1 5295.4 4467.2 4476.6 4537.7 4541.4 4550.0 5546.9 5617.8 5618.8 5624.8 5641.3 3530.4 3613.6 3686.2 3694.6 3727.0 5731.9 5780.2 5823.9 5900.6 5946.0 3684.3 3714.2 3745.5 3754.2 3764.6 3746.8 3760.9 3785.4 3832.2 3842.4 4468.4 4480.7 4491.6 4496.0 4523.0 5263.7 5309.8 5519.2 5637.4 5675.9 1332.9 1340.5 1346.3 1356.5 1365.5 856.0 857.8 863.6 864.5 871.0 5295.2 5371.8 5392.9 5400.0 5467.0 5751.7 5850.6 5867.7 5884.6 5919.4 5319.9 5340.1 5374.2 5401.1 5446.6 3029.0 3089.8 3102.8 3117.3 3153.5 5919.1 5946.8 5993.3 6029.4 6031.9 5912.9 5956.5 5958.6 6006.7 6063.9 5724.5 5933.9 5943.1 5957.4 5986.9 5792.9 5797.6 5801.6 5826.1 5841.9 5620.6 5640.5 5682.4 5715.3 5724.5 5992.5 5995.9 6005.4 6010.3 6017.8 3604.4 3752.2 3792.8 3810.1 3810.8 5638.0 5725.3 5738.5 5797.3 5818.4 5575.3 5626.5 5717.8 5726.6 5739.3 5648.8 5740.2 5751.7 5761.8 5765.4 5512.9 5577.0 5581.5 5595.8 5606.3 5513.4 5660.9 5719.7 5754.8 5787.0 5577.9 5642.2 5651.6 5664.0 5672.0 05:49:39 INFO - 2015-11-17 05:49:39,830 DEBUG : BROWSER_OUTPUT: 05:49:39 INFO - 2015-11-17 05:49:39,830 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10516.81 Median:544.31 stddev:13274.70 (2438.8%) stddev-sans-first:13290.60 05:49:39 INFO - 2015-11-17 05:49:39,832 DEBUG : BROWSER_OUTPUT: Values: 492.8 500.9 519.1 539.2 549.4 10902.7 11183.5 11260.3 11273.8 11365.3 10113.9 10116.4 10184.4 10218.6 10432.2 531.5 550.4 653.4 686.7 690.3 678.8 688.5 694.4 696.9 697.0 714.8 714.9 717.1 720.5 734.0 714.1 715.6 716.1 718.5 724.7 519.8 524.3 524.6 524.8 525.4 8986.6 9081.9 9130.2 9222.0 9233.6 6163.6 6323.3 7370.4 7385.0 7675.3 6932.4 7133.9 7134.5 7300.3 7397.3 2439.5 2449.2 2477.9 2485.2 2496.3 34293.1 34823.5 38625.2 39154.4 39486.0 5217.7 5509.1 5550.4 5558.5 5856.8 9169.4 9269.1 9470.9 9541.3 9561.8 4466.4 4625.2 4639.2 4687.7 4880.9 2821.7 2952.0 3064.2 3073.2 3087.2 2080.6 2084.6 2197.5 2213.9 2230.3 371.6 380.9 382.0 385.4 385.9 373.2 398.4 411.3 413.0 446.0 5868.9 6259.8 6511.3 6689.9 6734.0 319.0 363.8 397.1 425.6 442.7 2833.8 2926.3 2952.1 2973.6 2978.3 44223.0 44496.1 45216.5 46838.3 47404.3 41066.4 41972.4 42034.4 42094.2 42925.8 39019.4 39224.2 39532.0 39704.8 40257.4 6232.7 6435.2 6490.5 6540.7 6574.4 29727.7 29816.4 30196.4 30261.4 30330.8 36250.5 39342.4 39385.6 39424.0 39700.4 5787.8 5824.7 6012.1 6077.6 6161.2 7917.2 8422.4 8540.8 8714.2 8720.6 7676.4 7786.7 7867.8 8396.7 8454.2 8036.4 8297.3 8304.9 8305.5 8433.6 7936.8 7961.0 8047.9 8065.9 8228.7 6461.3 6738.0 6753.4 6786.3 6827.2 6931.3 6943.0 6946.5 7083.0 7195.4 05:49:39 INFO - 2015-11-17 05:49:39,832 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:49:39 INFO - 2015-11-17 05:49:39,832 DEBUG : BROWSER_OUTPUT: 05:49:40 INFO - 2015-11-17 05:49:40,519 INFO : Browser exited with error code: 0 05:49:40 INFO - 2015-11-17 05:49:40,551 INFO : Completed test dromaeo_css (00:18:34) 05:49:40 INFO - 2015-11-17 05:49:40,551 INFO : Starting test kraken 05:49:40 INFO - 2015-11-17 05:49:40,551 DEBUG : operating with platform_type : mac_ 05:49:40 INFO - 2015-11-17 05:49:40,552 INFO : Initialising browser for kraken test... 05:49:40 INFO - 2015-11-17 05:49:40,566 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmpUlgxca/profile http://localhost:49267/getInfo.html 05:49:44 INFO - 2015-11-17 05:49:44,062 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:49:44 INFO - 2015-11-17 05:49:44,062 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:49:44 INFO - 2015-11-17 05:49:44,062 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 05:49:44 INFO - 2015-11-17 05:49:44,063 DEBUG : BROWSER_OUTPUT: __metrics 05:49:44 INFO - 2015-11-17 05:49:44,807 INFO : Browser initialized. 05:49:44 INFO - 2015-11-17 05:49:44,808 INFO : Running cycle 1/1 for kraken test... 05:49:44 INFO - 2015-11-17 05:49:44,808 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmpUlgxca/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:49:57 INFO - 2015-11-17 05:49:57,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 242024448 05:49:57 INFO - 2015-11-17 05:49:57,078 DEBUG : BROWSER_OUTPUT: 05:50:00 INFO - 2015-11-17 05:50:00,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 05:50:00 INFO - 2015-11-17 05:50:00,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 259543040 05:50:00 INFO - 2015-11-17 05:50:00,607 DEBUG : BROWSER_OUTPUT: 05:50:03 INFO - 2015-11-17 05:50:03,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 05:50:04 INFO - 2015-11-17 05:50:04,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 267001856 05:50:04 INFO - 2015-11-17 05:50:04,295 DEBUG : BROWSER_OUTPUT: 05:50:07 INFO - 2015-11-17 05:50:07,652 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 05:50:08 INFO - 2015-11-17 05:50:08,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 267128832 05:50:08 INFO - 2015-11-17 05:50:08,228 DEBUG : BROWSER_OUTPUT: 05:50:10 INFO - 2015-11-17 05:50:10,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 05:50:11 INFO - 2015-11-17 05:50:11,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 268705792 05:50:11 INFO - 2015-11-17 05:50:11,083 DEBUG : BROWSER_OUTPUT: 05:50:13 INFO - 2015-11-17 05:50:13,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:50:14 INFO - 2015-11-17 05:50:14,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 268886016 05:50:14 INFO - 2015-11-17 05:50:14,094 DEBUG : BROWSER_OUTPUT: 05:50:17 INFO - 2015-11-17 05:50:17,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 05:50:18 INFO - 2015-11-17 05:50:18,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 267321344 05:50:18 INFO - 2015-11-17 05:50:18,247 DEBUG : BROWSER_OUTPUT: 05:50:21 INFO - 2015-11-17 05:50:21,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 05:50:22 INFO - 2015-11-17 05:50:22,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 265699328 05:50:22 INFO - 2015-11-17 05:50:22,538 DEBUG : BROWSER_OUTPUT: 05:50:25 INFO - 2015-11-17 05:50:25,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 05:50:26 INFO - 2015-11-17 05:50:26,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 267526144 05:50:26 INFO - 2015-11-17 05:50:26,460 DEBUG : BROWSER_OUTPUT: 05:50:28 INFO - 2015-11-17 05:50:28,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:50:28 INFO - 2015-11-17 05:50:28,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 267141120 05:50:28 INFO - 2015-11-17 05:50:28,856 DEBUG : BROWSER_OUTPUT: 05:50:30 INFO - 2015-11-17 05:50:30,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:50:31 INFO - 2015-11-17 05:50:31,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 267280384 05:50:31 INFO - 2015-11-17 05:50:31,583 DEBUG : BROWSER_OUTPUT: 05:50:34 INFO - 2015-11-17 05:50:34,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:50:34 INFO - 2015-11-17 05:50:34,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 267493376 05:50:34 INFO - 2015-11-17 05:50:34,601 DEBUG : BROWSER_OUTPUT: 05:50:37 INFO - 2015-11-17 05:50:37,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:50:38 INFO - 2015-11-17 05:50:38,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 267317248 05:50:38 INFO - 2015-11-17 05:50:38,266 DEBUG : BROWSER_OUTPUT: 05:50:41 INFO - 2015-11-17 05:50:41,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:50:41 INFO - 2015-11-17 05:50:41,974 DEBUG : BROWSER_OUTPUT: RSS: Main: 268500992 05:50:41 INFO - 2015-11-17 05:50:41,974 DEBUG : BROWSER_OUTPUT: 05:50:43 INFO - 2015-11-17 05:50:43,921 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 05:50:44 INFO - 2015-11-17 05:50:44,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 268242944 05:50:44 INFO - 2015-11-17 05:50:44,173 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,173 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:50:44 INFO - 2015-11-17 05:50:44,173 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:50:44 INFO - 2015-11-17 05:50:44,173 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:50:44 INFO - 2015-11-17 05:50:44,173 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:50:44 INFO - 2015-11-17 05:50:44,173 DEBUG : BROWSER_OUTPUT: |0;ai-astar;128;123;141;140;134;147;133;135;141;140 05:50:44 INFO - 2015-11-17 05:50:44,174 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;177;166;194;206;165;178;178;165;204;166 05:50:44 INFO - 2015-11-17 05:50:44,174 DEBUG : BROWSER_OUTPUT: |2;audio-dft;197;214;209;207;203;201;201;205;205;211 05:50:44 INFO - 2015-11-17 05:50:44,174 DEBUG : BROWSER_OUTPUT: |3;audio-fft;84;89;98;148;86;89;91;91;125;84 05:50:44 INFO - 2015-11-17 05:50:44,174 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;102;104;150;112;115;115;148;108;110;155 05:50:44 INFO - 2015-11-17 05:50:44,174 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;142;148;150;154;150;149;156;153;149;142 05:50:44 INFO - 2015-11-17 05:50:44,174 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;165;165;157;157;166;165;162;157;165;164 05:50:44 INFO - 2015-11-17 05:50:44,174 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;121;133;123;136;128;125;123;124;124;133 05:50:44 INFO - 2015-11-17 05:50:44,174 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;77;77;78;82;88;81;90;81;81 05:50:44 INFO - 2015-11-17 05:50:44,174 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;85;83;82;87;86;90;92;94;95;92 05:50:44 INFO - 2015-11-17 05:50:44,174 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;102;105;115;112;113;111;112;111;113;107 05:50:44 INFO - 2015-11-17 05:50:44,174 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;161;163;160;174;163;172;164;166;172;159 05:50:44 INFO - 2015-11-17 05:50:44,175 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;181;199;206;199;191;192;204;206;204;182 05:50:44 INFO - 2015-11-17 05:50:44,175 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;83;89;88;93;93;94;94;93;94;92 05:50:44 INFO - 2015-11-17 05:50:44,175 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:50:44 INFO - 2015-11-17 05:50:44,175 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:50:44 INFO - 2015-11-17 05:50:44,175 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,756 05:50:44 INFO - 2015-11-17 05:50:44,175 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:50:44 INFO - 2015-11-17 05:50:44,175 DEBUG : BROWSER_OUTPUT: __startTimestamp1447768244172__endTimestamp 05:50:44 INFO - 2015-11-17 05:50:44,175 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,178 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:50:44 INFO - 2015-11-17 05:50:44,179 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:50:44 INFO - 2015-11-17 05:50:44,179 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,179 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:136.20 Median:140.00 stddev:7.07 (5.0%) stddev-sans-first:6.85 05:50:44 INFO - 2015-11-17 05:50:44,179 DEBUG : BROWSER_OUTPUT: Values: 128.0 123.0 141.0 140.0 134.0 147.0 133.0 135.0 141.0 140.0 05:50:44 INFO - 2015-11-17 05:50:44,179 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,179 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:179.90 Median:178.00 stddev:16.01 (9.0%) stddev-sans-first:16.95 05:50:44 INFO - 2015-11-17 05:50:44,180 DEBUG : BROWSER_OUTPUT: Values: 177.0 166.0 194.0 206.0 165.0 178.0 178.0 165.0 204.0 166.0 05:50:44 INFO - 2015-11-17 05:50:44,180 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,180 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:205.30 Median:206.00 stddev:5.12 (2.5%) stddev-sans-first:4.47 05:50:44 INFO - 2015-11-17 05:50:44,180 DEBUG : BROWSER_OUTPUT: Values: 197.0 214.0 209.0 207.0 203.0 201.0 201.0 205.0 205.0 211.0 05:50:44 INFO - 2015-11-17 05:50:44,180 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,181 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:98.50 Median:89.00 stddev:21.14 (23.8%) stddev-sans-first:21.76 05:50:44 INFO - 2015-11-17 05:50:44,181 DEBUG : BROWSER_OUTPUT: Values: 84.0 89.0 98.0 148.0 86.0 89.0 91.0 91.0 125.0 84.0 05:50:44 INFO - 2015-11-17 05:50:44,181 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,181 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:121.90 Median:115.00 stddev:20.58 (17.9%) stddev-sans-first:20.53 05:50:44 INFO - 2015-11-17 05:50:44,181 DEBUG : BROWSER_OUTPUT: Values: 102.0 104.0 150.0 112.0 115.0 115.0 148.0 108.0 110.0 155.0 05:50:44 INFO - 2015-11-17 05:50:44,181 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,182 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:149.30 Median:150.00 stddev:4.60 (3.1%) stddev-sans-first:4.04 05:50:44 INFO - 2015-11-17 05:50:44,182 DEBUG : BROWSER_OUTPUT: Values: 142.0 148.0 150.0 154.0 150.0 149.0 156.0 153.0 149.0 142.0 05:50:44 INFO - 2015-11-17 05:50:44,182 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,182 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:162.30 Median:165.00 stddev:3.80 (2.3%) stddev-sans-first:3.91 05:50:44 INFO - 2015-11-17 05:50:44,182 DEBUG : BROWSER_OUTPUT: Values: 165.0 165.0 157.0 157.0 166.0 165.0 162.0 157.0 165.0 164.0 05:50:44 INFO - 2015-11-17 05:50:44,183 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,183 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:127.00 Median:126.50 stddev:5.21 (4.1%) stddev-sans-first:5.05 05:50:44 INFO - 2015-11-17 05:50:44,183 DEBUG : BROWSER_OUTPUT: Values: 121.0 133.0 123.0 136.0 128.0 125.0 123.0 124.0 124.0 133.0 05:50:44 INFO - 2015-11-17 05:50:44,183 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,183 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:80.70 Median:81.00 stddev:5.29 (6.5%) stddev-sans-first:4.58 05:50:44 INFO - 2015-11-17 05:50:44,183 DEBUG : BROWSER_OUTPUT: Values: 72.0 77.0 77.0 78.0 82.0 88.0 81.0 90.0 81.0 81.0 05:50:44 INFO - 2015-11-17 05:50:44,183 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,185 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:88.60 Median:91.00 stddev:4.62 (5.1%) stddev-sans-first:4.72 05:50:44 INFO - 2015-11-17 05:50:44,185 DEBUG : BROWSER_OUTPUT: Values: 85.0 83.0 82.0 87.0 86.0 90.0 92.0 94.0 95.0 92.0 05:50:44 INFO - 2015-11-17 05:50:44,185 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,185 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:110.10 Median:112.00 stddev:4.09 (3.7%) stddev-sans-first:3.12 05:50:44 INFO - 2015-11-17 05:50:44,185 DEBUG : BROWSER_OUTPUT: Values: 102.0 105.0 115.0 112.0 113.0 111.0 112.0 111.0 113.0 107.0 05:50:44 INFO - 2015-11-17 05:50:44,185 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,185 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:165.40 Median:165.00 stddev:5.42 (3.3%) stddev-sans-first:5.51 05:50:44 INFO - 2015-11-17 05:50:44,185 DEBUG : BROWSER_OUTPUT: Values: 161.0 163.0 160.0 174.0 163.0 172.0 164.0 166.0 172.0 159.0 05:50:44 INFO - 2015-11-17 05:50:44,185 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,185 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.40 Median:201.50 stddev:9.47 (4.7%) stddev-sans-first:8.24 05:50:44 INFO - 2015-11-17 05:50:44,186 DEBUG : BROWSER_OUTPUT: Values: 181.0 199.0 206.0 199.0 191.0 192.0 204.0 206.0 204.0 182.0 05:50:44 INFO - 2015-11-17 05:50:44,186 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,186 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:91.30 Median:93.00 stddev:3.59 (3.9%) stddev-sans-first:2.22 05:50:44 INFO - 2015-11-17 05:50:44,186 DEBUG : BROWSER_OUTPUT: Values: 83.0 89.0 88.0 93.0 93.0 94.0 94.0 93.0 94.0 92.0 05:50:44 INFO - 2015-11-17 05:50:44,186 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:50:44 INFO - 2015-11-17 05:50:44,186 DEBUG : BROWSER_OUTPUT: 05:50:44 INFO - 2015-11-17 05:50:44,911 INFO : Browser exited with error code: 0 05:50:44 INFO - 2015-11-17 05:50:44,968 INFO : Completed test kraken (00:01:04) 05:50:44 INFO - 2015-11-17 05:50:44,969 INFO : Starting test v8_7 05:50:44 INFO - 2015-11-17 05:50:44,969 DEBUG : operating with platform_type : mac_ 05:50:44 INFO - 2015-11-17 05:50:44,969 INFO : Initialising browser for v8_7 test... 05:50:44 INFO - 2015-11-17 05:50:44,984 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmpwWu5oW/profile http://localhost:49267/getInfo.html 05:50:48 INFO - 2015-11-17 05:50:48,382 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:50:48 INFO - 2015-11-17 05:50:48,383 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:50:48 INFO - 2015-11-17 05:50:48,383 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 05:50:48 INFO - 2015-11-17 05:50:48,383 DEBUG : BROWSER_OUTPUT: __metrics 05:50:49 INFO - 2015-11-17 05:50:49,120 INFO : Browser initialized. 05:50:49 INFO - 2015-11-17 05:50:49,120 INFO : Running cycle 1/1 for v8_7 test... 05:50:49 INFO - 2015-11-17 05:50:49,121 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmpwWu5oW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:51:01 INFO - 2015-11-17 05:51:01,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 240472064 05:51:01 INFO - 2015-11-17 05:51:01,357 DEBUG : BROWSER_OUTPUT: 05:51:24 INFO - 2015-11-17 05:51:24,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/v8_7/run.html (next: http://localhost:49267/tests/v8_7/run.html) 05:51:24 INFO - 2015-11-17 05:51:24,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 260644864 05:51:24 INFO - 2015-11-17 05:51:24,292 DEBUG : BROWSER_OUTPUT: 05:51:24 INFO - 2015-11-17 05:51:24,292 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:51:24 INFO - 2015-11-17 05:51:24,292 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:51:24 INFO - 2015-11-17 05:51:24,292 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:51:24 INFO - 2015-11-17 05:51:24,292 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:51:24 INFO - 2015-11-17 05:51:24,293 DEBUG : BROWSER_OUTPUT: |0;Richards;879.5074758135444 05:51:24 INFO - 2015-11-17 05:51:24,293 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;238.60653781913624 05:51:24 INFO - 2015-11-17 05:51:24,293 DEBUG : BROWSER_OUTPUT: |2;Encrypt;388.19875776397515 05:51:24 INFO - 2015-11-17 05:51:24,293 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6896.551724137931 05:51:24 INFO - 2015-11-17 05:51:24,293 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1351.3513513513512 05:51:24 INFO - 2015-11-17 05:51:24,293 DEBUG : BROWSER_OUTPUT: |5;Earley;962.4639076034649 05:51:24 INFO - 2015-11-17 05:51:24,293 DEBUG : BROWSER_OUTPUT: |6;Boyer;16274.193548387097 05:51:24 INFO - 2015-11-17 05:51:24,293 DEBUG : BROWSER_OUTPUT: |7;RegExp;35068.96551724138 05:51:24 INFO - 2015-11-17 05:51:24,293 DEBUG : BROWSER_OUTPUT: |8;Splay;874.8906386701663 05:51:24 INFO - 2015-11-17 05:51:24,293 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6951.388888888889 05:51:24 INFO - 2015-11-17 05:51:24,294 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:51:24 INFO - 2015-11-17 05:51:24,294 DEBUG : BROWSER_OUTPUT: __startTimestamp1447768284287__endTimestamp 05:51:24 INFO - 2015-11-17 05:51:24,294 DEBUG : BROWSER_OUTPUT: 05:51:24 INFO - 2015-11-17 05:51:24,294 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:51:24 INFO - 2015-11-17 05:51:24,294 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:51:24 INFO - 2015-11-17 05:51:24,294 DEBUG : BROWSER_OUTPUT: 05:51:24 INFO - 2015-11-17 05:51:24,294 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:879.51 Median:879.51 stddev:0.00 (0.0%) 05:51:24 INFO - 2015-11-17 05:51:24,294 DEBUG : BROWSER_OUTPUT: Values: 879.5 05:51:24 INFO - 2015-11-17 05:51:24,295 DEBUG : BROWSER_OUTPUT: 05:51:24 INFO - 2015-11-17 05:51:24,295 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:238.61 Median:238.61 stddev:0.00 (0.0%) 05:51:24 INFO - 2015-11-17 05:51:24,295 DEBUG : BROWSER_OUTPUT: Values: 238.6 05:51:24 INFO - 2015-11-17 05:51:24,295 DEBUG : BROWSER_OUTPUT: 05:51:24 INFO - 2015-11-17 05:51:24,295 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:388.20 Median:388.20 stddev:0.00 (0.0%) 05:51:24 INFO - 2015-11-17 05:51:24,295 DEBUG : BROWSER_OUTPUT: Values: 388.2 05:51:24 INFO - 2015-11-17 05:51:24,295 DEBUG : BROWSER_OUTPUT: 05:51:24 INFO - 2015-11-17 05:51:24,295 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6896.55 Median:6896.55 stddev:0.00 (0.0%) 05:51:24 INFO - 2015-11-17 05:51:24,295 DEBUG : BROWSER_OUTPUT: Values: 6896.6 05:51:24 INFO - 2015-11-17 05:51:24,295 DEBUG : BROWSER_OUTPUT: 05:51:24 INFO - 2015-11-17 05:51:24,295 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1351.35 Median:1351.35 stddev:0.00 (0.0%) 05:51:24 INFO - 2015-11-17 05:51:24,295 DEBUG : BROWSER_OUTPUT: Values: 1351.4 05:51:24 INFO - 2015-11-17 05:51:24,295 DEBUG : BROWSER_OUTPUT: 05:51:24 INFO - 2015-11-17 05:51:24,296 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:962.46 Median:962.46 stddev:0.00 (0.0%) 05:51:24 INFO - 2015-11-17 05:51:24,296 DEBUG : BROWSER_OUTPUT: Values: 962.5 05:51:24 INFO - 2015-11-17 05:51:24,296 DEBUG : BROWSER_OUTPUT: 05:51:24 INFO - 2015-11-17 05:51:24,296 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16274.19 Median:16274.19 stddev:0.00 (0.0%) 05:51:24 INFO - 2015-11-17 05:51:24,296 DEBUG : BROWSER_OUTPUT: Values: 16274.2 05:51:24 INFO - 2015-11-17 05:51:24,296 DEBUG : BROWSER_OUTPUT: 05:51:24 INFO - 2015-11-17 05:51:24,296 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35068.97 Median:35068.97 stddev:0.00 (0.0%) 05:51:24 INFO - 2015-11-17 05:51:24,296 DEBUG : BROWSER_OUTPUT: Values: 35069.0 05:51:24 INFO - 2015-11-17 05:51:24,296 DEBUG : BROWSER_OUTPUT: 05:51:24 INFO - 2015-11-17 05:51:24,296 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:874.89 Median:874.89 stddev:0.00 (0.0%) 05:51:24 INFO - 2015-11-17 05:51:24,296 DEBUG : BROWSER_OUTPUT: Values: 874.9 05:51:24 INFO - 2015-11-17 05:51:24,296 DEBUG : BROWSER_OUTPUT: 05:51:24 INFO - 2015-11-17 05:51:24,296 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6951.39 Median:6951.39 stddev:0.00 (0.0%) 05:51:24 INFO - 2015-11-17 05:51:24,296 DEBUG : BROWSER_OUTPUT: Values: 6951.4 05:51:24 INFO - 2015-11-17 05:51:24,297 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:51:24 INFO - 2015-11-17 05:51:24,297 DEBUG : BROWSER_OUTPUT: 05:51:25 INFO - 2015-11-17 05:51:25,046 INFO : Browser exited with error code: 0 05:51:25 INFO - 2015-11-17 05:51:25,070 INFO : Completed test v8_7 (00:00:40) 05:51:25 INFO - 2015-11-17 05:51:25,162 INFO : Completed test suite (00:20:18) 05:51:25 INFO - 2015-11-17 05:51:25,162 DEBUG : Working with test: dromaeo_css 05:51:25 INFO - 2015-11-17 05:51:25,163 DEBUG : Generating results file: dromaeo_css 05:51:25 INFO - 2015-11-17 05:51:25,163 DEBUG : Working with test: kraken 05:51:25 INFO - 2015-11-17 05:51:25,164 DEBUG : Generating results file: kraken 05:51:25 INFO - 2015-11-17 05:51:25,164 INFO : javascript benchmark 05:51:25 INFO - 2015-11-17 05:51:25,164 DEBUG : Working with test: v8_7 05:51:25 INFO - 2015-11-17 05:51:25,164 DEBUG : Generating results file: v8_7 05:51:25 INFO - 2015-11-17 05:51:25,164 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:25 INFO - 2015-11-17 05:51:25,222 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,57]] 05:51:25 INFO - 2015-11-17 05:51:25,222 DEBUG : process_Request line: dromaeo_css 5368.63 graph.html#tests=[[72,1,57]] 05:51:25 INFO - 2015-11-17 05:51:25,222 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:25 INFO - 2015-11-17 05:51:25,255 DEBUG : process_Request line: kraken 1912.90 graph.html#tests=[[232,1,57]] 05:51:25 INFO - 2015-11-17 05:51:25,255 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:25 INFO - 2015-11-17 05:51:25,285 DEBUG : process_Request line: v8_7 13806.12 graph.html#tests=[[230,1,57]] 05:51:25 INFO - 2015-11-17 05:51:25,286 INFO : javascript benchmark 05:51:25 INFO - 2015-11-17 05:51:25,289 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [271.2148330582961, 274.67588245869877, 275.1484156535522, 280.3370029879335, 283.78999540340146, 11098.334099954009, 13701.931490342547, 14386.568402947914, 14464.566063018114, 14483.203423811687, 9370.906290937088, 9579.0, 9642.566084526195, 14357.425702971896, 14754.0, 3584.139806446454, 3699.46357778122, 3728.757630753992, 3758.267137908109, 3766.020834583014, 3671.1556342041345, 3679.9880032990873, 3696.20531585709, 3713.3501637213517, 3713.4058550631903, 2777.8333300001964, 2847.2454799478155, 3629.9274014519824, 3636.672699457048, 3867.845286188563, 3823.1397935464574, 3909.8045097745285, 3961.4652021977095, 4010.6189911958318, 4017.0, 3346.1467325832, 3351.916202094943, 3354.815485148316, 3356.228067544454, 3356.9664303357144, 10508.632197873114, 10899.782004359948, 10916.945415272952, 11042.227044106916, 11086.501107450184, 1515.6210947263185, 1548.7212301785673, 1557.4159690116207, 1656.9171541422882, 1670.5656529302348, 7737.148913619498, 7761.805954851117, 8091.959540202321, 8127.5529845858455, 8140.633671484798, 1274.898008159345, 1287.851897031844, 1306.9738605227938, 1309.6267563744286, 1310.3710219094887, 44579.0, 45990.54009459896, 47613.0, 47840.76079619615, 48067.51932480666, 5240.711760853113, 5299.761510732026, 5378.91931621026, 5383.919241211385, 5450.427705090988, 6120.78577249803, 6123.877522449615, 6159.1069294951985, 6165.84585385369, 6180.443760061616, 4395.120975804852, 4484.529124441887, 4509.909801803946, 4520.095980803787, 4578.656600754956, 4757.310190022427, 4766.165920963817, 4794.304825800239, 4799.400074990626, 4832.251001094836, 2340.3564019894666, 2345.425370784169, 2354.6350315701093, 2396.74834142416, 2406.6630671705975, 858.52780970466, 862.1895418306772, 868.9869651955225, 879.5162660536679, 914.970658009739, 347.7723635566455, 352.1706381471649, 365.43540230344183, 371.0926784013116, 377.7638975640225, 9192.816143677222, 9632.32573719847, 9801.16690081351, 9901.504924753734, 9974.501274936225, 375.15964240101977, 382.4836470764446, 383.1780830119378, 390.9921801563953, 393.22142158526276, 4817.975910120427, 5182.378114626269, 5224.608154388436, 5261.316028916293, 5383.192521121863, 518225.0, 524623.0, 533683.0, 550250.0, 554649.0, 56435.0, 56803.43196567981, 57795.422045779844, 58243.0, 59414.10878836821, 414.3867076726462, 414.80089557012803, 415.41219174867825, 421.3490157706351, 424.16439613959835, 8994.865077023718, 9054.954725226595, 9132.817343652956, 9238.353315268136, 9375.624975001196, 28046.719532805226, 28435.857820710764, 28445.573316399856, 28834.0, 29318.853405733687, 35227.0, 36509.0, 36822.8158859204, 39183.2163356737, 39207.41188882112, 4937.530934561211, 5021.84934451967, 5109.795608175631, 5163.535281824654, 5198.116320225495, 9424.293178011814, 9516.33385662997, 9631.807363852824, 9739.123478886651, 9744.0, 8138.755837324889, 8389.161083891562, 8402.957985210034, 8407.537585432616, 8531.402801803813, 6547.672616369257, 7702.961485192538, 8055.798605034921, 8093.0, 8362.080171181287, 8620.827583448421, 8706.651733930572, 8725.781855453664, 8756.124387561193, 8850.026497085186, 4918.114739346809, 5031.597472202288, 5188.143956247177, 5226.216067589892, 5235.816746413857, 8177.100518943031, 8385.74842754694, 8444.366672499464, 8444.408891377545, 8462.492250464991], "dojo.html": [2541.9110331138413, 2571.6656834611504, 2596.7013793413753, 2696.528107581174, 2711.3492761737166, 4326.84856030039, 4388.9341659875045, 4426.800793964276, 4442.755648439334, 4540.3189521571785, 4261.701680882339, 4368.410264614284, 4422.955770442302, 4505.076459325838, 4556.316552517116, 3933.5476420211685, 4088.2028004539125, 4113.547509773923, 4153.813078411479, 4197.538270790211, 4066.146109317047, 4135.751854888701, 4149.605787450188, 4156.147989662112, 4210.263203939314, 3906.3945088511327, 3983.2630963271886, 4049.5747946465785, 4089.7137200395982, 4130.318497447917, 4084.979575102135, 4091.85678501254, 4092.5702801205744, 4103.692223083281, 4113.074558224405, 4059.303892809003, 4067.877963661095, 4092.0179157002403, 4098.446709694183, 4129.318662420727, 4042.2319759245943, 4156.376543518466, 4309.82760689572, 4334.739915605074, 4443.133588950156, 4600.263957766741, 4618.076384723069, 4622.329762184498, 4669.766511674403, 4689.460712018127, 4651.767411629405, 4665.2535594304745, 4683.765811709401, 4735.1713450146435, 4744.810207591692, 4330.39374487572, 4332.241857674894, 4379.693421460531, 4443.178012067746, 4512.661550383735, 4820.662553621283, 4857.149998750205, 4880.804767809319, 4883.02339532095, 4912.533309335608, 4432.29083346663, 4649.163150632919, 4668.183067963093, 4697.95302046982, 4701.059788042337, 4440.378347031418, 4555.63554915606, 4675.555822196886, 4681.32120842476, 4750.95249047512, 4573.954260457353, 4606.976965115153, 4681.789319480631, 4686.250199968057, 4686.297055441711, 4521.977390113028, 4603.976980115078, 4663.813447462131, 4666.510016448224, 4672.486026537078, 3581.94627080594, 3650.3429382710838, 3651.634836516327, 3684.060564556021, 3693.649103335179, 3350.4136776064092, 3355.832208389571, 3357.5970883494138, 3359.277755282626, 3377.594688637379, 4288.120935208275, 4294.527601963781, 4391.033972526039, 4462.352958821018, 4531.682782205214, 4656.534346565317, 4663.137319595886, 4697.600703940135, 4701.271302948048, 4740.1230772307235, 4385.495667998221, 4403.625691816167, 4407.537208593116, 4451.421315228999, 4463.977680111579, 3999.580044095328, 4077.3883917412627, 4082.795860206978, 4129.855455059059, 4132.132252227006, 4787.712737235777, 4800.807967681323, 4806.663533552688, 4846.418429788378, 4846.781894814671, 4569.360289559398, 4667.043256132552, 4680.134175177603, 4745.074710431432, 4765.332853400596, 4648.767561621973, 4749.501302363202, 4750.596199323097, 4791.113643975876, 4817.566419022305, 4641.559051890065, 4650.395448591797, 4655.441347038377, 4697.295405689174, 4698.436187657503, 4610.377599024089, 4716.834910778106, 4737.099951009297, 4772.594329482033, 4854.708717476963, 4500.122476117126, 4546.272596384562, 4644.628429725546, 4666.323383109498, 4674.929876051794, 4623.745693986863, 4644.489106198383, 4667.766611669471, 4684.0866031123605, 4704.835330763407, 4425.845095421645, 4493.865184044484, 4508.594226519629, 4521.683482156218, 4634.443866736014, 4469.709468884512, 4542.159700455426, 4570.520095390069, 4629.722216667011, 4634.490206077261, 4521.457425109008, 4535.251683472322, 4547.386102876069, 4618.838340658061, 4626.074785042938], "mootools.html": [1404.6137312239132, 1412.3503188533275, 1421.5948454690415, 1434.992825035874, 1458.1469840143516, 5917.970410147954, 5975.073863551145, 6031.517478601712, 6193.597416167951, 6214.84462888428, 6256.186695729549, 6349.238091429035, 6353.205849268841, 6492.091107244978, 6559.639219842907, 1871.2608519634737, 1884.9246030158777, 1891.508207865958, 1897.6868816645238, 1904.552430178907, 1866.3001374484568, 1880.8025157358486, 1881.4543782303115, 1884.547708549945, 1916.4633902507321, 1868.2993877296014, 1870.055621910933, 1871.644387566365, 1873.4660621722812, 1897.222138923042, 1810.9637807243848, 1834.899080550576, 1854.0822292964933, 1855.8144185581468, 1859.0425930645729, 1878.5585387433941, 1880.8025157358554, 1882.3505890467766, 1904.552430178907, 1939.3697048459308, 6433.774817881398, 6498.447631951242, 6548.050532672783, 6557.147570815811, 6565.737370505174, 3935.763854168759, 4051.149258655686, 4051.7974101295113, 4086.6117718816663, 4090.6931980101613, 2337.0885354711677, 2355.234548771656, 2406.1818981546185, 2440.5362981033722, 2452.570800109974, 689.2452764223168, 690.8927770300613, 698.2982102986466, 709.1313141401793, 717.4654882112859, 8582.570871456403, 8584.313254939652, 8617.827643447159, 8657.961044674616, 8705.303575713991, 3520.718416866112, 3524.136586536315, 3595.9640403596154, 3619.4027985382645, 3692.390755525308, 7539.359154471931, 7543.509671871311, 7546.20764819697, 7551.509151905108, 7593.5823529706395, 3994.2810294147334, 4015.1768887378603, 4017.5781542938157, 4018.959810401917, 4019.2363450944226, 3163.225009872596, 3333.4166520858753, 3633.400488919299, 3668.679275460832, 3675.7978311192605, 3039.3313471036777, 3081.0910781319117, 3107.502799552106, 3124.3595063012026, 3184.0607020928883, 1007.8891321954579, 1022.9795404091876, 1034.524118905312, 1034.5913364221242, 1048.224314007629, 797.8803179523118, 799.2327365728966, 808.296781799838, 876.5573385440312, 1015.0661391519671, 5997.0, 6062.333143354227, 6062.969685151546, 6066.029435290332, 6085.2393450818645, 870.7083127152475, 920.8342498350361, 926.1942110364026, 928.5682157796657, 930.3394589841289, 4627.305904114342, 4746.359241502422, 4759.547842954914, 4842.007388485423, 4876.926846097312, 7575.204603516661, 7601.0, 7739.148693643695, 7771.883421748678, 7882.802929926683, 7505.174430812606, 7739.458237923292, 7766.8058298541855, 7775.844483110419, 7784.455088143889, 5732.914006289826, 5821.79623713168, 5902.203202567598, 5912.46787789101, 5924.20023296858, 5819.883602327845, 5916.645001299936, 5982.970085149546, 6038.69806509664, 6041.909371359346, 6658.167729033871, 6753.864922701617, 6829.795106146824, 6917.550359226835, 6924.4114250289285, 6901.102856628606, 6970.337817907291, 7037.683304251219, 7042.753503627348, 7173.0675012248075, 4881.58506526935, 5486.094794359045, 5672.517835983987, 5722.62802917809, 5728.598998070095, 5821.534277257724, 6239.7504099837315, 6277.780277690259, 6312.179416675803, 6412.23053233615, 5775.075987841925, 5828.94171058301, 5899.351071382231, 6023.27720673522, 6062.969685151546, 5683.914741278802, 5739.110437882135, 5806.303243610625, 5857.970710146422, 5976.073708575178, 5839.386864379179, 5892.234009578728, 5895.852603684943, 5952.8809423812145, 6042.335343112342, 5312.150055991023, 5336.119540275966, 5349.919751203813, 5381.058314794974, 5404.918926216032, 5405.540529054917, 5416.160495123262, 5489.505944465017, 5496.0, 5499.065158922913], "ext.html": [443.2088721631888, 453.4128303846519, 477.46762359968636, 485.4829606469108, 488.2285988138741, 30313.0, 30943.690563094362, 31288.843555782245, 32037.43700503957, 32192.03423897287, 32040.839795801046, 32050.198745031328, 32253.838730806372, 32289.35421291573, 32844.67155328452, 7306.963465182666, 7455.0681164854395, 7460.179380268166, 7476.887846682304, 7587.393008559302, 7259.60072196029, 7366.15289241736, 7380.74167404141, 7391.186969433385, 7514.361279291267, 7308.378787803043, 7410.70357185712, 7413.851722965537, 7455.888161677579, 7521.022267105296, 7425.034745483053, 7428.257174282582, 7475.0656167979005, 7496.925030749677, 7596.3163315301335, 7318.085239345082, 7336.266373362621, 7350.191478937312, 7356.742514011984, 7484.101907771103, 30655.233619159477, 30662.84668576665, 30850.69149308523, 30965.0710478686, 31388.686113139032, 2289.095807156164, 2321.5008773113864, 2403.134871446278, 2429.0, 2481.838680485763, 21649.242276520246, 21889.67165492519, 22540.887295563418, 22701.54596908069, 22835.0, 1883.1714045819795, 1888.0748433267738, 1907.656621808074, 1916.4729699332656, 1934.0523143659645, 215178.0, 216155.0, 216596.0, 217478.0, 217763.0, 39855.40216896749, 40158.59841401548, 43969.560304397186, 44553.33170002452, 45106.32340514895, 46553.53446465492, 46676.29985550219, 47039.0, 47402.288965665546, 47466.67733258639, 11782.057435405148, 11852.525898964117, 11894.82157767634, 11901.821472677917, 11971.221870578385, 10123.291369604205, 10191.133753631024, 10193.388396696073, 10199.235057370726, 10203.540840662039, 14903.403863845542, 14910.850891490947, 14967.401303947938, 15076.698466030617, 15197.088174709554, 6600.636964966877, 6850.760223392157, 6854.485913556404, 6875.174979002451, 6914.274001229899, 772.7836205862255, 776.8640487914593, 790.4506368074249, 799.0641234088055, 921.576075005505, 23040.769592303863, 23042.8847855763, 23096.4225894354, 23160.4209894754, 23405.0, 837.0, 871.4684042734054, 878.1131057631837, 882.5410786391169, 913.182701482183, 11885.821712674317, 11891.167618266638, 11992.400379980965, 12071.577494787816, 12140.0, 243635.0, 250957.0, 253008.0, 253630.0, 256017.0, 43361.34957975633, 43467.34798978018, 43671.56328436739, 43865.78067109644, 43976.56023439789, 1000.5747557288123, 1015.2487159501916, 1024.206240163864, 1027.4759872465097, 1098.5001824169983, 22701.545969080194, 22732.65901011453, 22830.0, 22985.770142298363, 23183.76816231816, 37096.258074838894, 37441.625583743815, 37577.0, 38131.42802857904, 38456.23087538178, 222197.0, 224975.0, 226341.0, 229455.0, 229698.0, 25113.87443062773, 25124.0, 25192.0, 25250.242492725247, 25704.74295257098, 29574.40851183007, 30680.693193068677, 30733.846330768203, 30950.0714978551, 30962.665226868707, 25027.0, 26090.73909260883, 26451.867740661175, 26672.59991100174, 27384.863075684494, 25632.743672563036, 25854.612180816926, 25886.35284117912, 25947.481050379265, 26431.0, 27807.582886256318, 28124.43751125007, 29094.854525727234, 29100.0, 29300.853495732386, 24030.51938961246, 24966.50066998686, 25062.498750024533, 25226.873865630554, 25813.096541621704, 19430.2227910882, 19433.902830485757, 19484.0, 19577.51056223549, 19649.31227407034], "prototype.html": [256.2019309849818, 259.8674675915284, 265.15680137163815, 266.87056777462936, 270.7454992307231, 5234.319538459995, 5289.92065119023, 5305.363356397228, 5313.78744850206, 5320.733963301839, 5231.0, 5267.499587539187, 5330.333708286465, 5384.865378365543, 5418.187271909215, 4029.556748757649, 4038.737482063671, 4066.6949978751563, 4072.063425412157, 4109.97945010276, 4036.3340048891896, 4040.9797951010205, 4071.4503542021894, 4099.754014759124, 4100.63094321511, 3787.110029143149, 4012.1975604878994, 4021.6380525752675, 4056.594340565949, 4065.166640838636, 3923.5880232575596, 3924.725269231155, 3926.6466018058513, 3943.605639436062, 3947.467091942594, 3337.8998630041137, 3368.0401085690705, 3371.612264589579, 3385.0, 3386.847591858372, 5090.33825602673, 5103.336566246364, 5237.16205407133, 5290.100682883919, 5295.364556253275, 4467.173572889026, 4476.61948734358, 4537.705049171794, 4541.43232095988, 4549.977250113761, 5546.889062218774, 5617.775288988436, 5618.831435056954, 5624.775008999635, 5641.323041235037, 3530.4351303791527, 3613.6205698401814, 3686.152184997439, 3694.556653201606, 3726.981365093184, 5731.914021289684, 5780.1907732917425, 5823.941760582382, 5900.645961242296, 5946.048632218867, 3684.281565094781, 3714.201446688975, 3745.5318085239346, 3754.192848537523, 3764.5858955514873, 3746.7751934883995, 3760.9435858462143, 3785.413260944503, 3832.1952389997855, 3842.3852183650483, 4468.352088947149, 4480.686351955332, 4491.618212451978, 4496.0, 4523.0, 5263.6578622389425, 5309.787608495694, 5519.172124181405, 5637.379888212294, 5675.858103547444, 1332.9066965312336, 1340.544214966916, 1346.2528296795372, 1356.4641966423405, 1365.5357178559138, 855.9572021398906, 857.7726902370877, 863.5897948474425, 864.5201912938379, 870.9825803483894, 5295.232191332235, 5371.838844834661, 5392.892142157135, 5399.973000134974, 5466.972665136649, 5751.712414379348, 5850.61970971894, 5867.735951882176, 5884.617499862496, 5919.408059194132, 5319.946800532022, 5340.145576707708, 5374.247605335257, 5401.054815407288, 5446.564274858002, 3029.0, 3089.81461112334, 3102.751779857606, 3117.314190878003, 3153.495440729472, 5919.082542205965, 5946.762129514857, 5993.340732519419, 6029.397060293935, 6031.939680603138, 5912.940870591325, 5956.52347812174, 5958.553108516879, 6006.729697163638, 6063.9090413643835, 5724.4561766632105, 5933.851653708605, 5943.10853371989, 5957.434043765836, 5986.850328741816, 5792.855178620568, 5797.565182611405, 5801.622894511843, 5826.126081087701, 5841.94158058431, 5620.578456615688, 5640.464155905182, 5682.431756824284, 5715.2855893013375, 5724.484796368347, 5992.5205983520345, 5995.850103747442, 6005.39946005396, 6010.3088144863905, 6017.849553761191, 3604.3692353838496, 3752.2307926874378, 3792.7534710243744, 3810.1236715555024, 3810.847566097436, 5637.9718101409235, 5725.341585717696, 5738.512226460798, 5797.275340582427, 5818.44724751148, 5575.275214222125, 5626.549876009827, 5717.771289148387, 5726.570507211893, 5739.282589676291, 5648.830535083954, 5740.167675686918, 5751.712414379181, 5761.827145185651, 5765.423457654201, 5512.862178445571, 5577.0, 5581.5255703265675, 5595.776168953196, 5606.27118474612, 5513.393526712139, 5660.915086273627, 5719.656820590778, 5754.827355179351, 5787.0, 5577.916331255115, 5642.238297829905, 5651.632643878134, 5664.0, 5672.03575392176], "yui.html": [492.8399655605808, 500.87227756922005, 519.138230537308, 539.2262103880929, 549.3846891481542, 10902.672919812409, 11183.496742646581, 11260.268082574627, 11273.774524509505, 11365.261258018234, 10113.938036506172, 10116.39301641902, 10184.388936663805, 10218.591256349737, 10432.16542676586, 531.5349069564131, 550.4138092931036, 653.398873036805, 686.7459040155125, 690.2821066091259, 678.7827895073578, 688.5180373738403, 694.4236283884389, 696.9372756451918, 697.0102454514576, 714.8034290570083, 714.9356557909787, 717.0534893940002, 720.531654424623, 733.9889901651479, 714.1465948191939, 715.6207210178613, 716.0941409117471, 718.4719231364943, 724.6521669598595, 519.7764961066778, 524.281734024389, 524.6039240373532, 524.7795925711172, 525.4482793067302, 8986.55067246635, 9081.863772043425, 9130.223930965809, 9222.0, 9233.6306547738, 6163.568550201488, 6323.27282362525, 7370.373518250955, 7385.003024591665, 7675.309222170032, 6932.3760861522205, 7133.89299160513, 7134.464915131334, 7300.306470885257, 7397.2602739726135, 2439.524292762912, 2449.1795248591743, 2477.913273035435, 2485.2047344849657, 2496.2636022373445, 34293.142671433416, 34823.477647835556, 38625.22749544994, 39154.412683809765, 39486.0, 5217.739113044333, 5509.118541033416, 5550.389457159709, 5558.527525160407, 5856.795012174639, 9169.449833009907, 9269.119433653792, 9470.90529094714, 9541.284403669753, 9561.808763824823, 4466.3523789050405, 4625.190591646448, 4639.211334073216, 4687.67186296956, 4880.92678609814, 2821.7460428561117, 2951.985240073786, 3064.233941514621, 3073.1548824073557, 3087.1818967973504, 2080.6150862090562, 2084.5622419292117, 2197.4726065744107, 2213.878236696997, 2230.286308381302, 371.6228028551023, 380.9390497520439, 381.95416550014176, 385.39108209029666, 385.91509867829035, 373.2385932697267, 398.40836358008335, 411.2515222295394, 412.9710920235615, 446.0343356632918, 5868.941310586925, 6259.812205633838, 6511.28375878653, 6689.866202675919, 6734.0, 319.0412809507415, 363.8253638253653, 397.1461358080093, 425.62970215912355, 442.6635756824772, 2833.7591304738917, 2926.268432891777, 2952.129121909042, 2973.628296462942, 2978.3447641518833, 44223.0, 44496.110077798265, 45216.547834521894, 46838.29742553864, 47404.288935665994, 41066.38400423996, 41972.37041444381, 42034.369484457755, 42094.1581168381, 42925.78537107295, 39019.41470877882, 39224.215515689524, 39532.0, 39704.801475993016, 40257.396139057935, 6232.657203853832, 6435.22777266731, 6490.513211509061, 6540.738370465128, 6574.408303252731, 29727.702722973358, 29816.403671926873, 30196.396072078875, 30261.394772104875, 30330.848345759012, 36250.456243155844, 39342.40986385149, 39385.60614393934, 39424.0, 39700.40449393204, 5787.797427090031, 5824.650520968756, 6012.128241405059, 6077.604955677867, 6161.199044124235, 7917.168697286702, 8422.410431269753, 8540.786480338042, 8714.215720585178, 8720.607572659119, 7676.424268179797, 7786.727464538714, 7867.803304917423, 8396.706115285935, 8454.239118479367, 8036.437449378487, 8297.294729948022, 8304.87542686848, 8305.46014509055, 8433.578321083798, 7936.761897143095, 7960.960195198987, 8047.919520804951, 8065.919340806517, 8228.670853166046, 6461.321561236191, 6738.0, 6753.425958793361, 6786.253512113565, 6827.214870289781, 6931.306869313028, 6942.965285173542, 6946.548474349152, 7082.964585177041, 7195.388391986739]}, "summary": {"lowerIsBetter": false, "suite": 5368.635393125794, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5461.673071521256, "unit": "ms", "value": 5461.673071521256}, "dojo.html": {"lowerIsBetter": false, "filtered": 4350.87354787083, "unit": "ms", "value": 4350.87354787083}, "mootools.html": {"lowerIsBetter": false, "filtered": 3697.5611097052047, "unit": "ms", "value": 3697.5611097052047}, "ext.html": {"lowerIsBetter": false, "filtered": 14465.227587216645, "unit": "ms", "value": 14465.227587216645}, "prototype.html": {"lowerIsBetter": false, "filtered": 4166.607753005835, "unit": "ms", "value": 4166.607753005835}, "yui.html": {"lowerIsBetter": false, "filtered": 4520.810706078341, "unit": "ms", "value": 4520.810706078341}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0003.e"}, "testrun": {"date": 1447767066, "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": "20151117030242", "branch": "Firefox", "revision": "898c2c656e4b156c323416ef0c859915f3fd2308"}}, {"talos_counters": {}, "results": {"audio-dft": [197.0, 214.0, 209.0, 207.0, 203.0, 201.0, 201.0, 205.0, 205.0, 211.0], "ai-astar": [128.0, 123.0, 141.0, 140.0, 134.0, 147.0, 133.0, 135.0, 141.0, 140.0], "imaging-gaussian-blur": [142.0, 148.0, 150.0, 154.0, 150.0, 149.0, 156.0, 153.0, 149.0, 142.0], "audio-beat-detection": [177.0, 166.0, 194.0, 206.0, 165.0, 178.0, 178.0, 165.0, 204.0, 166.0], "json-stringify-tinderbox": [85.0, 83.0, 82.0, 87.0, 86.0, 90.0, 92.0, 94.0, 95.0, 92.0], "stanford-crypto-pbkdf2": [181.0, 199.0, 206.0, 199.0, 191.0, 192.0, 204.0, 206.0, 204.0, 182.0], "json-parse-financial": [72.0, 77.0, 77.0, 78.0, 82.0, 88.0, 81.0, 90.0, 81.0, 81.0], "stanford-crypto-sha256-iterative": [83.0, 89.0, 88.0, 93.0, 93.0, 94.0, 94.0, 93.0, 94.0, 92.0], "audio-fft": [84.0, 89.0, 98.0, 148.0, 86.0, 89.0, 91.0, 91.0, 125.0, 84.0], "imaging-darkroom": [165.0, 165.0, 157.0, 157.0, 166.0, 165.0, 162.0, 157.0, 165.0, 164.0], "stanford-crypto-ccm": [161.0, 163.0, 160.0, 174.0, 163.0, 172.0, 164.0, 166.0, 172.0, 159.0], "audio-oscillator": [102.0, 104.0, 150.0, 112.0, 115.0, 115.0, 148.0, 108.0, 110.0, 155.0], "stanford-crypto-aes": [102.0, 105.0, 115.0, 112.0, 113.0, 111.0, 112.0, 111.0, 113.0, 107.0], "imaging-desaturate": [121.0, 133.0, 123.0, 136.0, 128.0, 125.0, 123.0, 124.0, 124.0, 133.0]}, "summary": {"lowerIsBetter": true, "suite": 1912.9, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 98.5, "unit": "ms", "value": 98.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 196.4, "unit": "ms", "value": 196.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 179.9, "unit": "ms", "value": 179.9}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 165.4, "unit": "ms", "value": 165.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 162.3, "unit": "ms", "value": 162.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 80.7, "unit": "ms", "value": 80.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 121.9, "unit": "ms", "value": 121.9}, "ai-astar": {"lowerIsBetter": true, "filtered": 136.2, "unit": "ms", "value": 136.2}, "audio-dft": {"lowerIsBetter": true, "filtered": 205.3, "unit": "ms", "value": 205.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 91.3, "unit": "ms", "value": 91.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 88.6, "unit": "ms", "value": 88.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 149.3, "unit": "ms", "value": 149.3}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 110.1, "unit": "ms", "value": 110.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 127.0, "unit": "ms", "value": 127.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0003.e"}, "testrun": {"date": 1447767066, "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": "20151117030242", "branch": "Firefox", "revision": "898c2c656e4b156c323416ef0c859915f3fd2308"}}, {"talos_counters": {}, "results": {"DeltaBlue": [238.60653781913624], "Encrypt": [388.19875776397515], "NavierStokes": [6951.388888888889], "Decrypt": [6896.551724137931], "Splay": [874.8906386701663], "Richards": [879.5074758135444], "RegExp": [35068.96551724138], "Earley": [962.4639076034649], "Boyer": [16274.193548387097], "RayTrace": [1351.3513513513512]}, "summary": {"lowerIsBetter": false, "suite": 13806.117758572464, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 277.10053799999986, "unit": "score", "value": 277.10053799999986}, "Encrypt": {"lowerIsBetter": false, "filtered": 685.682256, "unit": "score", "value": 685.682256}, "NavierStokes": {"lowerIsBetter": false, "filtered": 213.48251748251758, "unit": "score", "value": 213.48251748251758}, "Decrypt": {"lowerIsBetter": false, "filtered": 38.59624499999999, "unit": "score", "value": 38.59624499999999}, "Splay": {"lowerIsBetter": false, "filtered": 93.14421300000002, "unit": "score", "value": 93.14421300000002}, "RegExp": {"lowerIsBetter": false, "filtered": 25.976956735496543, "unit": "score", "value": 25.976956735496543}, "Richards": {"lowerIsBetter": false, "filtered": 40.138374, "unit": "score", "value": 40.138374}, "Earley": {"lowerIsBetter": false, "filtered": 692.4550570000002, "unit": "score", "value": 692.4550570000002}, "Boyer": {"lowerIsBetter": false, "filtered": 40.95213676907831, "unit": "score", "value": 40.95213676907831}, "RayTrace": {"lowerIsBetter": false, "filtered": 547.5918600000002, "unit": "score", "value": 547.5918600000002}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0003.e"}, "testrun": {"date": 1447767066, "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": "20151117030242", "branch": "Firefox", "revision": "898c2c656e4b156c323416ef0c859915f3fd2308"}}] 05:51:25 INFO - RETURN: dromaeo_css: 5368.63 05:51:25 INFO - RETURN: kraken: 1912.90 05:51:25 INFO - RETURN: v8_7: 13806.12 05:51:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,57]]", "result": "13806.12"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,57]]", "result": "1912.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,57]]", "result": "5368.63"}}} 05:51:25 INFO - Return code: 0 05:51:25 INFO - # TBPL SUCCESS # 05:51:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:51:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:51:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:51:25 INFO - 2015-11-17 05:51:25.417 screenresolution[1669:10756] starting screenresolution argv=screenresolution get 05:51:25 INFO - 2015-11-17 05:51:25.420 screenresolution[1669:10756] Display 0: 1600x1200x32@60 05:51:25 INFO - 2015-11-17 05:51:25.427 screenresolution[1670:10760] starting screenresolution argv=screenresolution list 05:51:25 INFO - Available Modes on Display 0 05:51:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:51:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:51:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:51:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:51:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:51:25 INFO - Intel HD Graphics 3000: 05:51:25 INFO - Chipset Model: Intel HD Graphics 3000 05:51:25 INFO - Type: GPU 05:51:25 INFO - Bus: Built-In 05:51:25 INFO - VRAM (Total): 512 MB 05:51:25 INFO - VRAM (Dynamic, Max): 10 05:51:25 INFO - Vendor: Intel (0x8086) 05:51:25 INFO - Device ID: 0x0116 05:51:25 INFO - Revision ID: 0x0009 05:51:25 INFO - Displays: 05:51:25 INFO - Display: 05:51:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:51:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:51:25 INFO - Display Serial Number: 1600x1200 60 05:51:25 INFO - Main Display: Yes 05:51:25 INFO - Mirror: Off 05:51:25 INFO - Online: Yes 05:51:25 INFO - Rotation: Supported 05:51:25 INFO - Return code: 0 05:51:25 INFO - Running post-action listener: _resource_record_post_action 05:51:25 INFO - Running post-run listener: _resource_record_post_run 05:51:26 INFO - Total resource usage - Wall time: 1263s; CPU: 30.0%; Read bytes: 41063424; Write bytes: 691699712; Read time: 4966; Write time: 47687 05:51:26 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 343233024; Write bytes: 346402816; Read time: 38283; Write time: 6129 05:51:26 INFO - run-tests - Wall time: 1220s; CPU: 30.0%; Read bytes: 38921216; Write bytes: 344084480; Read time: 4587; Write time: 41543 05:51:26 INFO - Running post-run listener: _upload_blobber_files 05:51:26 INFO - Blob upload gear active. 05:51:26 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:51:26 INFO - Copying logs to upload dir... 05:51:26 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1325.087290 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2015-11-17 05:51:26.883172) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 05:51:26.888779) ========= 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.7kXCoV3lzL/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.AqIKPrrmyy/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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/NoHs0ew1TIaQOY1WnI9mpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010696 build_url: 'https://queue.taskcluster.net/v1/task/NoHs0ew1TIaQOY1WnI9mpQ/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:51:26.916899) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:51:26.917406) ========= 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.7kXCoV3lzL/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.AqIKPrrmyy/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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.005673 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:51:26.967626) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 05:51:26.968020) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 05:51:26.968502) ========= ========= Total master_lag: 0.26 =========