builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0002 starttime: 1448061748.9 results: success (0) buildid: 20151120142833 builduid: 30b59426512a4f10843b1e0104c3318a revision: 106bfad77bf44d39fc334b336b037a70c2130d52 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:28.903401) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:28.903760) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:28.904045) ========= 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.Z9a9FnWdjj/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.hS5nhQgUt7/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005336 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:28.931479) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:28.931782) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:28.948716) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:28.949060) ========= 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.Z9a9FnWdjj/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.hS5nhQgUt7/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005533 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:28.997123) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:29.001475) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:29.001839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:29.002119) ========= 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.Z9a9FnWdjj/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.hS5nhQgUt7/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-20 15:22:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.62G=0s 2015-11-20 15:22:29 (1.62 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189195 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:29.209360) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:29.209690) ========= 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.Z9a9FnWdjj/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.hS5nhQgUt7/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026395 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:29.263073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:29.267463) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 106bfad77bf44d39fc334b336b037a70c2130d52 --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 106bfad77bf44d39fc334b336b037a70c2130d52 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z9a9FnWdjj/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.hS5nhQgUt7/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-20 15:22:29,364 truncating revision to first 12 chars 2015-11-20 15:22:29,364 Setting DEBUG logging. 2015-11-20 15:22:29,364 attempt 1/10 2015-11-20 15:22:29,364 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/106bfad77bf4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 15:22:30,011 unpacking tar archive at: mozilla-central-106bfad77bf4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.888994 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:30.188106) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:30.188430) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:30.199510) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:30.199772) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 15:22:30.200149) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-20 15:22:30.200453) ========= /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.Z9a9FnWdjj/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.hS5nhQgUt7/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:22:30 INFO - MultiFileLogger online at 20151120 15:22:30 in /builds/slave/test 15:22:30 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 15:22:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:22:30 INFO - {'append_to_log': False, 15:22:30 INFO - 'base_work_dir': '/builds/slave/test', 15:22:30 INFO - 'blob_upload_branch': 'Firefox', 15:22:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:22:30 INFO - 'branch': 'Firefox', 15:22:30 INFO - 'buildbot_json_path': 'buildprops.json', 15:22:30 INFO - 'config_files': ('talos/mac_config.py',), 15:22:30 INFO - 'default_actions': ('clobber', 15:22:30 INFO - 'read-buildbot-config', 15:22:30 INFO - 'download-and-extract', 15:22:30 INFO - 'populate-webroot', 15:22:30 INFO - 'create-virtualenv', 15:22:30 INFO - 'install', 15:22:30 INFO - 'run-tests'), 15:22:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:22:30 INFO - 'download_minidump_stackwalk': True, 15:22:30 INFO - 'download_symbols': 'ondemand', 15:22:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:22:30 INFO - 'tooltool.py': '/tools/tooltool.py', 15:22:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:22:30 INFO - '/tools/misc-python/virtualenv.py')}, 15:22:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:22:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:22:30 INFO - 'installer_path': 'installer.exe', 15:22:30 INFO - 'log_level': 'info', 15:22:30 INFO - 'log_name': 'talos', 15:22:30 INFO - 'log_to_console': True, 15:22:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:22:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:22:30 INFO - 'opt_config_files': (), 15:22:30 INFO - 'pip_index': False, 15:22:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:22:30 INFO - 'cmd': ('bash', 15:22:30 INFO - '-c', 15:22:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:22:30 INFO - 'enabled': True, 15:22:30 INFO - 'halt_on_failure': False, 15:22:30 INFO - 'name': 'check_screen_resolution'},), 15:22:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:22:30 INFO - 'cmd': ('bash', 15:22:30 INFO - '-c', 15:22:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:22:30 INFO - 'enabled': True, 15:22:30 INFO - 'halt_on_failure': False, 15:22:30 INFO - 'name': 'check_screen_resolution'},), 15:22:30 INFO - 'run_cmd_checks_enabled': True, 15:22:30 INFO - 'sps_profile': False, 15:22:30 INFO - 'sps_profile_interval': 0, 15:22:30 INFO - 'suite': 'dromaeojs-e10s', 15:22:30 INFO - 'system_bits': '64', 15:22:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:22:30 INFO - 'title': 't-yosemite-r7-0002', 15:22:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:22:30 INFO - 'use_talos_json': True, 15:22:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:22:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:22:30 INFO - 'work_dir': 'build'} 15:22:30 INFO - ##### 15:22:30 INFO - ##### Running clobber step. 15:22:30 INFO - ##### 15:22:30 INFO - Running pre-action listener: _resource_record_pre_action 15:22:30 INFO - Running main action method: clobber 15:22:30 INFO - rmtree: /builds/slave/test/build 15:22:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:22:31 INFO - Running post-action listener: _resource_record_post_action 15:22:31 INFO - ##### 15:22:31 INFO - ##### Running read-buildbot-config step. 15:22:31 INFO - ##### 15:22:31 INFO - Running pre-action listener: _resource_record_pre_action 15:22:31 INFO - Running main action method: read_buildbot_config 15:22:31 INFO - Using buildbot properties: 15:22:31 INFO - { 15:22:31 INFO - "properties": { 15:22:31 INFO - "buildnumber": 4, 15:22:31 INFO - "product": "firefox", 15:22:31 INFO - "script_repo_revision": "production", 15:22:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:22:31 INFO - "repository": "", 15:22:31 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:22:31 INFO - "buildid": "20151120142833", 15:22:31 INFO - "slavename": "t-yosemite-r7-0002", 15:22:31 INFO - "pgo_build": "False", 15:22:31 INFO - "basedir": "/builds/slave/test", 15:22:31 INFO - "project": "", 15:22:31 INFO - "platform": "yosemite_r7", 15:22:31 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:22:31 INFO - "slavebuilddir": "test", 15:22:31 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:22:31 INFO - "branch": "mozilla-central", 15:22:31 INFO - "repo_path": "mozilla-central", 15:22:31 INFO - "stage_platform": "macosx64", 15:22:31 INFO - "builduid": "30b59426512a4f10843b1e0104c3318a", 15:22:31 INFO - "revision": "106bfad77bf44d39fc334b336b037a70c2130d52" 15:22:31 INFO - }, 15:22:31 INFO - "sourcestamp": { 15:22:31 INFO - "repository": "", 15:22:31 INFO - "hasPatch": false, 15:22:31 INFO - "project": "", 15:22:31 INFO - "branch": "mozilla-central-macosx64-talos", 15:22:31 INFO - "changes": [ 15:22:31 INFO - { 15:22:31 INFO - "category": null, 15:22:31 INFO - "files": [ 15:22:31 INFO - { 15:22:31 INFO - "url": null, 15:22:31 INFO - "name": "https://queue.taskcluster.net/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 15:22:31 INFO - } 15:22:31 INFO - ], 15:22:31 INFO - "repository": "", 15:22:31 INFO - "rev": "106bfad77bf44d39fc334b336b037a70c2130d52", 15:22:31 INFO - "who": "kwierso@gmail.com", 15:22:31 INFO - "when": 1448061026, 15:22:31 INFO - "number": 6690920, 15:22:31 INFO - "comments": "Bug 1226648 - Flame-kk device tests should be disabled r=jlorenzo", 15:22:31 INFO - "project": "", 15:22:31 INFO - "at": "Fri 20 Nov 2015 15:10:26", 15:22:31 INFO - "branch": "mozilla-central-macosx64-talos", 15:22:31 INFO - "revlink": "", 15:22:31 INFO - "properties": [ 15:22:31 INFO - [ 15:22:31 INFO - "buildid", 15:22:31 INFO - "20151120142833", 15:22:31 INFO - "Change" 15:22:31 INFO - ], 15:22:31 INFO - [ 15:22:31 INFO - "builduid", 15:22:31 INFO - "30b59426512a4f10843b1e0104c3318a", 15:22:31 INFO - "Change" 15:22:31 INFO - ], 15:22:31 INFO - [ 15:22:31 INFO - "pgo_build", 15:22:31 INFO - "False", 15:22:31 INFO - "Change" 15:22:31 INFO - ] 15:22:31 INFO - ], 15:22:31 INFO - "revision": "106bfad77bf44d39fc334b336b037a70c2130d52" 15:22:31 INFO - } 15:22:31 INFO - ], 15:22:31 INFO - "revision": "106bfad77bf44d39fc334b336b037a70c2130d52" 15:22:31 INFO - } 15:22:31 INFO - } 15:22:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 15:22:31 INFO - Running post-action listener: _resource_record_post_action 15:22:31 INFO - ##### 15:22:31 INFO - ##### Running download-and-extract step. 15:22:31 INFO - ##### 15:22:31 INFO - Running pre-action listener: _resource_record_pre_action 15:22:31 INFO - Running main action method: download_and_extract 15:22:31 INFO - mkdir: /builds/slave/test/build/tests 15:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:31 INFO - https://queue.taskcluster.net/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:22:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/test_packages.json 15:22:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/test_packages.json 15:22:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:22:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:22:32 INFO - Downloaded 1149 bytes. 15:22:32 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:22:32 INFO - Using the following test package requirements: 15:22:32 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:22:32 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:22:32 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 15:22:32 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:22:32 INFO - u'jsshell-mac.zip'], 15:22:32 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:22:32 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 15:22:32 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:22:32 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:22:32 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 15:22:32 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:22:32 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 15:22:32 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:22:32 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 15:22:32 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:22:32 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:22:32 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 15:22:32 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:32 INFO - https://queue.taskcluster.net/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:22:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:22:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:22:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/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 15:22:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/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 15:22:33 INFO - Downloaded 17526023 bytes. 15:22:33 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 15:22:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:22:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:22:36 INFO - Return code: 0 15:22:36 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 15:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:36 INFO - https://queue.taskcluster.net/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:22:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:22:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:22:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/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 15:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/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 15:22:37 INFO - Downloaded 17526023 bytes. 15:22:37 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 15:22:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:22:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:22:41 INFO - Return code: 0 15:22:41 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')]} 15:22:41 INFO - https://queue.taskcluster.net/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:22:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:22:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:22:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/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 15:22:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/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 15:22:42 INFO - Downloaded 11130997 bytes. 15:22:42 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 15:22:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:22:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 15:22:42 INFO - Return code: 0 15:22: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')]} 15:22:42 INFO - https://queue.taskcluster.net/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:22:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:22:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:22:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 15:22:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeZBSkcJSm-s6LMpDEufog/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 15:22:45 INFO - Downloaded 109417698 bytes. 15:22:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:22:45 INFO - mkdir: /builds/slave/test/properties 15:22:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:22:45 INFO - Writing to file /builds/slave/test/properties/build_url 15:22:45 INFO - Contents: 15:22:45 INFO - build_url:https://queue.taskcluster.net/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:22:45 INFO - Running post-action listener: _resource_record_post_action 15:22:45 INFO - Running post-action listener: set_extra_try_arguments 15:22:45 INFO - ##### 15:22:45 INFO - ##### Running populate-webroot step. 15:22:45 INFO - ##### 15:22:45 INFO - Running pre-action listener: _resource_record_pre_action 15:22:45 INFO - Running main action method: populate_webroot 15:22:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:22:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:22:45 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:22:45 INFO - '../fennec_ids.txt'], 15:22:45 INFO - 'tests': ['tcheck2']}, 15:22:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:22:45 INFO - '--tppagecycles', 15:22:45 INFO - '7'], 15:22:45 INFO - 'tests': ['tsvgm']}}, 15:22:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:22:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:22:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:22:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:22:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:22:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:22:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:45 INFO - 'talos_options': ['--e10s'], 15:22:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:45 INFO - 'tests': ['damp', 'tps']}, 15:22:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:45 INFO - 'talos_options': ['--e10s'], 15:22:45 INFO - 'tests': ['damp', 'tps']}, 15:22:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:22:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:22:45 INFO - 'other': {'tests': ['a11yr', 15:22:45 INFO - 'ts_paint', 15:22:45 INFO - 'tpaint', 15:22:45 INFO - 'sessionrestore', 15:22:45 INFO - 'sessionrestore_no_auto_restore']}, 15:22:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:22:45 INFO - 'tests': ['a11yr', 15:22:45 INFO - 'ts_paint', 15:22:45 INFO - 'tpaint', 15:22:45 INFO - 'sessionrestore', 15:22:45 INFO - 'sessionrestore_no_auto_restore']}, 15:22:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:22:45 INFO - 'tests': ['a11yr', 15:22:45 INFO - 'ts_paint', 15:22:45 INFO - 'tpaint', 15:22:45 INFO - 'sessionrestore', 15:22:45 INFO - 'sessionrestore_no_auto_restore']}, 15:22:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:22:45 INFO - 'tests': ['a11yr', 15:22:45 INFO - 'ts_paint', 15:22:45 INFO - 'tpaint', 15:22:45 INFO - 'sessionrestore', 15:22:45 INFO - 'sessionrestore_no_auto_restore']}, 15:22:45 INFO - 'other_l64': {'tests': ['a11yr', 15:22:45 INFO - 'ts_paint', 15:22:45 INFO - 'tpaint', 15:22:45 INFO - 'sessionrestore', 15:22:45 INFO - 'sessionrestore_no_auto_restore']}, 15:22:45 INFO - 'other_nol64': {'tests': ['a11yr', 15:22:45 INFO - 'ts_paint', 15:22:45 INFO - 'tpaint', 15:22:45 INFO - 'sessionrestore', 15:22:45 INFO - 'sessionrestore_no_auto_restore']}, 15:22:45 INFO - 'svgr': {'tests': ['tsvgx', 15:22:45 INFO - 'tsvgr_opacity', 15:22:45 INFO - 'tart', 15:22:45 INFO - 'tscrollx', 15:22:45 INFO - 'cart']}, 15:22:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:22:45 INFO - 'tests': ['tsvgx', 15:22:45 INFO - 'tsvgr_opacity', 15:22:45 INFO - 'tart', 15:22:45 INFO - 'tscrollx', 15:22:45 INFO - 'cart']}, 15:22:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:45 INFO - 'tests': ['tp5o']}, 15:22:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:45 INFO - 'talos_options': ['--e10s'], 15:22:45 INFO - 'tests': ['tp5o']}, 15:22:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:45 INFO - 'talos_options': ['--xperf_path', 15:22:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:45 INFO - 'tests': ['tp5n']}, 15:22:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:45 INFO - 'talos_options': ['--e10s', 15:22:45 INFO - '--xperf_path', 15:22:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:45 INFO - 'tests': ['tp5n']}}, 15:22:45 INFO - 'talos.zip': {'path': '', 15:22:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:22:45 INFO - Running post-action listener: _resource_record_post_action 15:22:45 INFO - ##### 15:22:45 INFO - ##### Running create-virtualenv step. 15:22:45 INFO - ##### 15:22:45 INFO - Running pre-action listener: _resource_record_pre_action 15:22:45 INFO - Running main action method: create_virtualenv 15:22:45 INFO - Creating virtualenv /builds/slave/test/build/venv 15:22:45 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 15:22:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:22:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:22:45 INFO - Using real prefix '/tools/python27' 15:22:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:22:46 INFO - Installing distribute.............................................................................................................................................................................................done. 15:22:49 INFO - Installing pip.................done. 15:22:49 INFO - Return code: 0 15:22:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:22:49 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')]} 15:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:49 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')]} 15:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:49 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 0x10b0c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0a4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18c34e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afeb9f0>, '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 0x10ad4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afde8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9a9FnWdjj/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.hS5nhQgUt7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:22:49 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 15:22:49 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 15:22:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9a9FnWdjj/Render', 15:22:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:49 INFO - 'HOME': '/Users/cltbld', 15:22:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:49 INFO - 'LOGNAME': 'cltbld', 15:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:49 INFO - 'MOZ_NO_REMOTE': '1', 15:22:49 INFO - 'NO_EM_RESTART': '1', 15:22:49 INFO - 'PAGER': '/bin/cat', 15:22:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:49 INFO - 'PWD': '/builds/slave/test', 15:22:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:49 INFO - 'SHELL': '/bin/bash', 15:22:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hS5nhQgUt7/Listeners', 15:22:49 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 15:22:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:49 INFO - 'USER': 'cltbld', 15:22:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:49 INFO - 'XPC_FLAGS': '0x0', 15:22:49 INFO - 'XPC_SERVICE_NAME': '0', 15:22:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:49 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 15:22:49 INFO - Cleaning up... 15:22:49 INFO - Return code: 0 15:22:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:22:49 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')]} 15:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:49 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')]} 15:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:49 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 0x10b0c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0a4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18c34e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afeb9f0>, '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 0x10ad4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afde8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9a9FnWdjj/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.hS5nhQgUt7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:22:49 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 15:22:49 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 15:22:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9a9FnWdjj/Render', 15:22:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:49 INFO - 'HOME': '/Users/cltbld', 15:22:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:49 INFO - 'LOGNAME': 'cltbld', 15:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:49 INFO - 'MOZ_NO_REMOTE': '1', 15:22:49 INFO - 'NO_EM_RESTART': '1', 15:22:49 INFO - 'PAGER': '/bin/cat', 15:22:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:49 INFO - 'PWD': '/builds/slave/test', 15:22:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:49 INFO - 'SHELL': '/bin/bash', 15:22:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hS5nhQgUt7/Listeners', 15:22:49 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 15:22:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:49 INFO - 'USER': 'cltbld', 15:22:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:49 INFO - 'XPC_FLAGS': '0x0', 15:22:49 INFO - 'XPC_SERVICE_NAME': '0', 15:22:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:49 INFO - Downloading/unpacking psutil>=0.7.1 15:22:49 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 15:22:49 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 15:22:49 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 15:22:49 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 15:22:49 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 15:22:49 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 15:22:51 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:22:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:52 INFO - Installing collected packages: psutil 15:22:52 INFO - Running setup.py install for psutil 15:22:52 INFO - building 'psutil._psutil_osx' extension 15:22:52 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 15:22:52 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 15:22:52 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 15:22:52 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 15:22:53 INFO - building 'psutil._psutil_posix' extension 15:22:53 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 15:22:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:22:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:22:53 INFO - ^ 15:22:53 INFO - 1 warning generated. 15:22:53 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 15:22:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:53 INFO - Successfully installed psutil 15:22:53 INFO - Cleaning up... 15:22:53 INFO - Return code: 0 15:22:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:22: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')]} 15:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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')]} 15:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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', '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 0x10b0c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0a4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18c34e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afeb9f0>, '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 0x10ad4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afde8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9a9FnWdjj/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.hS5nhQgUt7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:22: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:22: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 mozsystemmonitor==0.0.0 15:22:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9a9FnWdjj/Render', 15:22:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:53 INFO - 'HOME': '/Users/cltbld', 15:22:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:53 INFO - 'LOGNAME': 'cltbld', 15:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:53 INFO - 'MOZ_NO_REMOTE': '1', 15:22:53 INFO - 'NO_EM_RESTART': '1', 15:22:53 INFO - 'PAGER': '/bin/cat', 15:22:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:53 INFO - 'PWD': '/builds/slave/test', 15:22:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:53 INFO - 'SHELL': '/bin/bash', 15:22:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hS5nhQgUt7/Listeners', 15:22:53 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 15:22:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:53 INFO - 'USER': 'cltbld', 15:22:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:53 INFO - 'XPC_FLAGS': '0x0', 15:22:53 INFO - 'XPC_SERVICE_NAME': '0', 15:22:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:22:53 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 15:22:53 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 15:22:53 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 15:22:53 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 15:22:53 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 15:22:53 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 15:22:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:22:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:22:55 INFO - Installing collected packages: mozsystemmonitor 15:22:55 INFO - Running setup.py install for mozsystemmonitor 15:22:55 INFO - Successfully installed mozsystemmonitor 15:22:55 INFO - Cleaning up... 15:22:55 INFO - Return code: 0 15:22:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:55 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 0x10b0c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0a4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18c34e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afeb9f0>, '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 0x10ad4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afde8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9a9FnWdjj/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.hS5nhQgUt7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:22:55 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 15:22:55 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 15:22:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9a9FnWdjj/Render', 15:22:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:55 INFO - 'HOME': '/Users/cltbld', 15:22:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:55 INFO - 'LOGNAME': 'cltbld', 15:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:55 INFO - 'MOZ_NO_REMOTE': '1', 15:22:55 INFO - 'NO_EM_RESTART': '1', 15:22:55 INFO - 'PAGER': '/bin/cat', 15:22:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:55 INFO - 'PWD': '/builds/slave/test', 15:22:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:55 INFO - 'SHELL': '/bin/bash', 15:22:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hS5nhQgUt7/Listeners', 15:22:55 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 15:22:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:55 INFO - 'USER': 'cltbld', 15:22:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:55 INFO - 'XPC_FLAGS': '0x0', 15:22:55 INFO - 'XPC_SERVICE_NAME': '0', 15:22:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:56 INFO - Downloading/unpacking blobuploader==1.2.4 15:22:56 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 15:22:56 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 15:22:56 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 15:22:56 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 15:22:56 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 15:22:56 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 15:22:58 INFO - Downloading blobuploader-1.2.4.tar.gz 15:22:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:22:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:22:58 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 15:22:58 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 15:22:58 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 15:22:58 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 15:22:58 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 15:22:58 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 15:22:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:22:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:59 INFO - Downloading docopt-0.6.1.tar.gz 15:22:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:22:59 INFO - Installing collected packages: blobuploader, requests, docopt 15:22:59 INFO - Running setup.py install for blobuploader 15:22:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:22:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:22:59 INFO - Running setup.py install for requests 15:23:00 INFO - Running setup.py install for docopt 15:23:00 INFO - Successfully installed blobuploader requests docopt 15:23:00 INFO - Cleaning up... 15:23:00 INFO - Return code: 0 15:23:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:23: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')]} 15:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23: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')]} 15:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:00 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 0x10b0c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0a4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18c34e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afeb9f0>, '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 0x10ad4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afde8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9a9FnWdjj/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.hS5nhQgUt7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:23:00 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 15:23:00 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 15:23:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9a9FnWdjj/Render', 15:23:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:00 INFO - 'HOME': '/Users/cltbld', 15:23:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:00 INFO - 'LOGNAME': 'cltbld', 15:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:00 INFO - 'MOZ_NO_REMOTE': '1', 15:23:00 INFO - 'NO_EM_RESTART': '1', 15:23:00 INFO - 'PAGER': '/bin/cat', 15:23:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:00 INFO - 'PWD': '/builds/slave/test', 15:23:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:00 INFO - 'SHELL': '/bin/bash', 15:23:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hS5nhQgUt7/Listeners', 15:23:00 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 15:23:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:00 INFO - 'USER': 'cltbld', 15:23:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:00 INFO - 'XPC_FLAGS': '0x0', 15:23:00 INFO - 'XPC_SERVICE_NAME': '0', 15:23:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:23:00 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-5dH5iY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:23:00 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-bjSrRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:23:00 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-iRYCBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:23:00 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-1A7gKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:23:01 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-QaLQY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:23:01 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-HbYikk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:23:01 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-9SYgKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:23:01 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-_uo1cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:23:01 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-fg7bYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:23:01 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-t3NXzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:23:01 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-xcFY29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:23:01 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-r4Pgs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:23:01 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-UbbLhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:23:02 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-e02oju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:02 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Muf1Jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:23:02 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-2uVQaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:23:02 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-rPkP46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:23:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:23:02 INFO - Running setup.py install for manifestparser 15:23:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:23:02 INFO - Running setup.py install for mozcrash 15:23:02 INFO - Running setup.py install for mozdebug 15:23:02 INFO - Running setup.py install for mozdevice 15:23:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:23:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:23:03 INFO - Running setup.py install for mozfile 15:23:03 INFO - Running setup.py install for mozhttpd 15:23:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:23:03 INFO - Running setup.py install for mozinfo 15:23:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:23:03 INFO - Running setup.py install for mozInstall 15:23:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:23:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:23:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:23:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:23:03 INFO - Running setup.py install for mozleak 15:23:03 INFO - Running setup.py install for mozlog 15:23:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:23:03 INFO - Running setup.py install for moznetwork 15:23:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:23:04 INFO - Running setup.py install for mozprocess 15:23:04 INFO - Running setup.py install for mozprofile 15:23:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:23:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:23:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:23:04 INFO - Running setup.py install for mozrunner 15:23:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:23:04 INFO - Running setup.py install for mozscreenshot 15:23:04 INFO - Running setup.py install for moztest 15:23:04 INFO - Running setup.py install for mozversion 15:23:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:23:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:23:04 INFO - Cleaning up... 15:23:04 INFO - Return code: 0 15:23:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:23:04 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')]} 15:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:04 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')]} 15:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:04 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 0x10b0c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0a4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18c34e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afeb9f0>, '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 0x10ad4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afde8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9a9FnWdjj/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.hS5nhQgUt7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:23:04 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 15:23:04 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 15:23:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9a9FnWdjj/Render', 15:23:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:04 INFO - 'HOME': '/Users/cltbld', 15:23:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:04 INFO - 'LOGNAME': 'cltbld', 15:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:04 INFO - 'MOZ_NO_REMOTE': '1', 15:23:04 INFO - 'NO_EM_RESTART': '1', 15:23:04 INFO - 'PAGER': '/bin/cat', 15:23:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:04 INFO - 'PWD': '/builds/slave/test', 15:23:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:04 INFO - 'SHELL': '/bin/bash', 15:23:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hS5nhQgUt7/Listeners', 15:23:04 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 15:23:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:04 INFO - 'USER': 'cltbld', 15:23:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:04 INFO - 'XPC_FLAGS': '0x0', 15:23:04 INFO - 'XPC_SERVICE_NAME': '0', 15:23:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:23:05 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-N5jwir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:23:05 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)) 15:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:23:05 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-6vnFmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:23:05 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)) 15:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:23:05 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-UJaMsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:23:05 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)) 15:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:23:05 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ABTYDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:23:05 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)) 15:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:23:05 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-GMn4RX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:23:05 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)) 15:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:23:05 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-NNjgxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:23:05 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)) 15:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:23:05 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-WinBSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:23:05 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)) 15:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:23:05 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-F2K8FK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:23:06 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)) 15:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:23:06 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-RUB1uT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:23:06 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)) 15:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:23:06 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-W6Pkn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:23:06 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)) 15:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:23:06 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-faqBgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:23:06 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)) 15:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:23:06 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Fz7YiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:23:06 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)) 15:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:23:06 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-N14vsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:23:06 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)) 15:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:23:06 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-soOMxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:23:06 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)) 15:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:06 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-PCn6bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:06 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)) 15:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:23:06 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-VBANxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:23:06 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)) 15:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:23:06 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-yIyaUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:23:06 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)) 15:23:06 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)) 15:23:06 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)) 15:23:06 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)) 15:23:06 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)) 15:23:06 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)) 15:23:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:23: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 15:23: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 15:23: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 15:23: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 15:23: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 15:23: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 15:23:09 INFO - Downloading blessings-1.5.1.tar.gz 15:23:09 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 15:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:23:09 INFO - Installing collected packages: blessings 15:23:09 INFO - Running setup.py install for blessings 15:23:09 INFO - Successfully installed blessings 15:23:09 INFO - Cleaning up... 15:23:09 INFO - Return code: 0 15:23:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:23:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:23:09 INFO - Reading from file tmpfile_stdout 15:23:09 INFO - Current package versions: 15:23:09 INFO - blessings == 1.5.1 15:23:09 INFO - blobuploader == 1.2.4 15:23:09 INFO - docopt == 0.6.1 15:23:09 INFO - manifestparser == 1.1 15:23:09 INFO - mozInstall == 1.12 15:23:09 INFO - mozcrash == 0.16 15:23:09 INFO - mozdebug == 0.1 15:23:09 INFO - mozdevice == 0.47 15:23:09 INFO - mozfile == 1.2 15:23:09 INFO - mozhttpd == 0.7 15:23:09 INFO - mozinfo == 0.9 15:23:09 INFO - mozleak == 0.1 15:23:09 INFO - mozlog == 3.0 15:23:09 INFO - moznetwork == 0.27 15:23:09 INFO - mozprocess == 0.22 15:23:09 INFO - mozprofile == 0.27 15:23:09 INFO - mozrunner == 6.11 15:23:09 INFO - mozscreenshot == 0.1 15:23:09 INFO - mozsystemmonitor == 0.0 15:23:09 INFO - moztest == 0.7 15:23:09 INFO - mozversion == 1.4 15:23:09 INFO - psutil == 3.1.1 15:23:09 INFO - requests == 1.2.3 15:23:09 INFO - wsgiref == 0.1.2 15:23:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:23: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')]} 15:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23: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')]} 15:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10b0c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0a4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec18c34e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afeb9f0>, '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 0x10ad4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afde8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9a9FnWdjj/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.hS5nhQgUt7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:23:09 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 15:23:09 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 15:23:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9a9FnWdjj/Render', 15:23:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:09 INFO - 'HOME': '/Users/cltbld', 15:23:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:09 INFO - 'LOGNAME': 'cltbld', 15:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:09 INFO - 'MOZ_NO_REMOTE': '1', 15:23:09 INFO - 'NO_EM_RESTART': '1', 15:23:09 INFO - 'PAGER': '/bin/cat', 15:23:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:09 INFO - 'PWD': '/builds/slave/test', 15:23:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:09 INFO - 'SHELL': '/bin/bash', 15:23:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hS5nhQgUt7/Listeners', 15:23:09 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 15:23:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:09 INFO - 'USER': 'cltbld', 15:23:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:09 INFO - 'XPC_FLAGS': '0x0', 15:23:09 INFO - 'XPC_SERVICE_NAME': '0', 15:23:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:10 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)) 15:23:10 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)) 15:23:10 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)) 15:23:10 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)) 15:23:10 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)) 15:23:10 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)) 15:23:10 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)) 15:23:10 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)) 15:23:10 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)) 15:23:10 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)) 15:23:10 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)) 15:23:10 INFO - Cleaning up... 15:23:10 INFO - Return code: 0 15:23:10 INFO - Running post-action listener: _resource_record_post_action 15:23:10 INFO - Running post-action listener: _start_resource_monitoring 15:23:10 INFO - Starting resource monitoring. 15:23:10 INFO - ##### 15:23:10 INFO - ##### Running install step. 15:23:10 INFO - ##### 15:23:10 INFO - Running pre-action listener: _resource_record_pre_action 15:23:10 INFO - Running main action method: install 15:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:23:10 INFO - Reading from file tmpfile_stdout 15:23:10 INFO - Detecting whether we're running mozinstall >=1.0... 15:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:23:10 INFO - Reading from file tmpfile_stdout 15:23:10 INFO - Output received: 15:23:10 INFO - Usage: mozinstall [options] installer 15:23:10 INFO - Options: 15:23:10 INFO - -h, --help show this help message and exit 15:23:10 INFO - -d DEST, --destination=DEST 15:23:10 INFO - Directory to install application into. [default: 15:23:10 INFO - "/builds/slave/test"] 15:23:10 INFO - --app=APP Application being installed. [default: firefox] 15:23:10 INFO - mkdir: /builds/slave/test/build/application 15:23:10 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'] 15:23:10 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 15:23:40 INFO - Reading from file tmpfile_stdout 15:23:40 INFO - Output received: 15:23:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:23:40 INFO - Running post-action listener: _resource_record_post_action 15:23:40 INFO - ##### 15:23:40 INFO - ##### Running run-tests step. 15:23:40 INFO - ##### 15:23:40 INFO - Running pre-action listener: _resource_record_pre_action 15:23:40 INFO - Running main action method: run_tests 15:23:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:23:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:23:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:23:40 INFO - 2015-11-20 15:23:40.827 screenresolution[1641:7834] starting screenresolution argv=screenresolution get 15:23:40 INFO - 2015-11-20 15:23:40.830 screenresolution[1641:7834] Display 0: 1600x1200x32@60 15:23:40 INFO - 2015-11-20 15:23:40.836 screenresolution[1642:7837] starting screenresolution argv=screenresolution list 15:23:40 INFO - Available Modes on Display 0 15:23:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:23:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:23:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:23:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:23:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:23:41 INFO - Intel Iris: 15:23:41 INFO - Chipset Model: Intel Iris 15:23:41 INFO - Type: GPU 15:23:41 INFO - Bus: Built-In 15:23:41 INFO - VRAM (Dynamic, Max): 1536 MB 15:23:41 INFO - Vendor: Intel (0x8086) 15:23:41 INFO - Device ID: 0x0a2e 15:23:41 INFO - Revision ID: 0x0009 15:23:41 INFO - Displays: 15:23:41 INFO - Display: 15:23:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:23:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:23:41 INFO - Display Serial Number: 1600x1200 60 15:23:41 INFO - Main Display: Yes 15:23:41 INFO - Mirror: Off 15:23:41 INFO - Online: Yes 15:23:41 INFO - Rotation: Supported 15:23:41 INFO - Return code: 0 15:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:23:41 INFO - Python 2.7.3 15:23:41 INFO - Return code: 0 15:23:41 INFO - grabbing minidump binary from tooltool 15:23:41 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')]} 15:23:41 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 0x10afeb9f0>, '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 0x10ad4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afde8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:23:41 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 15:23:41 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 15:23:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:23:41 INFO - Return code: 0 15:23:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:23:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:23:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:23:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:23:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:23:41 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--webServer', 'localhost'] in /builds/slave/test/build 15:23:41 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0002 --webServer localhost 15:23:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z9a9FnWdjj/Render', 15:23:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:41 INFO - 'HOME': '/Users/cltbld', 15:23:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:41 INFO - 'LOGNAME': 'cltbld', 15:23:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:23:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:41 INFO - 'MOZ_NO_REMOTE': '1', 15:23:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:23:41 INFO - 'NO_EM_RESTART': '1', 15:23:41 INFO - 'PAGER': '/bin/cat', 15:23:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:41 INFO - 'PWD': '/builds/slave/test', 15:23:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:23:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:41 INFO - 'SHELL': '/bin/bash', 15:23:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hS5nhQgUt7/Listeners', 15:23:41 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 15:23:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:41 INFO - 'USER': 'cltbld', 15:23:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:41 INFO - 'XPC_FLAGS': '0x0', 15:23:41 INFO - 'XPC_SERVICE_NAME': '0', 15:23:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:41 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--webServer', 'localhost'] with output_timeout 3600 15:23:41 INFO - mozversion INFO | application_buildid: 20151120142833 15:23:41 INFO - mozversion INFO | application_changeset: 106bfad77bf44d39fc334b336b037a70c2130d52 15:23:41 INFO - mozversion INFO | application_display_name: Nightly 15:23:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:23:41 INFO - mozversion INFO | application_name: Firefox 15:23:41 INFO - mozversion INFO | application_remotingname: firefox 15:23:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 15:23:41 INFO - mozversion INFO | application_vendor: Mozilla 15:23:41 INFO - mozversion INFO | application_version: 45.0a1 15:23:41 INFO - mozversion INFO | platform_buildid: 20151120142833 15:23:41 INFO - mozversion INFO | platform_changeset: 106bfad77bf44d39fc334b336b037a70c2130d52 15:23:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 15:23:41 INFO - mozversion INFO | platform_version: 45.0a1 15:23:41 INFO - 2015-11-20 15:23:41,383 DEBUG : using testdate: 1448061821 15:23:41 INFO - 2015-11-20 15:23:41,383 DEBUG : actual date: 1448061821 15:23:41 INFO - 2015-11-20 15:23:41,798 INFO : starting webserver on 'localhost:49269' 15:23:41 INFO - 2015-11-20 15:23:41,799 INFO : Starting test suite t-yosemite-r7-0002.e 15:23:41 INFO - 2015-11-20 15:23:41,799 INFO : Starting test dromaeo_css 15:23:41 INFO - 2015-11-20 15:23:41,799 DEBUG : operating with platform_type : mac_ 15:23:41 INFO - 2015-11-20 15:23:41,800 INFO : Initialising browser for dromaeo_css test... 15:23:41 INFO - 2015-11-20 15:23:41,813 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpgE1D36/profile http://localhost:49269/getInfo.html 15:23:44 INFO - 2015-11-20 15:23:44,665 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:23:44 INFO - 2015-11-20 15:23:44,665 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:23:44 INFO - 2015-11-20 15:23:44,665 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:23:44 INFO - 2015-11-20 15:23:44,665 DEBUG : BROWSER_OUTPUT: __metrics 15:23:45 INFO - 2015-11-20 15:23:45,242 INFO : Browser initialized. 15:23:45 INFO - 2015-11-20 15:23:45,242 INFO : Running cycle 1/1 for dromaeo_css test... 15:23:45 INFO - 2015-11-20 15:23:45,243 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpgE1D36/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:23:57 INFO - 2015-11-20 15:23:57,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 236724224 15:23:57 INFO - 2015-11-20 15:23:57,213 DEBUG : BROWSER_OUTPUT: 15:24:46 INFO - 2015-11-20 15:24:46,932 DEBUG : BROWSER_OUTPUT: 1448061886930 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] 15:26:57 INFO - 2015-11-20 15:26:57,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 15:26:58 INFO - 2015-11-20 15:26:58,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 252657664 15:26:58 INFO - 2015-11-20 15:26:58,869 DEBUG : BROWSER_OUTPUT: 15:30:00 INFO - 2015-11-20 15:30:00,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 15:30:01 INFO - 2015-11-20 15:30:01,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 263544832 15:30:01 INFO - 2015-11-20 15:30:01,479 DEBUG : BROWSER_OUTPUT: 15:33:03 INFO - 2015-11-20 15:33:03,161 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 15:33:03 INFO - 2015-11-20 15:33:03,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 265433088 15:33:03 INFO - 2015-11-20 15:33:03,746 DEBUG : BROWSER_OUTPUT: 15:36:05 INFO - 2015-11-20 15:36:05,326 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 15:36:05 INFO - 2015-11-20 15:36:05,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 266420224 15:36:05 INFO - 2015-11-20 15:36:05,914 DEBUG : BROWSER_OUTPUT: 15:39:08 INFO - 2015-11-20 15:39:08,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 15:39:08 INFO - 2015-11-20 15:39:08,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 269410304 15:39:08 INFO - 2015-11-20 15:39:08,883 DEBUG : BROWSER_OUTPUT: 15:42:11 INFO - 2015-11-20 15:42:11,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 15:42:11 INFO - 2015-11-20 15:42:11,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 271605760 15:42:11 INFO - 2015-11-20 15:42:11,348 DEBUG : BROWSER_OUTPUT: 15:42:11 INFO - 2015-11-20 15:42:11,348 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:42:11 INFO - 2015-11-20 15:42:11,348 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:42:11 INFO - 2015-11-20 15:42:11,348 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:42:11 INFO - 2015-11-20 15:42:11,348 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:42:11 INFO - 2015-11-20 15:42:11,348 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2911.708829117088;3520.119970007498;3536.1336472564226;3569.1434055826603;3576.695980841628;5860.384659610738;5868.765249390025;5919.260092488439;5926.170336152942;5971.88056238876;5609.859753506164;5711.343195532515;5742.942570574293;5805.954928112938;5935.584509084366;5256.369235691723;5266.210068489738;5352.892942141155;5400.459954004607;5404.810831620894;5404.675719456825;5431.21247419124;5437.075697131497;5466.34403871534;5483.067878460672;4507.211238033331;5153.871153221162;5157.974210128963;5281.630285879952;5365.222042803791;5292.655977361459;5294.841154765363;5308.495692909168;5311.521963023347;5319.654222475527;5301.257823904656;5304.098303288451;5323.946760532383;5324.41431442541;5404.702741349224;4516.909661806745;5495.945040549584;5692.861427714473;5769.423057694239;5834.212381328509;6301.527385446064;6305.905411418832;6359.42765151134;6359.586626869239;6376.330485299023;6331.588446750947;6332.4934005279465;6333.1450254216015;6349;6360.840978975516;5761.337446193657;5849.268841394868;5919.319278283009;5989.520838332923;6056.063558686801;6359.904601430982;6412.134361861183;6462.709178086998;6463.6768161591735;6472.741090356333;6064.272287325461;6309;6323.177986861679;6349.746010159634;6355.0785136155;5188.844334669966;6143.416375444325;6266.530010249249;6306.968465157736;6341.4609758170145;6289.7169627366875;6307.747690092437;6331.461825744771;6339.904901426482;6349.238091429058;6133.48768512239;6277.2781130170615;6341.334159913143;6345.302016778151;6346.936530634634;4880.170371036932;4938.604911607063;4950.4059512858685;4958.801647934114;4989.60083193351;4519.525449827786;4529.456465224194;4531.84138555149;4536.77316134192;4585.70192937458;5742.885142297131;5856.970715146397;5928.644281343047;6076;6092.543059270483;6184.381561843779;6293.905591416133;6294.874102517924;6305.8649443100685;6321.715522801485;5986.491148252448;6023.909641355383;6036.405175196766;6037.818865434044;6075.696215189311;5240.895182096337;5363.329583802025;5456.345238571397;5538.667679939216;5551.306086739158;6280.089387038854;6363.490920726238;6376.458001069961;6377.266614339411;6406.519511036598;6290.24517057956;6332.746690132527;6346.143270658402;6375.553711240169;6377;6264.467520260829;6291.622502649856;6446.033095035595;6452.096706461193;6515.641639709862;6327.936720632735;6330.493560515056;6341.714622841891;6352.936470635419;6364.172657554488;6328.715207815567;6333.145025421509;6341.492680585634;6349.174607301206;6349.809505714836;5880.529557635294;6129.236538068469;6220.564560480723;6233.283172435228;6289.7484100635465;6236.251649802053;6260.499160067093;6328.936710632835;6336.524760642878;6345.460635846005;6001.639901605918;6135.417135372132;6201.906971395342;6202.596831206138;6239.968800156152;5243.318368612056;5697.202391665087;6103.23709536308;6186.845328866814;6239.220097487814;5056.317397151484;6159.568830182024;6211.844703882439;6214.8135555933395;6220.906686399617 15:42:11 INFO - 2015-11-20 15:42:11,348 DEBUG : BROWSER_OUTPUT: |1;ext.html;529.6213207556597;566.8441178675862;570.5036618142217;601.2064075420446;630.977915772948;41083;41345;41357.58642413575;41433.17133657329;41500.79249603752;39722;42628.78685606575;44933.775331123295;45378.773106134424;45653.086938261295;9812.313138080337;9914.157296629759;9987.101160895518;9989.250806189528;10004.799904001951;9754.170895473893;9876.209903207726;9876.802463950717;9882.703518894408;9915.553800079013;9859.753506162368;9929.3545919515;9940.055694709028;9964.501774911261;9973.152282056033;9872.062154095349;9876.999999999964;9937.25470589705;9952;9988.600455981752;9682.419054856731;9831.655892043744;9833.213342932548;9841.55712992917;9852.211823054138;41656.79171604153;41741.58258417438;41885.95285117866;42110.57889421097;42215.57784422147;3097.2877534938066;3110.6111736032994;3185.729213016896;3240.756943229267;3377.9324413511836;20376;27213.86393068022;28760.137195884156;29188.27029324284;30351.848240758656;2799.1322689965973;2827.2507785436874;2865.5988161657383;2888.7111288871156;2890.2918784897834;517190;522962.3851880754;523121.3843930756;523266;524235;59639;60522.092168617506;69845;70455.2954470459;73057.6347118261;71982.28017719756;72269.63865180641;72895.63552182312;72920.63539682268;72988.63505682438;16663.00021998684;16704.58238544022;16721.331146753993;16937.745933811002;16975.660486790443;12513.74972500545;12634.747305053848;12733.29966851832;12772.489100435878;12778.488860445665;21908.45228869291;21975.2308669199;21988.01053952576;22256.777432225794;22317.55364892693;9074.45553266793;9355.251579873593;9565.808683826284;9626.422414655142;9642.71071867845;966.2221911361281;982.3565564555228;990.4156547636928;1021.9284650074572;1143.7941170589374;30198.245043873638;30296.84851575728;30452.53555351964;30501;30732.846335768627;902.8781114549583;1061.7027232374946;1087.8857719939451;1118.3345909184022;1200.477792160413;14969.925150374178;14970;15269.923650381677;15270.847291527165;17329.046902420236;544329;653880;670472;672518;672863;67213.32786672168;67513;67564.6621766888;67836.6608166956;68201.65899170472;1203.506562309449;1369.6370461827623;1508.8868334874928;1515.6059424549476;1520.3538496139097;31859;31967.840160799045;32063.67936320607;32456.35087298288;32491.35017299688;53891.92216155576;53895.73052134871;54116.45883541114;54526;54629.726851365485;508246;511549;512119;515344;517106;34913.65086349104;47686.523134768206;48143.75928120337;48925.5107448921;49129;46007.76996114998;46877;47344.053118938114;48040;48392.758036211;37534.81232593929;39574;39824.00439989023;41638.791806040776;42296.57703422927;35410.645893540735;39402.21195576015;41485;41619.16761664689;42263.7886810564;38128;38521.422178667905;38668.419973699856;38674.71264942511;40607.39088913728;29949.15483029109;34167.63329466793;35850.820745896104;36121.63878361183;36678.26643467062;25558.849851756342;25569.48861022806;25846.35384115337;25927.197289674015;25994.350141245865 15:42:11 INFO - 2015-11-20 15:42:11,348 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.4239190120106;363.26438961103764;366.6828193612526;367.06581749447645;367.25997115811634;16916;18878.244870205177;19677.60644787105;20761.896190519044;21261.893690531546;17276.82723172768;20223.191072357087;20228.8988555057;20473.590528189427;20779.68830467544;5149.356330458702;5268.31511903452;5303.15149576066;5305.761240744157;5311.442298558634;3955.861544845931;4082.7142100053006;5229.973850130744;5673.631213971079;5754.482096611304;5696.231008813798;5785.942140578582;5807.274090738658;5829.09649004405;5867.237259156325;5712.171735098429;5720.056190728525;5734.913976290359;5751.281089863767;5772.5670574706855;5227.581793456515;5527.226188333637;5532.3914369419335;5533.3083364579425;5535.142052981794;12553.560625378159;12878.549250776177;12886.226826390353;14345.928270358685;25896.352591185183;1983.6429442700307;2001.4896201468532;2155.2887547109417;2237.8881055947136;2270.852394594346;9685.467299298536;12191.695207619792;14536.34586443602;14827.481038163613;15374.615634609112;1691.8646508279307;1710.2816816936916;1724.8016478104928;1737.218251786701;1781.403229917979;75240;89952;98147.50926245323;98451.50774246083;98854;10849.294795838245;11030.172737044753;11112.888871111347;11161.051310638524;11222.438878056064;12997.740045199043;13042.347882605833;13109.213447193199;13129.474821007243;13169.868301317056;7110.893336599956;8352.749417517483;8460.534670593053;8472.110428405053;8547.74356769298;7297.16082650502;8443.155684431507;8672.089430609822;8693.695945608082;8696.086910874394;4261.296886013773;4279.507856596531;4310.719803212781;4346.282863327516;4358.8910277242685;1822.098061459586;1859.6466671332673;1869.6728072587243;1879.0322983663425;1889.9622007560047;853.7364700243675;900.2887718702152;924.9722508324761;949.392388871123;988.3378136648463;19968.30110946139;20234.494137646678;20378.796212037985;20498.282560110325;20707.23988460998;886.078478382475;1001.5092604623682;1007.7228762090484;1015.1979935850595;1026.8357062869904;9977.750556236153;10822;10860.402677852637;10936.726581835517;10954.233203675667;712342;735412;750770;752477;763909;104212.95787042184;108969;131978;133244.99999999805;134254.65745342616;1152.3028567716578;1169.1582060916128;1179.2040372748531;1196.7247533067443;1201.3692811274152;18588.535286617942;18675.066246687882;19330.4200873974;19405.902970485058;19824.70262946086;48238;48430.27354589613;48839;49138.262926055424;52758.472415275355;70642.64678676573;74816.62591687006;76451.23548764442;77119;77568;9531.857022144812;9602.08780165883;9812.460314682761;9959.103680668484;9982.151517121127;11494.252873563191;11749.88250117488;19360.225590976766;19594.706079408534;20653.793462065787;15795.921020394824;15931.601709957344;16118.67762644764;16158;16539.91730041342;15209.391624335345;15313.693726125637;15677;15765.527034188992;15790.21048947571;15440.613984650474;16558.840881138203;16718.247678854237;17011.829881701025;17043.65912681764;8787.560621968749;9803.313768036169;9910.504474776377;9956.054174853378;10110.887802341884;15851.207439628202;15871.841281587036;15998.9200053999;16447.342106315613;16511.256993435083 15:42:11 INFO - 2015-11-20 15:42:11,349 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1368.3431952662716;1548.3419546692653;1662.2769095443475;1889.8393636540893;1912.4167129025648;5766.423357664232;7043.964780176098;7056.717731290749;7560.886586701204;7650.846983060335;8073.798155046126;8202.302804261644;8280.089190189074;8316.584170791466;8324.33405327574;2345.108858633717;2395.880205989702;2396.8082553395775;2403.0868270057354;2409.036385445827;2397.436602398435;2417.8549287042833;2450.9583427043526;2456.5701002324613;2463.1132792194794;2366.2782851230368;2392.222527678503;2409.5662780699467;2417.0694282701197;2424.3939015246187;2066.5040390306367;2358.9764102358927;2386.9283921482383;2413.9758602414013;2419.407245224931;2094.465911192636;2112.5035616630234;2121.809037186645;2128.595566842295;2138.037882952662;8418.368622353286;8438.156184381513;8442.366822488339;8467.407281490237;8481.448705834102;4681.836135735233;5124.282600435942;5240.292560504321;5249.4750524947585;5253.264542963988;3231.88688395905;3483.529723487322;3488.3895318319446;3557.964420355815;3598.352296586613;1015.3755440404173;1025.8512515685259;1050.0444595418132;1072.7479042425102;1079.373963101407;11064.557417703201;11079.944600277027;11127.888721112848;11148.888511114947;11158.776824463546;4688.968426946067;4726.8109275628585;4768.6661933665;4785.928211076836;4818.469968303484;9675.984021677623;9700.6119755209;9712.125908668253;9713;9719.708408747749;4535.546445355438;5197.194434862602;5223.738813059332;5235.240890070919;5272.815451459181;4787.257975013878;4795.544423279783;4821.783019764119;4824.107540105092;4828.782704778293;3886.689064874803;3888.902777430587;3896.8246428910766;3898.0314940955204;3911.119998000427;1246.2211118051218;1285.556483013359;1289.6582405662507;1295.1452041652465;1299.3957809618573;1043.6973277749369;1052.5000624703357;1084.262701363065;1386.2583517817918;1409.901306908527;7725.575093369918;7863.33161681252;7885.605719713992;7931.2068793120225;7932.603369831485;487.76343473415363;500.64204094072187;504.14547342254525;504.772852216504;504.9065922804293;5875.206847075676;6126.908096378558;6129.478994285536;6170.043643235305;6210.689465526705;8263.710770123138;8521.786955326043;8539.188777066169;8543.530105844115;8558.186972237627;9894.703158905244;10054.547545360476;10127.24045696561;10197.490125493696;10272.486375681186;7926.24700653437;7927.801804954922;7943.92056079455;7994.200579942076;8041.035075790943;7712;7759.961200193963;7777;7800.102988156435;7845.607719613882;8935.642574297215;8996.325275604488;9113.77215569616;9123.908760912305;9154.633814647606;9153.450792952444;9365.484898330657;9405.811883762422;9428;9490.715278541655;7225.205227425085;7287.526310789782;7291.4166866649475;7295.4528410368375;7298.96350518244;7547.132079810892;7745.651445684845;7766.378689704697;7773.41699372538;7817.37461003107;7493.587852668155;7512.023436953161;7531.548107113591;7541.7360392386;7585.962070189614;7339;7372.520786148883;7406.851862962602;7503.09962804467;7516.924830751623;7374.926250737639;7486.5508069516;7504.812379690551;7511.173770885089;7522.774316770506;6829.760958366433;6832.214295356098;6851.143607049119;6863.245043045361;6875.656217189021;6888.827779305558;6910.44716422695;6925.68834402443;6936.132983377078;6953.68708408133 15:42:11 INFO - 2015-11-20 15:42:11,354 DEBUG : BROWSER_OUTPUT: |4;prototype.html;266.7572509016795;319.62124882014814;326.6358010817938;329.7576281433148;339.3230505142242;5891;6438.710258038388;6776.15298087739;6906.274841141683;6921.273266307035;5151.74241287936;6760.966195169017;6778.932210677892;6804.693788779505;6815.352541508549;4918.139325618021;4927.753612319388;4934.0625281196635;4943.629227807911;4947.872414861608;4918.286848406979;4929.383827021622;4938.234573641073;4940.456549779521;4955.479674634165;4726.291056341559;4880.3655524781725;4895.730734809584;4901.975490122544;4914.213725803854;4894.486078961711;4898.314236006961;4915.778789954461;4918.5573298403315;4925.064237794808;4029.49631296088;4106.7946602669745;4118.835246590133;4138.793060347;4146.004958809864;6364.936350636481;6384.265809431929;6458.709358078898;6470.514711396617;6497.090407342976;4675.766211689402;5222.529972302473;5251.133562962106;5760.9711951440395;5791.391903850077;6909.1018167638385;7144.678489467987;7170.390516806077;7174.354308112295;7189.8202544936275;3808.447775072599;3834.4248362745534;4613.492515823256;4624.745638989854;4644.744539050351;5442.700651464168;7401;7536.4724469287175;7551.018367612175;7659.961700191519;4670.883227919329;4688.320193571913;4697.718136911796;4701.130290896127;4713;4678.461976872703;4793.688410253322;4803.807847686124;4811.061842940663;4834.105690447208;5756.395578464285;5790.826275211751;5798.536117110621;5806.274215723035;5821.563382746311;7256.8911466328045;7284.745033923893;7286.963565182246;7294.598797066213;7299.5255308404785;1612.5243053299305;1642.4251511970954;1673.6652669466155;1681.1762236504026;1686.1400685650406;1047.3611097230682;1063.7553362726617;1069.1072954083272;1074.1782536359692;1083.0577397663926;6818.079559259536;6821.556598821061;6831.385175334244;6859.416949559243;6885.793426197222;7529.284717951786;7564.546127232384;7569.545827250273;7579.317861392501;7581.3176814087;6619.966900165468;6840.281770414134;6844.589324640438;6845.007473916255;6866.313368663094;3420.743444241692;3897.7271590988926;3906;3973.5033120859894;3991.900202494961;7672.616369181518;7699.615019249015;7833.882491762628;7959.403044771665;7959.920400796033;7753.767386978399;7835.882461763078;7858.2141785822105;7881.1724768899585;7902.644381002869;6407.615543067431;7787.961060194776;7971.561564113914;7983.600819958979;8004.159563245892;7650.73222437212;7663.233676632292;7665.923340766521;7675.808104797425;7691.192424795316;7304.96347518259;7509.699612015458;7511.699532018658;7514.736984205527;7517;7942.6966179807205;7973.561454120079;7977.8404431912195;7984.920150798418;7996.3602911768085;4866.48901865299;4924.138275801649;4926.729029903389;4928.334674818853;4957.429895561912;5544.944550554443;7390.889136663062;7524.473286869867;7533;7561.735339263099;5849.064149736022;5887.61730487517;6277.2153480814895;6891.655417229219;7264.418846492374;7257.963710181415;7258.491905566771;7266.491345605757;7276.235995220426;7292.015577897128;6840.2475727668925;7046.894296585453;7052.977318288717;7056.717731290691;7076;7292.635368231461;7300.087489063867;7322.560646361236;7346.52247603904;7368.852622947618;5796.275465566804;7140.964295178491;7157.355837974607;7164.068671072727;7168.139823221039 15:42:11 INFO - 2015-11-20 15:42:11,354 DEBUG : BROWSER_OUTPUT: |5;yui.html;748.6107224243393;776.5146783260462;793.2820797178551;793.3970182661176;863.9222469977702;14919.925400372997;15074.924625376885;15272.160031198307;15293.999999999985;15364.308606112723;15670.686586268297;15716.528504144866;15825.971311864721;15836;15898.364065437368;649.438235925923;780.2626517940548;941.1952780372802;963.0177219236375;963.1764841060897;936.8360536906048;946.820104180207;951.1154626197633;961.1877963121151;964.1274646444944;979.2704435195789;986.921046316293;987.6641941739807;991.6826615483048;996.8305388084007;978.3738407419257;980.7204946590223;983.6606370802061;987.6938149173743;996.7209181429175;731.3454458259828;735.7498450526847;740.2967181177903;741.525423728814;742.1391186224008;15336.15651139187;15405.22973851303;15423;15423.537293881202;15539.30073146711;12240.143189976705;12270.202436841577;12342.938285308606;12349.567765128177;12426.130170888042;9914.305998580103;10138.898611013869;10260.281780275383;10298.073173414428;10303.742406439898;3463.8441270142903;3511.7541772075965;3560.9821950890077;3598.298331825295;3709.962900370989;75441.62279188569;76272.23727762706;76809;79622;79994.20005799926;8212.548309842896;9373.765655858659;9561.713148605553;9574.617015319449;10062.19502439803;18550.16524256412;21145.519813613206;21458.24896128628;21594.460138496663;21807.890960545414;7452.664630091659;7498.700051997859;7697.653605587762;7772.222777722295;7854.803629909298;4131.5248746394545;4146.37804329353;4173.269677806372;4183.686223533247;4183.769892655933;3537.4163263061823;3540.7344449166417;3555.911102222465;3592.0481072515804;3594.6045934947133;640.5228105061759;644.9967750161313;651.6611362091686;673.9730410783513;675.0785178231777;415.6300892205939;496.63497329462814;517.506828904892;518.2097301614992;521.1999580643694;8602.225799678059;8738.38831281817;8744.300455963508;8865.246454051477;8917.019127895926;593.8248216776061;631.7567736421511;633.7401665317198;634.1502386801708;644.3813938618885;3835.1946091321133;4108.239975604463;4152.896177595584;4179.519355274182;4187.832486700498;104002;104543;104571.95428045775;104751;104958;64689;73775;87740;88803.11196888078;89392;74239;75227.62386188035;76586;77264;77397.61301193571;8323.22869418135;8342.708005219789;8619.655213791379;8631.26634236097;9061.22979546746;41498;54395.45604543904;54521.72739136279;54978;55085;69553;69833;70220.59558808897;74958;75313.62343188249;11041.44792760375;11152.888471115184;11214.439278036229;11409.429528523375;12104.636860894187;11794.646160615195;12070.939645301718;12237.816432753694;12824;12953.54662586805;11273.492692828679;11357.432128393713;11364.204505684524;11491.195616307112;12451.066170037102;11392.94303528477;11421.828672570084;11754.823677645014;11820.940895295813;12409.255444673348;11426;11862.822057669315;11873.109516786102;11900.642980710592;11902.523899043941;8355.749327520183;10169.796604068026;10191.592336306761;10226.795464090825;10849.077828384676;8004.919950800418;8051.557164356017;9141.497217653094;9589.712308630753;9707.029297070236 15:42:11 INFO - 2015-11-20 15:42:11,354 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:42:11 INFO - 2015-11-20 15:42:11,354 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:42:11 INFO - 2015-11-20 15:42:11,354 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,320 15:42:11 INFO - 2015-11-20 15:42:11,354 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:42:11 INFO - 2015-11-20 15:42:11,354 DEBUG : BROWSER_OUTPUT: __startTimestamp1448062931340__endTimestamp 15:42:11 INFO - 2015-11-20 15:42:11,355 DEBUG : BROWSER_OUTPUT: 15:42:11 INFO - 2015-11-20 15:42:11,355 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:42:11 INFO - 2015-11-20 15:42:11,355 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:42:11 INFO - 2015-11-20 15:42:11,355 DEBUG : BROWSER_OUTPUT: 15:42:11 INFO - 2015-11-20 15:42:11,355 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5832.23 Median:6103.24 stddev:671.17 (11.0%) stddev-sans-first:632.92 15:42:11 INFO - 2015-11-20 15:42:11,355 DEBUG : BROWSER_OUTPUT: Values: 2911.7 3520.1 3536.1 3569.1 3576.7 5860.4 5868.8 5919.3 5926.2 5971.9 5609.9 5711.3 5742.9 5806.0 5935.6 5256.4 5266.2 5352.9 5400.5 5404.8 5404.7 5431.2 5437.1 5466.3 5483.1 4507.2 5153.9 5158.0 5281.6 5365.2 5292.7 5294.8 5308.5 5311.5 5319.7 5301.3 5304.1 5323.9 5324.4 5404.7 4516.9 5495.9 5692.9 5769.4 5834.2 6301.5 6305.9 6359.4 6359.6 6376.3 6331.6 6332.5 6333.1 6349.0 6360.8 5761.3 5849.3 5919.3 5989.5 6056.1 6359.9 6412.1 6462.7 6463.7 6472.7 6064.3 6309.0 6323.2 6349.7 6355.1 5188.8 6143.4 6266.5 6307.0 6341.5 6289.7 6307.7 6331.5 6339.9 6349.2 6133.5 6277.3 6341.3 6345.3 6346.9 4880.2 4938.6 4950.4 4958.8 4989.6 4519.5 4529.5 4531.8 4536.8 4585.7 5742.9 5857.0 5928.6 6076.0 6092.5 6184.4 6293.9 6294.9 6305.9 6321.7 5986.5 6023.9 6036.4 6037.8 6075.7 5240.9 5363.3 5456.3 5538.7 5551.3 6280.1 6363.5 6376.5 6377.3 6406.5 6290.2 6332.7 6346.1 6375.6 6377.0 6264.5 6291.6 6446.0 6452.1 6515.6 6327.9 6330.5 6341.7 6352.9 6364.2 6328.7 6333.1 6341.5 6349.2 6349.8 5880.5 6129.2 6220.6 6233.3 6289.7 6236.3 6260.5 6328.9 6336.5 6345.5 6001.6 6135.4 6201.9 6202.6 6240.0 5243.3 5697.2 6103.2 6186.8 6239.2 5056.3 6159.6 6211.8 6214.8 6220.9 15:42:11 INFO - 2015-11-20 15:42:11,355 DEBUG : BROWSER_OUTPUT: 15:42:11 INFO - 2015-11-20 15:42:11,355 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:71236.53 Median:42163.08 stddev:150121.28 (356.0%) stddev-sans-first:150448.54 15:42:11 INFO - 2015-11-20 15:42:11,357 DEBUG : BROWSER_OUTPUT: Values: 529.6 566.8 570.5 601.2 631.0 41083.0 41345.0 41357.6 41433.2 41500.8 39722.0 42628.8 44933.8 45378.8 45653.1 9812.3 9914.2 9987.1 9989.3 10004.8 9754.2 9876.2 9876.8 9882.7 9915.6 9859.8 9929.4 9940.1 9964.5 9973.2 9872.1 9877.0 9937.3 9952.0 9988.6 9682.4 9831.7 9833.2 9841.6 9852.2 41656.8 41741.6 41886.0 42110.6 42215.6 3097.3 3110.6 3185.7 3240.8 3377.9 20376.0 27213.9 28760.1 29188.3 30351.8 2799.1 2827.3 2865.6 2888.7 2890.3 517190.0 522962.4 523121.4 523266.0 524235.0 59639.0 60522.1 69845.0 70455.3 73057.6 71982.3 72269.6 72895.6 72920.6 72988.6 16663.0 16704.6 16721.3 16937.7 16975.7 12513.7 12634.7 12733.3 12772.5 12778.5 21908.5 21975.2 21988.0 22256.8 22317.6 9074.5 9355.3 9565.8 9626.4 9642.7 966.2 982.4 990.4 1021.9 1143.8 30198.2 30296.8 30452.5 30501.0 30732.8 902.9 1061.7 1087.9 1118.3 1200.5 14969.9 14970.0 15269.9 15270.8 17329.0 544329.0 653880.0 670472.0 672518.0 672863.0 67213.3 67513.0 67564.7 67836.7 68201.7 1203.5 1369.6 1508.9 1515.6 1520.4 31859.0 31967.8 32063.7 32456.4 32491.4 53891.9 53895.7 54116.5 54526.0 54629.7 508246.0 511549.0 512119.0 515344.0 517106.0 34913.7 47686.5 48143.8 48925.5 49129.0 46007.8 46877.0 47344.1 48040.0 48392.8 37534.8 39574.0 39824.0 41638.8 42296.6 35410.6 39402.2 41485.0 41619.2 42263.8 38128.0 38521.4 38668.4 38674.7 40607.4 29949.2 34167.6 35850.8 36121.6 36678.3 25558.8 25569.5 25846.4 25927.2 25994.4 15:42:11 INFO - 2015-11-20 15:42:11,357 DEBUG : BROWSER_OUTPUT: 15:42:11 INFO - 2015-11-20 15:42:11,357 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38412.09 Median:20734.57 stddev:122288.23 (589.8%) stddev-sans-first:122597.89 15:42:11 INFO - 2015-11-20 15:42:11,358 DEBUG : BROWSER_OUTPUT: Values: 353.4 363.3 366.7 367.1 367.3 16916.0 18878.2 19677.6 20761.9 21261.9 17276.8 20223.2 20228.9 20473.6 20779.7 5149.4 5268.3 5303.2 5305.8 5311.4 3955.9 4082.7 5230.0 5673.6 5754.5 5696.2 5785.9 5807.3 5829.1 5867.2 5712.2 5720.1 5734.9 5751.3 5772.6 5227.6 5527.2 5532.4 5533.3 5535.1 12553.6 12878.5 12886.2 14345.9 25896.4 1983.6 2001.5 2155.3 2237.9 2270.9 9685.5 12191.7 14536.3 14827.5 15374.6 1691.9 1710.3 1724.8 1737.2 1781.4 75240.0 89952.0 98147.5 98451.5 98854.0 10849.3 11030.2 11112.9 11161.1 11222.4 12997.7 13042.3 13109.2 13129.5 13169.9 7110.9 8352.7 8460.5 8472.1 8547.7 7297.2 8443.2 8672.1 8693.7 8696.1 4261.3 4279.5 4310.7 4346.3 4358.9 1822.1 1859.6 1869.7 1879.0 1890.0 853.7 900.3 925.0 949.4 988.3 19968.3 20234.5 20378.8 20498.3 20707.2 886.1 1001.5 1007.7 1015.2 1026.8 9977.8 10822.0 10860.4 10936.7 10954.2 712342.0 735412.0 750770.0 752477.0 763909.0 104213.0 108969.0 131978.0 133245.0 134254.7 1152.3 1169.2 1179.2 1196.7 1201.4 18588.5 18675.1 19330.4 19405.9 19824.7 48238.0 48430.3 48839.0 49138.3 52758.5 70642.6 74816.6 76451.2 77119.0 77568.0 9531.9 9602.1 9812.5 9959.1 9982.2 11494.3 11749.9 19360.2 19594.7 20653.8 15795.9 15931.6 16118.7 16158.0 16539.9 15209.4 15313.7 15677.0 15765.5 15790.2 15440.6 16558.8 16718.2 17011.8 17043.7 8787.6 9803.3 9910.5 9956.1 10110.9 15851.2 15871.8 15998.9 16447.3 16511.3 15:42:11 INFO - 2015-11-20 15:42:11,358 DEBUG : BROWSER_OUTPUT: 15:42:11 INFO - 2015-11-20 15:42:11,358 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5750.39 Median:6001.06 stddev:2985.04 (49.7%) stddev-sans-first:2975.24 15:42:11 INFO - 2015-11-20 15:42:11,359 DEBUG : BROWSER_OUTPUT: Values: 1368.3 1548.3 1662.3 1889.8 1912.4 5766.4 7044.0 7056.7 7560.9 7650.8 8073.8 8202.3 8280.1 8316.6 8324.3 2345.1 2395.9 2396.8 2403.1 2409.0 2397.4 2417.9 2451.0 2456.6 2463.1 2366.3 2392.2 2409.6 2417.1 2424.4 2066.5 2359.0 2386.9 2414.0 2419.4 2094.5 2112.5 2121.8 2128.6 2138.0 8418.4 8438.2 8442.4 8467.4 8481.4 4681.8 5124.3 5240.3 5249.5 5253.3 3231.9 3483.5 3488.4 3558.0 3598.4 1015.4 1025.9 1050.0 1072.7 1079.4 11064.6 11079.9 11127.9 11148.9 11158.8 4689.0 4726.8 4768.7 4785.9 4818.5 9676.0 9700.6 9712.1 9713.0 9719.7 4535.5 5197.2 5223.7 5235.2 5272.8 4787.3 4795.5 4821.8 4824.1 4828.8 3886.7 3888.9 3896.8 3898.0 3911.1 1246.2 1285.6 1289.7 1295.1 1299.4 1043.7 1052.5 1084.3 1386.3 1409.9 7725.6 7863.3 7885.6 7931.2 7932.6 487.8 500.6 504.1 504.8 504.9 5875.2 6126.9 6129.5 6170.0 6210.7 8263.7 8521.8 8539.2 8543.5 8558.2 9894.7 10054.5 10127.2 10197.5 10272.5 7926.2 7927.8 7943.9 7994.2 8041.0 7712.0 7760.0 7777.0 7800.1 7845.6 8935.6 8996.3 9113.8 9123.9 9154.6 9153.5 9365.5 9405.8 9428.0 9490.7 7225.2 7287.5 7291.4 7295.5 7299.0 7547.1 7745.7 7766.4 7773.4 7817.4 7493.6 7512.0 7531.5 7541.7 7586.0 7339.0 7372.5 7406.9 7503.1 7516.9 7374.9 7486.6 7504.8 7511.2 7522.8 6829.8 6832.2 6851.1 6863.2 6875.7 6888.8 6910.4 6925.7 6936.1 6953.7 15:42:11 INFO - 2015-11-20 15:42:11,360 DEBUG : BROWSER_OUTPUT: 15:42:11 INFO - 2015-11-20 15:42:11,360 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5865.24 Median:6690.47 stddev:1923.24 (28.7%) stddev-sans-first:1882.17 15:42:11 INFO - 2015-11-20 15:42:11,361 DEBUG : BROWSER_OUTPUT: Values: 266.8 319.6 326.6 329.8 339.3 5891.0 6438.7 6776.2 6906.3 6921.3 5151.7 6761.0 6778.9 6804.7 6815.4 4918.1 4927.8 4934.1 4943.6 4947.9 4918.3 4929.4 4938.2 4940.5 4955.5 4726.3 4880.4 4895.7 4902.0 4914.2 4894.5 4898.3 4915.8 4918.6 4925.1 4029.5 4106.8 4118.8 4138.8 4146.0 6364.9 6384.3 6458.7 6470.5 6497.1 4675.8 5222.5 5251.1 5761.0 5791.4 6909.1 7144.7 7170.4 7174.4 7189.8 3808.4 3834.4 4613.5 4624.7 4644.7 5442.7 7401.0 7536.5 7551.0 7660.0 4670.9 4688.3 4697.7 4701.1 4713.0 4678.5 4793.7 4803.8 4811.1 4834.1 5756.4 5790.8 5798.5 5806.3 5821.6 7256.9 7284.7 7287.0 7294.6 7299.5 1612.5 1642.4 1673.7 1681.2 1686.1 1047.4 1063.8 1069.1 1074.2 1083.1 6818.1 6821.6 6831.4 6859.4 6885.8 7529.3 7564.5 7569.5 7579.3 7581.3 6620.0 6840.3 6844.6 6845.0 6866.3 3420.7 3897.7 3906.0 3973.5 3991.9 7672.6 7699.6 7833.9 7959.4 7959.9 7753.8 7835.9 7858.2 7881.2 7902.6 6407.6 7788.0 7971.6 7983.6 8004.2 7650.7 7663.2 7665.9 7675.8 7691.2 7305.0 7509.7 7511.7 7514.7 7517.0 7942.7 7973.6 7977.8 7984.9 7996.4 4866.5 4924.1 4926.7 4928.3 4957.4 5544.9 7390.9 7524.5 7533.0 7561.7 5849.1 5887.6 6277.2 6891.7 7264.4 7258.0 7258.5 7266.5 7276.2 7292.0 6840.2 7046.9 7053.0 7056.7 7076.0 7292.6 7300.1 7322.6 7346.5 7368.9 5796.3 7141.0 7157.4 7164.1 7168.1 15:42:11 INFO - 2015-11-20 15:42:11,361 DEBUG : BROWSER_OUTPUT: 15:42:11 INFO - 2015-11-20 15:42:11,361 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19103.72 Median:54458.59 stddev:27383.12 (50.3%) stddev-sans-first:27425.26 15:42:11 INFO - 2015-11-20 15:42:11,362 DEBUG : BROWSER_OUTPUT: Values: 748.6 776.5 793.3 793.4 863.9 14919.9 15074.9 15272.2 15294.0 15364.3 15670.7 15716.5 15826.0 15836.0 15898.4 649.4 780.3 941.2 963.0 963.2 936.8 946.8 951.1 961.2 964.1 979.3 986.9 987.7 991.7 996.8 978.4 980.7 983.7 987.7 996.7 731.3 735.7 740.3 741.5 742.1 15336.2 15405.2 15423.0 15423.5 15539.3 12240.1 12270.2 12342.9 12349.6 12426.1 9914.3 10138.9 10260.3 10298.1 10303.7 3463.8 3511.8 3561.0 3598.3 3710.0 75441.6 76272.2 76809.0 79622.0 79994.2 8212.5 9373.8 9561.7 9574.6 10062.2 18550.2 21145.5 21458.2 21594.5 21807.9 7452.7 7498.7 7697.7 7772.2 7854.8 4131.5 4146.4 4173.3 4183.7 4183.8 3537.4 3540.7 3555.9 3592.0 3594.6 640.5 645.0 651.7 674.0 675.1 415.6 496.6 517.5 518.2 521.2 8602.2 8738.4 8744.3 8865.2 8917.0 593.8 631.8 633.7 634.2 644.4 3835.2 4108.2 4152.9 4179.5 4187.8 104002.0 104543.0 104572.0 104751.0 104958.0 64689.0 73775.0 87740.0 88803.1 89392.0 74239.0 75227.6 76586.0 77264.0 77397.6 8323.2 8342.7 8619.7 8631.3 9061.2 41498.0 54395.5 54521.7 54978.0 55085.0 69553.0 69833.0 70220.6 74958.0 75313.6 11041.4 11152.9 11214.4 11409.4 12104.6 11794.6 12070.9 12237.8 12824.0 12953.5 11273.5 11357.4 11364.2 11491.2 12451.1 11392.9 11421.8 11754.8 11820.9 12409.3 11426.0 11862.8 11873.1 11900.6 11902.5 8355.7 10169.8 10191.6 10226.8 10849.1 8004.9 8051.6 9141.5 9589.7 9707.0 15:42:11 INFO - 2015-11-20 15:42:11,362 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:42:11 INFO - 2015-11-20 15:42:11,362 DEBUG : BROWSER_OUTPUT: 15:42:11 INFO - 2015-11-20 15:42:11,732 INFO : Browser exited with error code: 0 15:42:11 INFO - 2015-11-20 15:42:11,758 INFO : Completed test dromaeo_css (00:18:29) 15:42:11 INFO - 2015-11-20 15:42:11,758 INFO : Starting test kraken 15:42:11 INFO - 2015-11-20 15:42:11,758 DEBUG : operating with platform_type : mac_ 15:42:11 INFO - 2015-11-20 15:42:11,758 INFO : Initialising browser for kraken test... 15:42:11 INFO - 2015-11-20 15:42:11,771 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmp7lYr7U/profile http://localhost:49269/getInfo.html 15:42:14 INFO - 2015-11-20 15:42:14,289 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:42:14 INFO - 2015-11-20 15:42:14,289 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:42:14 INFO - 2015-11-20 15:42:14,290 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:42:14 INFO - 2015-11-20 15:42:14,290 DEBUG : BROWSER_OUTPUT: __metrics 15:42:14 INFO - 2015-11-20 15:42:14,857 INFO : Browser initialized. 15:42:14 INFO - 2015-11-20 15:42:14,858 INFO : Running cycle 1/1 for kraken test... 15:42:14 INFO - 2015-11-20 15:42:14,858 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmp7lYr7U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:42:26 INFO - 2015-11-20 15:42:26,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 236773376 15:42:26 INFO - 2015-11-20 15:42:26,715 DEBUG : BROWSER_OUTPUT: 15:42:29 INFO - 2015-11-20 15:42:29,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 15:42:30 INFO - 2015-11-20 15:42:30,268 DEBUG : BROWSER_OUTPUT: RSS: Main: 247963648 15:42:30 INFO - 2015-11-20 15:42:30,268 DEBUG : BROWSER_OUTPUT: 15:42:32 INFO - 2015-11-20 15:42:32,794 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 15:42:33 INFO - 2015-11-20 15:42:33,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 258387968 15:42:33 INFO - 2015-11-20 15:42:33,400 DEBUG : BROWSER_OUTPUT: 15:42:37 INFO - 2015-11-20 15:42:37,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 15:42:37 INFO - 2015-11-20 15:42:37,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 262488064 15:42:37 INFO - 2015-11-20 15:42:37,599 DEBUG : BROWSER_OUTPUT: 15:42:39 INFO - 2015-11-20 15:42:39,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 15:42:40 INFO - 2015-11-20 15:42:40,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 262500352 15:42:40 INFO - 2015-11-20 15:42:40,042 DEBUG : BROWSER_OUTPUT: 15:42:42 INFO - 2015-11-20 15:42:42,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:42:42 INFO - 2015-11-20 15:42:42,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 263122944 15:42:42 INFO - 2015-11-20 15:42:42,687 DEBUG : BROWSER_OUTPUT: 15:42:45 INFO - 2015-11-20 15:42:45,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 15:42:46 INFO - 2015-11-20 15:42:46,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 264830976 15:42:46 INFO - 2015-11-20 15:42:46,213 DEBUG : BROWSER_OUTPUT: 15:42:49 INFO - 2015-11-20 15:42:49,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 15:42:49 INFO - 2015-11-20 15:42:49,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 264851456 15:42:49 INFO - 2015-11-20 15:42:49,943 DEBUG : BROWSER_OUTPUT: 15:42:52 INFO - 2015-11-20 15:42:52,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 15:42:53 INFO - 2015-11-20 15:42:53,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 263061504 15:42:53 INFO - 2015-11-20 15:42:53,506 DEBUG : BROWSER_OUTPUT: 15:42:55 INFO - 2015-11-20 15:42:55,009 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:42:55 INFO - 2015-11-20 15:42:55,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 264589312 15:42:55 INFO - 2015-11-20 15:42:55,591 DEBUG : BROWSER_OUTPUT: 15:42:57 INFO - 2015-11-20 15:42:57,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:42:57 INFO - 2015-11-20 15:42:57,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 263933952 15:42:57 INFO - 2015-11-20 15:42:57,981 DEBUG : BROWSER_OUTPUT: 15:43:00 INFO - 2015-11-20 15:43:00,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:43:00 INFO - 2015-11-20 15:43:00,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 264392704 15:43:00 INFO - 2015-11-20 15:43:00,714 DEBUG : BROWSER_OUTPUT: 15:43:03 INFO - 2015-11-20 15:43:03,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:43:03 INFO - 2015-11-20 15:43:03,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 264253440 15:43:03 INFO - 2015-11-20 15:43:03,846 DEBUG : BROWSER_OUTPUT: 15:43:06 INFO - 2015-11-20 15:43:06,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:43:07 INFO - 2015-11-20 15:43:07,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 264634368 15:43:07 INFO - 2015-11-20 15:43:07,050 DEBUG : BROWSER_OUTPUT: 15:43:08 INFO - 2015-11-20 15:43:08,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 15:43:09 INFO - 2015-11-20 15:43:09,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 264560640 15:43:09 INFO - 2015-11-20 15:43:09,133 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,136 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:43:09 INFO - 2015-11-20 15:43:09,136 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:43:09 INFO - 2015-11-20 15:43:09,136 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:43:09 INFO - 2015-11-20 15:43:09,137 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:43:09 INFO - 2015-11-20 15:43:09,137 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;108;114;113;114;125;156;168;167;115 15:43:09 INFO - 2015-11-20 15:43:09,137 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;138;120;142;151;120;155;165;120;152;121 15:43:09 INFO - 2015-11-20 15:43:09,137 DEBUG : BROWSER_OUTPUT: |2;audio-dft;278;253;202;249;266;196;192;222;240;277 15:43:09 INFO - 2015-11-20 15:43:09,137 DEBUG : BROWSER_OUTPUT: |3;audio-fft;59;62;68;114;56;56;62;58;93;93 15:43:09 INFO - 2015-11-20 15:43:09,137 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;75;76;107;75;103;113;134;89;78;105 15:43:09 INFO - 2015-11-20 15:43:09,137 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;122;76;106;86;134;133;121;86;87;88 15:43:09 INFO - 2015-11-20 15:43:09,137 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;124;110;152;150;95;95;127;106;107;153 15:43:09 INFO - 2015-11-20 15:43:09,137 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;110;121;89;127;153;90;92;90;105;139 15:43:09 INFO - 2015-11-20 15:43:09,137 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;59;59;59;58;59;67;58;59 15:43:09 INFO - 2015-11-20 15:43:09,137 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;66;67;67;66;68;68;69;68;71 15:43:09 INFO - 2015-11-20 15:43:09,137 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;87;82;84;80;103;107;110;82 15:43:09 INFO - 2015-11-20 15:43:09,138 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;124;129;127;125;137;117;139;114;125 15:43:09 INFO - 2015-11-20 15:43:09,138 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;144;143;155;183;137;178;177;178;128 15:43:09 INFO - 2015-11-20 15:43:09,138 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;80;95;94;95;90;89;93;68;72 15:43:09 INFO - 2015-11-20 15:43:09,138 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:43:09 INFO - 2015-11-20 15:43:09,138 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:43:09 INFO - 2015-11-20 15:43:09,138 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,819 15:43:09 INFO - 2015-11-20 15:43:09,138 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:43:09 INFO - 2015-11-20 15:43:09,138 DEBUG : BROWSER_OUTPUT: __startTimestamp1448062989134__endTimestamp 15:43:09 INFO - 2015-11-20 15:43:09,138 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,142 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:43:09 INFO - 2015-11-20 15:43:09,142 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:43:09 INFO - 2015-11-20 15:43:09,142 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,143 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:129.50 Median:120.00 stddev:24.14 (20.1%) stddev-sans-first:25.03 15:43:09 INFO - 2015-11-20 15:43:09,143 DEBUG : BROWSER_OUTPUT: Values: 115.0 108.0 114.0 113.0 114.0 125.0 156.0 168.0 167.0 115.0 15:43:09 INFO - 2015-11-20 15:43:09,143 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,143 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:138.40 Median:146.50 stddev:17.19 (11.7%) stddev-sans-first:18.23 15:43:09 INFO - 2015-11-20 15:43:09,144 DEBUG : BROWSER_OUTPUT: Values: 138.0 120.0 142.0 151.0 120.0 155.0 165.0 120.0 152.0 121.0 15:43:09 INFO - 2015-11-20 15:43:09,144 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,144 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:237.50 Median:251.00 stddev:32.80 (13.1%) stddev-sans-first:31.35 15:43:09 INFO - 2015-11-20 15:43:09,144 DEBUG : BROWSER_OUTPUT: Values: 278.0 253.0 202.0 249.0 266.0 196.0 192.0 222.0 240.0 277.0 15:43:09 INFO - 2015-11-20 15:43:09,144 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,144 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:72.10 Median:62.00 stddev:20.38 (32.9%) stddev-sans-first:21.06 15:43:09 INFO - 2015-11-20 15:43:09,144 DEBUG : BROWSER_OUTPUT: Values: 59.0 62.0 68.0 114.0 56.0 56.0 62.0 58.0 93.0 93.0 15:43:09 INFO - 2015-11-20 15:43:09,144 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,144 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:95.50 Median:75.00 stddev:20.10 (26.8%) stddev-sans-first:19.90 15:43:09 INFO - 2015-11-20 15:43:09,144 DEBUG : BROWSER_OUTPUT: Values: 75.0 76.0 107.0 75.0 103.0 113.0 134.0 89.0 78.0 105.0 15:43:09 INFO - 2015-11-20 15:43:09,144 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,145 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:103.90 Median:81.00 stddev:21.95 (27.1%) stddev-sans-first:22.28 15:43:09 INFO - 2015-11-20 15:43:09,145 DEBUG : BROWSER_OUTPUT: Values: 122.0 76.0 106.0 86.0 134.0 133.0 121.0 86.0 87.0 88.0 15:43:09 INFO - 2015-11-20 15:43:09,145 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,145 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:121.90 Median:151.00 stddev:22.99 (15.2%) stddev-sans-first:24.37 15:43:09 INFO - 2015-11-20 15:43:09,145 DEBUG : BROWSER_OUTPUT: Values: 124.0 110.0 152.0 150.0 95.0 95.0 127.0 106.0 107.0 153.0 15:43:09 INFO - 2015-11-20 15:43:09,145 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,145 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:111.60 Median:121.00 stddev:22.77 (18.8%) stddev-sans-first:24.14 15:43:09 INFO - 2015-11-20 15:43:09,145 DEBUG : BROWSER_OUTPUT: Values: 110.0 121.0 89.0 127.0 153.0 90.0 92.0 90.0 105.0 139.0 15:43:09 INFO - 2015-11-20 15:43:09,145 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,146 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.60 Median:59.00 stddev:2.63 (4.5%) stddev-sans-first:2.78 15:43:09 INFO - 2015-11-20 15:43:09,146 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 59.0 59.0 59.0 58.0 59.0 67.0 58.0 59.0 15:43:09 INFO - 2015-11-20 15:43:09,146 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,147 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:1.58 (2.3%) stddev-sans-first:1.56 15:43:09 INFO - 2015-11-20 15:43:09,147 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 67.0 67.0 66.0 68.0 68.0 69.0 68.0 71.0 15:43:09 INFO - 2015-11-20 15:43:09,147 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,147 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:82.50 stddev:11.62 (14.1%) stddev-sans-first:12.11 15:43:09 INFO - 2015-11-20 15:43:09,147 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 87.0 82.0 84.0 80.0 103.0 107.0 110.0 82.0 15:43:09 INFO - 2015-11-20 15:43:09,147 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,147 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:126.00 stddev:7.86 (6.2%) stddev-sans-first:8.14 15:43:09 INFO - 2015-11-20 15:43:09,148 DEBUG : BROWSER_OUTPUT: Values: 121.0 124.0 129.0 127.0 125.0 137.0 117.0 139.0 114.0 125.0 15:43:09 INFO - 2015-11-20 15:43:09,148 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,148 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:166.00 stddev:20.25 (12.2%) stddev-sans-first:21.09 15:43:09 INFO - 2015-11-20 15:43:09,148 DEBUG : BROWSER_OUTPUT: Values: 146.0 144.0 143.0 155.0 183.0 137.0 178.0 177.0 178.0 128.0 15:43:09 INFO - 2015-11-20 15:43:09,148 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,148 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.80 Median:91.50 stddev:10.74 (11.7%) stddev-sans-first:10.34 15:43:09 INFO - 2015-11-20 15:43:09,148 DEBUG : BROWSER_OUTPUT: Values: 72.0 80.0 95.0 94.0 95.0 90.0 89.0 93.0 68.0 72.0 15:43:09 INFO - 2015-11-20 15:43:09,148 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:43:09 INFO - 2015-11-20 15:43:09,148 DEBUG : BROWSER_OUTPUT: 15:43:09 INFO - 2015-11-20 15:43:09,750 INFO : Browser exited with error code: 0 15:43:09 INFO - 2015-11-20 15:43:09,794 INFO : Completed test kraken (00:00:58) 15:43:09 INFO - 2015-11-20 15:43:09,794 INFO : Starting test v8_7 15:43:09 INFO - 2015-11-20 15:43:09,794 DEBUG : operating with platform_type : mac_ 15:43:09 INFO - 2015-11-20 15:43:09,795 INFO : Initialising browser for v8_7 test... 15:43:09 INFO - 2015-11-20 15:43:09,807 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpjjxPHK/profile http://localhost:49269/getInfo.html 15:43:12 INFO - 2015-11-20 15:43:12,533 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:43:12 INFO - 2015-11-20 15:43:12,533 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:43:12 INFO - 2015-11-20 15:43:12,533 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:43:12 INFO - 2015-11-20 15:43:12,533 DEBUG : BROWSER_OUTPUT: __metrics 15:43:13 INFO - 2015-11-20 15:43:13,086 INFO : Browser initialized. 15:43:13 INFO - 2015-11-20 15:43:13,086 INFO : Running cycle 1/1 for v8_7 test... 15:43:13 INFO - 2015-11-20 15:43:13,087 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpjjxPHK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:43:24 INFO - 2015-11-20 15:43:24,911 DEBUG : BROWSER_OUTPUT: RSS: Main: 237441024 15:43:24 INFO - 2015-11-20 15:43:24,911 DEBUG : BROWSER_OUTPUT: 15:43:46 INFO - 2015-11-20 15:43:46,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/v8_7/run.html (next: http://localhost:49269/tests/v8_7/run.html) 15:43:46 INFO - 2015-11-20 15:43:46,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 248578048 15:43:46 INFO - 2015-11-20 15:43:46,566 DEBUG : BROWSER_OUTPUT: 15:43:46 INFO - 2015-11-20 15:43:46,566 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:43:46 INFO - 2015-11-20 15:43:46,566 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:43:46 INFO - 2015-11-20 15:43:46,566 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:43:46 INFO - 2015-11-20 15:43:46,566 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:43:46 INFO - 2015-11-20 15:43:46,566 DEBUG : BROWSER_OUTPUT: |0;Richards;148.5001485001485 15:43:46 INFO - 2015-11-20 15:43:46,566 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;156.7889620570712 15:43:46 INFO - 2015-11-20 15:43:46,566 DEBUG : BROWSER_OUTPUT: |2;Encrypt;287.0264064293915 15:43:46 INFO - 2015-11-20 15:43:46,567 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4761.9047619047615 15:43:46 INFO - 2015-11-20 15:43:46,567 DEBUG : BROWSER_OUTPUT: |4;RayTrace;947.8672985781991 15:43:46 INFO - 2015-11-20 15:43:46,567 DEBUG : BROWSER_OUTPUT: |5;Earley;740.1924500370096 15:43:46 INFO - 2015-11-20 15:43:46,567 DEBUG : BROWSER_OUTPUT: |6;Boyer;12600 15:43:46 INFO - 2015-11-20 15:43:46,567 DEBUG : BROWSER_OUTPUT: |7;RegExp;26500 15:43:46 INFO - 2015-11-20 15:43:46,567 DEBUG : BROWSER_OUTPUT: |8;Splay;668.8963210702341 15:43:46 INFO - 2015-11-20 15:43:46,567 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4529.411764705882 15:43:46 INFO - 2015-11-20 15:43:46,567 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:43:46 INFO - 2015-11-20 15:43:46,567 DEBUG : BROWSER_OUTPUT: __startTimestamp1448063026565__endTimestamp 15:43:46 INFO - 2015-11-20 15:43:46,567 DEBUG : BROWSER_OUTPUT: 15:43:46 INFO - 2015-11-20 15:43:46,568 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:43:46 INFO - 2015-11-20 15:43:46,568 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:43:46 INFO - 2015-11-20 15:43:46,569 DEBUG : BROWSER_OUTPUT: 15:43:46 INFO - 2015-11-20 15:43:46,569 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:148.50 Median:148.50 stddev:0.00 (0.0%) 15:43:46 INFO - 2015-11-20 15:43:46,569 DEBUG : BROWSER_OUTPUT: Values: 148.5 15:43:46 INFO - 2015-11-20 15:43:46,569 DEBUG : BROWSER_OUTPUT: 15:43:46 INFO - 2015-11-20 15:43:46,569 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:156.79 Median:156.79 stddev:0.00 (0.0%) 15:43:46 INFO - 2015-11-20 15:43:46,569 DEBUG : BROWSER_OUTPUT: Values: 156.8 15:43:46 INFO - 2015-11-20 15:43:46,569 DEBUG : BROWSER_OUTPUT: 15:43:46 INFO - 2015-11-20 15:43:46,569 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:287.03 Median:287.03 stddev:0.00 (0.0%) 15:43:46 INFO - 2015-11-20 15:43:46,569 DEBUG : BROWSER_OUTPUT: Values: 287.0 15:43:46 INFO - 2015-11-20 15:43:46,569 DEBUG : BROWSER_OUTPUT: 15:43:46 INFO - 2015-11-20 15:43:46,569 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4761.90 Median:4761.90 stddev:0.00 (0.0%) 15:43:46 INFO - 2015-11-20 15:43:46,569 DEBUG : BROWSER_OUTPUT: Values: 4761.9 15:43:46 INFO - 2015-11-20 15:43:46,569 DEBUG : BROWSER_OUTPUT: 15:43:46 INFO - 2015-11-20 15:43:46,569 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:947.87 Median:947.87 stddev:0.00 (0.0%) 15:43:46 INFO - 2015-11-20 15:43:46,570 DEBUG : BROWSER_OUTPUT: Values: 947.9 15:43:46 INFO - 2015-11-20 15:43:46,570 DEBUG : BROWSER_OUTPUT: 15:43:46 INFO - 2015-11-20 15:43:46,570 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:740.19 Median:740.19 stddev:0.00 (0.0%) 15:43:46 INFO - 2015-11-20 15:43:46,570 DEBUG : BROWSER_OUTPUT: Values: 740.2 15:43:46 INFO - 2015-11-20 15:43:46,570 DEBUG : BROWSER_OUTPUT: 15:43:46 INFO - 2015-11-20 15:43:46,570 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12600.00 Median:12600.00 stddev:0.00 (0.0%) 15:43:46 INFO - 2015-11-20 15:43:46,570 DEBUG : BROWSER_OUTPUT: Values: 12600.0 15:43:46 INFO - 2015-11-20 15:43:46,570 DEBUG : BROWSER_OUTPUT: 15:43:46 INFO - 2015-11-20 15:43:46,570 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26500.00 Median:26500.00 stddev:0.00 (0.0%) 15:43:46 INFO - 2015-11-20 15:43:46,570 DEBUG : BROWSER_OUTPUT: Values: 26500.0 15:43:46 INFO - 2015-11-20 15:43:46,570 DEBUG : BROWSER_OUTPUT: 15:43:46 INFO - 2015-11-20 15:43:46,570 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:668.90 Median:668.90 stddev:0.00 (0.0%) 15:43:46 INFO - 2015-11-20 15:43:46,570 DEBUG : BROWSER_OUTPUT: Values: 668.9 15:43:46 INFO - 2015-11-20 15:43:46,570 DEBUG : BROWSER_OUTPUT: 15:43:46 INFO - 2015-11-20 15:43:46,571 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4529.41 Median:4529.41 stddev:0.00 (0.0%) 15:43:46 INFO - 2015-11-20 15:43:46,571 DEBUG : BROWSER_OUTPUT: Values: 4529.4 15:43:46 INFO - 2015-11-20 15:43:46,571 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:43:46 INFO - 2015-11-20 15:43:46,571 DEBUG : BROWSER_OUTPUT: 15:43:47 INFO - 2015-11-20 15:43:47,150 INFO : Browser exited with error code: 0 15:43:47 INFO - 2015-11-20 15:43:47,168 INFO : Completed test v8_7 (00:00:37) 15:43:47 INFO - 2015-11-20 15:43:47,627 INFO : Completed test suite (00:20:05) 15:43:47 INFO - 2015-11-20 15:43:47,627 DEBUG : Working with test: dromaeo_css 15:43:47 INFO - 2015-11-20 15:43:47,627 DEBUG : Generating results file: dromaeo_css 15:43:47 INFO - 2015-11-20 15:43:47,628 DEBUG : Working with test: kraken 15:43:47 INFO - 2015-11-20 15:43:47,628 DEBUG : Generating results file: kraken 15:43:47 INFO - 2015-11-20 15:43:47,628 INFO : javascript benchmark 15:43:47 INFO - 2015-11-20 15:43:47,628 DEBUG : Working with test: v8_7 15:43:47 INFO - 2015-11-20 15:43:47,628 DEBUG : Generating results file: v8_7 15:43:47 INFO - 2015-11-20 15:43:47,629 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:43:48 INFO - 2015-11-20 15:43:48,107 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 15:43:48 INFO - 2015-11-20 15:43:48,107 DEBUG : process_Request line: dromaeo_css 7683.47 graph.html#tests=[[72,1,61]] 15:43:48 INFO - 2015-11-20 15:43:48,107 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:43:48 INFO - 2015-11-20 15:43:48,135 DEBUG : process_Request line: kraken 1595.30 graph.html#tests=[[232,1,61]] 15:43:48 INFO - 2015-11-20 15:43:48,135 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:43:48 INFO - 2015-11-20 15:43:48,163 DEBUG : process_Request line: v8_7 22086.92 graph.html#tests=[[230,1,61]] 15:43:48 INFO - 2015-11-20 15:43:48,164 INFO : javascript benchmark 15:43:48 INFO - 2015-11-20 15:43:48,166 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2911.708829117088, 3520.119970007498, 3536.1336472564226, 3569.1434055826603, 3576.695980841628, 5860.384659610738, 5868.765249390025, 5919.260092488439, 5926.170336152942, 5971.88056238876, 5609.859753506164, 5711.343195532515, 5742.942570574293, 5805.954928112938, 5935.584509084366, 5256.369235691723, 5266.210068489738, 5352.892942141155, 5400.459954004607, 5404.810831620894, 5404.675719456825, 5431.21247419124, 5437.075697131497, 5466.34403871534, 5483.067878460672, 4507.211238033331, 5153.871153221162, 5157.974210128963, 5281.630285879952, 5365.222042803791, 5292.655977361459, 5294.841154765363, 5308.495692909168, 5311.521963023347, 5319.654222475527, 5301.257823904656, 5304.098303288451, 5323.946760532383, 5324.41431442541, 5404.702741349224, 4516.909661806745, 5495.945040549584, 5692.861427714473, 5769.423057694239, 5834.212381328509, 6301.527385446064, 6305.905411418832, 6359.42765151134, 6359.586626869239, 6376.330485299023, 6331.588446750947, 6332.4934005279465, 6333.1450254216015, 6349.0, 6360.840978975516, 5761.337446193657, 5849.268841394868, 5919.319278283009, 5989.520838332923, 6056.063558686801, 6359.904601430982, 6412.134361861183, 6462.709178086998, 6463.6768161591735, 6472.741090356333, 6064.272287325461, 6309.0, 6323.177986861679, 6349.746010159634, 6355.0785136155, 5188.844334669966, 6143.416375444325, 6266.530010249249, 6306.968465157736, 6341.4609758170145, 6289.7169627366875, 6307.747690092437, 6331.461825744771, 6339.904901426482, 6349.238091429058, 6133.48768512239, 6277.2781130170615, 6341.334159913143, 6345.302016778151, 6346.936530634634, 4880.170371036932, 4938.604911607063, 4950.4059512858685, 4958.801647934114, 4989.60083193351, 4519.525449827786, 4529.456465224194, 4531.84138555149, 4536.77316134192, 4585.70192937458, 5742.885142297131, 5856.970715146397, 5928.644281343047, 6076.0, 6092.543059270483, 6184.381561843779, 6293.905591416133, 6294.874102517924, 6305.8649443100685, 6321.715522801485, 5986.491148252448, 6023.909641355383, 6036.405175196766, 6037.818865434044, 6075.696215189311, 5240.895182096337, 5363.329583802025, 5456.345238571397, 5538.667679939216, 5551.306086739158, 6280.089387038854, 6363.490920726238, 6376.458001069961, 6377.266614339411, 6406.519511036598, 6290.24517057956, 6332.746690132527, 6346.143270658402, 6375.553711240169, 6377.0, 6264.467520260829, 6291.622502649856, 6446.033095035595, 6452.096706461193, 6515.641639709862, 6327.936720632735, 6330.493560515056, 6341.714622841891, 6352.936470635419, 6364.172657554488, 6328.715207815567, 6333.145025421509, 6341.492680585634, 6349.174607301206, 6349.809505714836, 5880.529557635294, 6129.236538068469, 6220.564560480723, 6233.283172435228, 6289.7484100635465, 6236.251649802053, 6260.499160067093, 6328.936710632835, 6336.524760642878, 6345.460635846005, 6001.639901605918, 6135.417135372132, 6201.906971395342, 6202.596831206138, 6239.968800156152, 5243.318368612056, 5697.202391665087, 6103.23709536308, 6186.845328866814, 6239.220097487814, 5056.317397151484, 6159.568830182024, 6211.844703882439, 6214.8135555933395, 6220.906686399617], "unit": "ms", "name": "dojo.html", "value": 5789.868643188455}, {"lowerIsBetter": false, "replicates": [529.6213207556597, 566.8441178675862, 570.5036618142217, 601.2064075420446, 630.977915772948, 41083.0, 41345.0, 41357.58642413575, 41433.17133657329, 41500.79249603752, 39722.0, 42628.78685606575, 44933.775331123295, 45378.773106134424, 45653.086938261295, 9812.313138080337, 9914.157296629759, 9987.101160895518, 9989.250806189528, 10004.799904001951, 9754.170895473893, 9876.209903207726, 9876.802463950717, 9882.703518894408, 9915.553800079013, 9859.753506162368, 9929.3545919515, 9940.055694709028, 9964.501774911261, 9973.152282056033, 9872.062154095349, 9876.999999999964, 9937.25470589705, 9952.0, 9988.600455981752, 9682.419054856731, 9831.655892043744, 9833.213342932548, 9841.55712992917, 9852.211823054138, 41656.79171604153, 41741.58258417438, 41885.95285117866, 42110.57889421097, 42215.57784422147, 3097.2877534938066, 3110.6111736032994, 3185.729213016896, 3240.756943229267, 3377.9324413511836, 20376.0, 27213.86393068022, 28760.137195884156, 29188.27029324284, 30351.848240758656, 2799.1322689965973, 2827.2507785436874, 2865.5988161657383, 2888.7111288871156, 2890.2918784897834, 517190.0, 522962.3851880754, 523121.3843930756, 523266.0, 524235.0, 59639.0, 60522.092168617506, 69845.0, 70455.2954470459, 73057.6347118261, 71982.28017719756, 72269.63865180641, 72895.63552182312, 72920.63539682268, 72988.63505682438, 16663.00021998684, 16704.58238544022, 16721.331146753993, 16937.745933811002, 16975.660486790443, 12513.74972500545, 12634.747305053848, 12733.29966851832, 12772.489100435878, 12778.488860445665, 21908.45228869291, 21975.2308669199, 21988.01053952576, 22256.777432225794, 22317.55364892693, 9074.45553266793, 9355.251579873593, 9565.808683826284, 9626.422414655142, 9642.71071867845, 966.2221911361281, 982.3565564555228, 990.4156547636928, 1021.9284650074572, 1143.7941170589374, 30198.245043873638, 30296.84851575728, 30452.53555351964, 30501.0, 30732.846335768627, 902.8781114549583, 1061.7027232374946, 1087.8857719939451, 1118.3345909184022, 1200.477792160413, 14969.925150374178, 14970.0, 15269.923650381677, 15270.847291527165, 17329.046902420236, 544329.0, 653880.0, 670472.0, 672518.0, 672863.0, 67213.32786672168, 67513.0, 67564.6621766888, 67836.6608166956, 68201.65899170472, 1203.506562309449, 1369.6370461827623, 1508.8868334874928, 1515.6059424549476, 1520.3538496139097, 31859.0, 31967.840160799045, 32063.67936320607, 32456.35087298288, 32491.35017299688, 53891.92216155576, 53895.73052134871, 54116.45883541114, 54526.0, 54629.726851365485, 508246.0, 511549.0, 512119.0, 515344.0, 517106.0, 34913.65086349104, 47686.523134768206, 48143.75928120337, 48925.5107448921, 49129.0, 46007.76996114998, 46877.0, 47344.053118938114, 48040.0, 48392.758036211, 37534.81232593929, 39574.0, 39824.00439989023, 41638.791806040776, 42296.57703422927, 35410.645893540735, 39402.21195576015, 41485.0, 41619.16761664689, 42263.7886810564, 38128.0, 38521.422178667905, 38668.419973699856, 38674.71264942511, 40607.39088913728, 29949.15483029109, 34167.63329466793, 35850.820745896104, 36121.63878361183, 36678.26643467062, 25558.849851756342, 25569.48861022806, 25846.35384115337, 25927.197289674015, 25994.350141245865], "unit": "ms", "name": "ext.html", "value": 21011.587890146915}, {"lowerIsBetter": false, "replicates": [353.4239190120106, 363.26438961103764, 366.6828193612526, 367.06581749447645, 367.25997115811634, 16916.0, 18878.244870205177, 19677.60644787105, 20761.896190519044, 21261.893690531546, 17276.82723172768, 20223.191072357087, 20228.8988555057, 20473.590528189427, 20779.68830467544, 5149.356330458702, 5268.31511903452, 5303.15149576066, 5305.761240744157, 5311.442298558634, 3955.861544845931, 4082.7142100053006, 5229.973850130744, 5673.631213971079, 5754.482096611304, 5696.231008813798, 5785.942140578582, 5807.274090738658, 5829.09649004405, 5867.237259156325, 5712.171735098429, 5720.056190728525, 5734.913976290359, 5751.281089863767, 5772.5670574706855, 5227.581793456515, 5527.226188333637, 5532.3914369419335, 5533.3083364579425, 5535.142052981794, 12553.560625378159, 12878.549250776177, 12886.226826390353, 14345.928270358685, 25896.352591185183, 1983.6429442700307, 2001.4896201468532, 2155.2887547109417, 2237.8881055947136, 2270.852394594346, 9685.467299298536, 12191.695207619792, 14536.34586443602, 14827.481038163613, 15374.615634609112, 1691.8646508279307, 1710.2816816936916, 1724.8016478104928, 1737.218251786701, 1781.403229917979, 75240.0, 89952.0, 98147.50926245323, 98451.50774246083, 98854.0, 10849.294795838245, 11030.172737044753, 11112.888871111347, 11161.051310638524, 11222.438878056064, 12997.740045199043, 13042.347882605833, 13109.213447193199, 13129.474821007243, 13169.868301317056, 7110.893336599956, 8352.749417517483, 8460.534670593053, 8472.110428405053, 8547.74356769298, 7297.16082650502, 8443.155684431507, 8672.089430609822, 8693.695945608082, 8696.086910874394, 4261.296886013773, 4279.507856596531, 4310.719803212781, 4346.282863327516, 4358.8910277242685, 1822.098061459586, 1859.6466671332673, 1869.6728072587243, 1879.0322983663425, 1889.9622007560047, 853.7364700243675, 900.2887718702152, 924.9722508324761, 949.392388871123, 988.3378136648463, 19968.30110946139, 20234.494137646678, 20378.796212037985, 20498.282560110325, 20707.23988460998, 886.078478382475, 1001.5092604623682, 1007.7228762090484, 1015.1979935850595, 1026.8357062869904, 9977.750556236153, 10822.0, 10860.402677852637, 10936.726581835517, 10954.233203675667, 712342.0, 735412.0, 750770.0, 752477.0, 763909.0, 104212.95787042184, 108969.0, 131978.0, 133244.99999999805, 134254.65745342616, 1152.3028567716578, 1169.1582060916128, 1179.2040372748531, 1196.7247533067443, 1201.3692811274152, 18588.535286617942, 18675.066246687882, 19330.4200873974, 19405.902970485058, 19824.70262946086, 48238.0, 48430.27354589613, 48839.0, 49138.262926055424, 52758.472415275355, 70642.64678676573, 74816.62591687006, 76451.23548764442, 77119.0, 77568.0, 9531.857022144812, 9602.08780165883, 9812.460314682761, 9959.103680668484, 9982.151517121127, 11494.252873563191, 11749.88250117488, 19360.225590976766, 19594.706079408534, 20653.793462065787, 15795.921020394824, 15931.601709957344, 16118.67762644764, 16158.0, 16539.91730041342, 15209.391624335345, 15313.693726125637, 15677.0, 15765.527034188992, 15790.21048947571, 15440.613984650474, 16558.840881138203, 16718.247678854237, 17011.829881701025, 17043.65912681764, 8787.560621968749, 9803.313768036169, 9910.504474776377, 9956.054174853378, 10110.887802341884, 15851.207439628202, 15871.841281587036, 15998.9200053999, 16447.342106315613, 16511.256993435083], "unit": "ms", "name": "jquery.html", "value": 9862.907302653746}, {"lowerIsBetter": false, "replicates": [1368.3431952662716, 1548.3419546692653, 1662.2769095443475, 1889.8393636540893, 1912.4167129025648, 5766.423357664232, 7043.964780176098, 7056.717731290749, 7560.886586701204, 7650.846983060335, 8073.798155046126, 8202.302804261644, 8280.089190189074, 8316.584170791466, 8324.33405327574, 2345.108858633717, 2395.880205989702, 2396.8082553395775, 2403.0868270057354, 2409.036385445827, 2397.436602398435, 2417.8549287042833, 2450.9583427043526, 2456.5701002324613, 2463.1132792194794, 2366.2782851230368, 2392.222527678503, 2409.5662780699467, 2417.0694282701197, 2424.3939015246187, 2066.5040390306367, 2358.9764102358927, 2386.9283921482383, 2413.9758602414013, 2419.407245224931, 2094.465911192636, 2112.5035616630234, 2121.809037186645, 2128.595566842295, 2138.037882952662, 8418.368622353286, 8438.156184381513, 8442.366822488339, 8467.407281490237, 8481.448705834102, 4681.836135735233, 5124.282600435942, 5240.292560504321, 5249.4750524947585, 5253.264542963988, 3231.88688395905, 3483.529723487322, 3488.3895318319446, 3557.964420355815, 3598.352296586613, 1015.3755440404173, 1025.8512515685259, 1050.0444595418132, 1072.7479042425102, 1079.373963101407, 11064.557417703201, 11079.944600277027, 11127.888721112848, 11148.888511114947, 11158.776824463546, 4688.968426946067, 4726.8109275628585, 4768.6661933665, 4785.928211076836, 4818.469968303484, 9675.984021677623, 9700.6119755209, 9712.125908668253, 9713.0, 9719.708408747749, 4535.546445355438, 5197.194434862602, 5223.738813059332, 5235.240890070919, 5272.815451459181, 4787.257975013878, 4795.544423279783, 4821.783019764119, 4824.107540105092, 4828.782704778293, 3886.689064874803, 3888.902777430587, 3896.8246428910766, 3898.0314940955204, 3911.119998000427, 1246.2211118051218, 1285.556483013359, 1289.6582405662507, 1295.1452041652465, 1299.3957809618573, 1043.6973277749369, 1052.5000624703357, 1084.262701363065, 1386.2583517817918, 1409.901306908527, 7725.575093369918, 7863.33161681252, 7885.605719713992, 7931.2068793120225, 7932.603369831485, 487.76343473415363, 500.64204094072187, 504.14547342254525, 504.772852216504, 504.9065922804293, 5875.206847075676, 6126.908096378558, 6129.478994285536, 6170.043643235305, 6210.689465526705, 8263.710770123138, 8521.786955326043, 8539.188777066169, 8543.530105844115, 8558.186972237627, 9894.703158905244, 10054.547545360476, 10127.24045696561, 10197.490125493696, 10272.486375681186, 7926.24700653437, 7927.801804954922, 7943.92056079455, 7994.200579942076, 8041.035075790943, 7712.0, 7759.961200193963, 7777.0, 7800.102988156435, 7845.607719613882, 8935.642574297215, 8996.325275604488, 9113.77215569616, 9123.908760912305, 9154.633814647606, 9153.450792952444, 9365.484898330657, 9405.811883762422, 9428.0, 9490.715278541655, 7225.205227425085, 7287.526310789782, 7291.4166866649475, 7295.4528410368375, 7298.96350518244, 7547.132079810892, 7745.651445684845, 7766.378689704697, 7773.41699372538, 7817.37461003107, 7493.587852668155, 7512.023436953161, 7531.548107113591, 7541.7360392386, 7585.962070189614, 7339.0, 7372.520786148883, 7406.851862962602, 7503.09962804467, 7516.924830751623, 7374.926250737639, 7486.5508069516, 7504.812379690551, 7511.173770885089, 7522.774316770506, 6829.760958366433, 6832.214295356098, 6851.143607049119, 6863.245043045361, 6875.656217189021, 6888.827779305558, 6910.44716422695, 6925.68834402443, 6936.132983377078, 6953.68708408133], "unit": "ms", "name": "mootools.html", "value": 4636.4828110701255}, {"lowerIsBetter": false, "replicates": [266.7572509016795, 319.62124882014814, 326.6358010817938, 329.7576281433148, 339.3230505142242, 5891.0, 6438.710258038388, 6776.15298087739, 6906.274841141683, 6921.273266307035, 5151.74241287936, 6760.966195169017, 6778.932210677892, 6804.693788779505, 6815.352541508549, 4918.139325618021, 4927.753612319388, 4934.0625281196635, 4943.629227807911, 4947.872414861608, 4918.286848406979, 4929.383827021622, 4938.234573641073, 4940.456549779521, 4955.479674634165, 4726.291056341559, 4880.3655524781725, 4895.730734809584, 4901.975490122544, 4914.213725803854, 4894.486078961711, 4898.314236006961, 4915.778789954461, 4918.5573298403315, 4925.064237794808, 4029.49631296088, 4106.7946602669745, 4118.835246590133, 4138.793060347, 4146.004958809864, 6364.936350636481, 6384.265809431929, 6458.709358078898, 6470.514711396617, 6497.090407342976, 4675.766211689402, 5222.529972302473, 5251.133562962106, 5760.9711951440395, 5791.391903850077, 6909.1018167638385, 7144.678489467987, 7170.390516806077, 7174.354308112295, 7189.8202544936275, 3808.447775072599, 3834.4248362745534, 4613.492515823256, 4624.745638989854, 4644.744539050351, 5442.700651464168, 7401.0, 7536.4724469287175, 7551.018367612175, 7659.961700191519, 4670.883227919329, 4688.320193571913, 4697.718136911796, 4701.130290896127, 4713.0, 4678.461976872703, 4793.688410253322, 4803.807847686124, 4811.061842940663, 4834.105690447208, 5756.395578464285, 5790.826275211751, 5798.536117110621, 5806.274215723035, 5821.563382746311, 7256.8911466328045, 7284.745033923893, 7286.963565182246, 7294.598797066213, 7299.5255308404785, 1612.5243053299305, 1642.4251511970954, 1673.6652669466155, 1681.1762236504026, 1686.1400685650406, 1047.3611097230682, 1063.7553362726617, 1069.1072954083272, 1074.1782536359692, 1083.0577397663926, 6818.079559259536, 6821.556598821061, 6831.385175334244, 6859.416949559243, 6885.793426197222, 7529.284717951786, 7564.546127232384, 7569.545827250273, 7579.317861392501, 7581.3176814087, 6619.966900165468, 6840.281770414134, 6844.589324640438, 6845.007473916255, 6866.313368663094, 3420.743444241692, 3897.7271590988926, 3906.0, 3973.5033120859894, 3991.900202494961, 7672.616369181518, 7699.615019249015, 7833.882491762628, 7959.403044771665, 7959.920400796033, 7753.767386978399, 7835.882461763078, 7858.2141785822105, 7881.1724768899585, 7902.644381002869, 6407.615543067431, 7787.961060194776, 7971.561564113914, 7983.600819958979, 8004.159563245892, 7650.73222437212, 7663.233676632292, 7665.923340766521, 7675.808104797425, 7691.192424795316, 7304.96347518259, 7509.699612015458, 7511.699532018658, 7514.736984205527, 7517.0, 7942.6966179807205, 7973.561454120079, 7977.8404431912195, 7984.920150798418, 7996.3602911768085, 4866.48901865299, 4924.138275801649, 4926.729029903389, 4928.334674818853, 4957.429895561912, 5544.944550554443, 7390.889136663062, 7524.473286869867, 7533.0, 7561.735339263099, 5849.064149736022, 5887.61730487517, 6277.2153480814895, 6891.655417229219, 7264.418846492374, 7257.963710181415, 7258.491905566771, 7266.491345605757, 7276.235995220426, 7292.015577897128, 6840.2475727668925, 7046.894296585453, 7052.977318288717, 7056.717731290691, 7076.0, 7292.635368231461, 7300.087489063867, 7322.560646361236, 7346.52247603904, 7368.852622947618, 5796.275465566804, 7140.964295178491, 7157.355837974607, 7164.068671072727, 7168.139823221039], "unit": "ms", "name": "prototype.html", "value": 5219.049466588661}, {"lowerIsBetter": false, "replicates": [748.6107224243393, 776.5146783260462, 793.2820797178551, 793.3970182661176, 863.9222469977702, 14919.925400372997, 15074.924625376885, 15272.160031198307, 15293.999999999985, 15364.308606112723, 15670.686586268297, 15716.528504144866, 15825.971311864721, 15836.0, 15898.364065437368, 649.438235925923, 780.2626517940548, 941.1952780372802, 963.0177219236375, 963.1764841060897, 936.8360536906048, 946.820104180207, 951.1154626197633, 961.1877963121151, 964.1274646444944, 979.2704435195789, 986.921046316293, 987.6641941739807, 991.6826615483048, 996.8305388084007, 978.3738407419257, 980.7204946590223, 983.6606370802061, 987.6938149173743, 996.7209181429175, 731.3454458259828, 735.7498450526847, 740.2967181177903, 741.525423728814, 742.1391186224008, 15336.15651139187, 15405.22973851303, 15423.0, 15423.537293881202, 15539.30073146711, 12240.143189976705, 12270.202436841577, 12342.938285308606, 12349.567765128177, 12426.130170888042, 9914.305998580103, 10138.898611013869, 10260.281780275383, 10298.073173414428, 10303.742406439898, 3463.8441270142903, 3511.7541772075965, 3560.9821950890077, 3598.298331825295, 3709.962900370989, 75441.62279188569, 76272.23727762706, 76809.0, 79622.0, 79994.20005799926, 8212.548309842896, 9373.765655858659, 9561.713148605553, 9574.617015319449, 10062.19502439803, 18550.16524256412, 21145.519813613206, 21458.24896128628, 21594.460138496663, 21807.890960545414, 7452.664630091659, 7498.700051997859, 7697.653605587762, 7772.222777722295, 7854.803629909298, 4131.5248746394545, 4146.37804329353, 4173.269677806372, 4183.686223533247, 4183.769892655933, 3537.4163263061823, 3540.7344449166417, 3555.911102222465, 3592.0481072515804, 3594.6045934947133, 640.5228105061759, 644.9967750161313, 651.6611362091686, 673.9730410783513, 675.0785178231777, 415.6300892205939, 496.63497329462814, 517.506828904892, 518.2097301614992, 521.1999580643694, 8602.225799678059, 8738.38831281817, 8744.300455963508, 8865.246454051477, 8917.019127895926, 593.8248216776061, 631.7567736421511, 633.7401665317198, 634.1502386801708, 644.3813938618885, 3835.1946091321133, 4108.239975604463, 4152.896177595584, 4179.519355274182, 4187.832486700498, 104002.0, 104543.0, 104571.95428045775, 104751.0, 104958.0, 64689.0, 73775.0, 87740.0, 88803.11196888078, 89392.0, 74239.0, 75227.62386188035, 76586.0, 77264.0, 77397.61301193571, 8323.22869418135, 8342.708005219789, 8619.655213791379, 8631.26634236097, 9061.22979546746, 41498.0, 54395.45604543904, 54521.72739136279, 54978.0, 55085.0, 69553.0, 69833.0, 70220.59558808897, 74958.0, 75313.62343188249, 11041.44792760375, 11152.888471115184, 11214.439278036229, 11409.429528523375, 12104.636860894187, 11794.646160615195, 12070.939645301718, 12237.816432753694, 12824.0, 12953.54662586805, 11273.492692828679, 11357.432128393713, 11364.204505684524, 11491.195616307112, 12451.066170037102, 11392.94303528477, 11421.828672570084, 11754.823677645014, 11820.940895295813, 12409.255444673348, 11426.0, 11862.822057669315, 11873.109516786102, 11900.642980710592, 11902.523899043941, 8355.749327520183, 10169.796604068026, 10191.592336306761, 10226.795464090825, 10849.077828384676, 8004.919950800418, 8051.557164356017, 9141.497217653094, 9589.712308630753, 9707.029297070236], "unit": "ms", "name": "yui.html", "value": 7085.864995326386}], "name": "dromaeo_css", "value": 7683.4694491528635}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 108.0, 114.0, 113.0, 114.0, 125.0, 156.0, 168.0, 167.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 129.5}, {"lowerIsBetter": true, "replicates": [138.0, 120.0, 142.0, 151.0, 120.0, 155.0, 165.0, 120.0, 152.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 138.4}, {"lowerIsBetter": true, "replicates": [278.0, 253.0, 202.0, 249.0, 266.0, 196.0, 192.0, 222.0, 240.0, 277.0], "unit": "ms", "name": "audio-dft", "value": 237.5}, {"lowerIsBetter": true, "replicates": [59.0, 62.0, 68.0, 114.0, 56.0, 56.0, 62.0, 58.0, 93.0, 93.0], "unit": "ms", "name": "audio-fft", "value": 72.1}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 107.0, 75.0, 103.0, 113.0, 134.0, 89.0, 78.0, 105.0], "unit": "ms", "name": "audio-oscillator", "value": 95.5}, {"lowerIsBetter": true, "replicates": [122.0, 76.0, 106.0, 86.0, 134.0, 133.0, 121.0, 86.0, 87.0, 88.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 103.9}, {"lowerIsBetter": true, "replicates": [124.0, 110.0, 152.0, 150.0, 95.0, 95.0, 127.0, 106.0, 107.0, 153.0], "unit": "ms", "name": "imaging-darkroom", "value": 121.9}, {"lowerIsBetter": true, "replicates": [110.0, 121.0, 89.0, 127.0, 153.0, 90.0, 92.0, 90.0, 105.0, 139.0], "unit": "ms", "name": "imaging-desaturate", "value": 111.6}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 67.0, 58.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 67.0, 66.0, 68.0, 68.0, 69.0, 68.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 87.0, 82.0, 84.0, 80.0, 103.0, 107.0, 110.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 90.2}, {"lowerIsBetter": true, "replicates": [121.0, 124.0, 129.0, 127.0, 125.0, 137.0, 117.0, 139.0, 114.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [146.0, 144.0, 143.0, 155.0, 183.0, 137.0, 178.0, 177.0, 178.0, 128.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 156.9}, {"lowerIsBetter": true, "replicates": [72.0, 80.0, 95.0, 94.0, 95.0, 90.0, 89.0, 93.0, 68.0, 72.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 84.8}], "name": "kraken", "value": 1595.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [148.5001485001485], "unit": "score", "name": "Richards", "value": 237.72366800000006}, {"lowerIsBetter": false, "replicates": [156.7889620570712], "unit": "score", "name": "DeltaBlue", "value": 421.700604}, {"lowerIsBetter": false, "replicates": [287.0264064293915], "unit": "score", "name": "Encrypt", "value": 927.3746040000002}, {"lowerIsBetter": false, "replicates": [4761.9047619047615], "unit": "score", "name": "Decrypt", "value": 55.89801000000001}, {"lowerIsBetter": false, "replicates": [947.8672985781991], "unit": "score", "name": "RayTrace", "value": 780.6883950000001}, {"lowerIsBetter": false, "replicates": [740.1924500370096], "unit": "score", "name": "Earley", "value": 900.3915129999997}, {"lowerIsBetter": false, "replicates": [12600.0], "unit": "score", "name": "Boyer", "value": 52.89388888888888}, {"lowerIsBetter": false, "replicates": [26500.0], "unit": "score", "name": "RegExp", "value": 34.37679245283018}, {"lowerIsBetter": false, "replicates": [668.8963210702341], "unit": "score", "name": "Splay", "value": 121.82904500000001}, {"lowerIsBetter": false, "replicates": [4529.411764705882], "unit": "score", "name": "NavierStokes", "value": 327.63636363636374}], "name": "v8_7", "value": 22086.921527669387}]} 15:43:48 INFO - RETURN: dromaeo_css: 7683.47 15:43:48 INFO - RETURN: kraken: 1595.30 15:43:48 INFO - RETURN: v8_7: 22086.92 15:43:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,61]]", "result": "22086.92"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1595.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7683.47"}}} 15:43:48 INFO - Return code: 0 15:43:48 INFO - # TBPL SUCCESS # 15:43:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:43:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:43:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:43:48 INFO - 2015-11-20 15:43:48.263 screenresolution[1675:10970] starting screenresolution argv=screenresolution get 15:43:48 INFO - 2015-11-20 15:43:48.266 screenresolution[1675:10970] Display 0: 1600x1200x32@60 15:43:48 INFO - 2015-11-20 15:43:48.272 screenresolution[1676:10973] starting screenresolution argv=screenresolution list 15:43:48 INFO - Available Modes on Display 0 15:43:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:43:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:43:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:43:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:43:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:43:48 INFO - Intel Iris: 15:43:48 INFO - Chipset Model: Intel Iris 15:43:48 INFO - Type: GPU 15:43:48 INFO - Bus: Built-In 15:43:48 INFO - VRAM (Dynamic, Max): 1536 MB 15:43:48 INFO - Vendor: Intel (0x8086) 15:43:48 INFO - Device ID: 0x0a2e 15:43:48 INFO - Revision ID: 0x0009 15:43:48 INFO - Displays: 15:43:48 INFO - Display: 15:43:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:43:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:43:48 INFO - Display Serial Number: 1600x1200 60 15:43:48 INFO - Main Display: Yes 15:43:48 INFO - Mirror: Off 15:43:48 INFO - Online: Yes 15:43:48 INFO - Rotation: Supported 15:43:48 INFO - Return code: 0 15:43:48 INFO - Running post-action listener: _resource_record_post_action 15:43:48 INFO - Running post-run listener: _resource_record_post_run 15:43:49 INFO - Total resource usage - Wall time: 1237s; CPU: 54.0%; Read bytes: 33627648; Write bytes: 690006528; Read time: 350; Write time: 2515 15:43:49 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 336536064; Write bytes: 336967680; Read time: 26089; Write time: 1023 15:43:49 INFO - run-tests - Wall time: 1208s; CPU: 54.0%; Read bytes: 32706048; Write bytes: 342663680; Read time: 337; Write time: 1456 15:43:49 INFO - Running post-run listener: _upload_blobber_files 15:43:49 INFO - Blob upload gear active. 15:43:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:43:49 INFO - Copying logs to upload dir... 15:43:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.385346 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-20 15:43:49.625618) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 15:43:49.630421) ========= 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.Z9a9FnWdjj/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.hS5nhQgUt7/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/VeZBSkcJSm-s6LMpDEufog/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009351 build_url: 'https://queue.taskcluster.net/v1/task/VeZBSkcJSm-s6LMpDEufog/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-20 15:43:49.657526) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:43:49.657945) ========= 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.Z9a9FnWdjj/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.hS5nhQgUt7/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005106 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:43:49.710742) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 15:43:49.711137) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 15:43:49.711644) ========= ========= Total master_lag: 0.25 =========