builder: mozilla-inbound_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0021 starttime: 1447804545.53 results: success (0) buildid: 20151117140223 builduid: b9de740a4f7741fda8001beca0367b7d revision: 66768d6a50fa4c24bd851b47b2ae0f69d78ff475 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:45.534675) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:45.535227) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:45.535527) ========= 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.gUNOrodT82/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.jIILIRHUG7/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.007023 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:45.564190) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:45.564993) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:45.584033) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:45.584765) ========= 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.gUNOrodT82/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.jIILIRHUG7/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.006154 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:45.635877) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:45.636155) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:45.639527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:45.639815) ========= 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.gUNOrodT82/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.jIILIRHUG7/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-17 15:55:45-- 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% 7.56M=0.002s 2015-11-17 15:55:45 (7.56 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186212 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:45.842098) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:45.845531) ========= 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.gUNOrodT82/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.jIILIRHUG7/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.021824 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:45.894917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 15:55:45.895266) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 66768d6a50fa4c24bd851b47b2ae0f69d78ff475 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 66768d6a50fa4c24bd851b47b2ae0f69d78ff475 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gUNOrodT82/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.jIILIRHUG7/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-17 15:55:45,990 truncating revision to first 12 chars 2015-11-17 15:55:45,990 Setting DEBUG logging. 2015-11-17 15:55:45,991 attempt 1/10 2015-11-17 15:55:45,991 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/66768d6a50fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 15:55:47,053 unpacking tar archive at: mozilla-inbound-66768d6a50fa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.342325 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 15:55:47.258554) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:47.258927) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:47.273847) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:47.274190) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 15:55:47.274665) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2015-11-17 15:55:47.275031) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gUNOrodT82/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.jIILIRHUG7/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 15:55:47 INFO - MultiFileLogger online at 20151117 15:55:47 in /builds/slave/test 15:55:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:55:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:55:47 INFO - {'append_to_log': False, 15:55:47 INFO - 'base_work_dir': '/builds/slave/test', 15:55:47 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:55:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:55:47 INFO - 'branch': 'Mozilla-Inbound', 15:55:47 INFO - 'buildbot_json_path': 'buildprops.json', 15:55:47 INFO - 'config_files': ('talos/mac_config.py',), 15:55:47 INFO - 'default_actions': ('clobber', 15:55:47 INFO - 'read-buildbot-config', 15:55:47 INFO - 'download-and-extract', 15:55:47 INFO - 'populate-webroot', 15:55:47 INFO - 'create-virtualenv', 15:55:47 INFO - 'install', 15:55:47 INFO - 'run-tests'), 15:55:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:55:47 INFO - 'download_minidump_stackwalk': True, 15:55:47 INFO - 'download_symbols': 'ondemand', 15:55:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:55:47 INFO - 'tooltool.py': '/tools/tooltool.py', 15:55:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:55:47 INFO - '/tools/misc-python/virtualenv.py')}, 15:55:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:55:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:55:47 INFO - 'installer_path': 'installer.exe', 15:55:47 INFO - 'log_level': 'info', 15:55:47 INFO - 'log_name': 'talos', 15:55:47 INFO - 'log_to_console': True, 15:55:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:55:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:55:47 INFO - 'opt_config_files': (), 15:55:47 INFO - 'pip_index': False, 15:55:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:55:47 INFO - 'cmd': ('bash', 15:55:47 INFO - '-c', 15:55:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:55:47 INFO - 'enabled': True, 15:55:47 INFO - 'halt_on_failure': False, 15:55:47 INFO - 'name': 'check_screen_resolution'},), 15:55:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:55:47 INFO - 'cmd': ('bash', 15:55:47 INFO - '-c', 15:55:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:55:47 INFO - 'enabled': True, 15:55:47 INFO - 'halt_on_failure': False, 15:55:47 INFO - 'name': 'check_screen_resolution'},), 15:55:47 INFO - 'run_cmd_checks_enabled': True, 15:55:47 INFO - 'sps_profile': False, 15:55:47 INFO - 'sps_profile_interval': 0, 15:55:47 INFO - 'suite': 'dromaeojs-e10s', 15:55:47 INFO - 'system_bits': '64', 15:55:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:55:47 INFO - 'title': 't-yosemite-r5-0021', 15:55:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:55:47 INFO - 'use_talos_json': True, 15:55:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:55:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:55:47 INFO - 'work_dir': 'build'} 15:55:47 INFO - ##### 15:55:47 INFO - ##### Running clobber step. 15:55:47 INFO - ##### 15:55:47 INFO - Running pre-action listener: _resource_record_pre_action 15:55:47 INFO - Running main action method: clobber 15:55:47 INFO - rmtree: /builds/slave/test/build 15:55:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:55:49 INFO - Running post-action listener: _resource_record_post_action 15:55:49 INFO - ##### 15:55:49 INFO - ##### Running read-buildbot-config step. 15:55:49 INFO - ##### 15:55:49 INFO - Running pre-action listener: _resource_record_pre_action 15:55:49 INFO - Running main action method: read_buildbot_config 15:55:49 INFO - Using buildbot properties: 15:55:49 INFO - { 15:55:49 INFO - "properties": { 15:55:49 INFO - "buildnumber": 199, 15:55:49 INFO - "product": "firefox", 15:55:49 INFO - "script_repo_revision": "production", 15:55:49 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs-e10s", 15:55:49 INFO - "repository": "", 15:55:49 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs-e10s", 15:55:49 INFO - "buildid": "20151117140223", 15:55:49 INFO - "slavename": "t-yosemite-r5-0021", 15:55:49 INFO - "pgo_build": "False", 15:55:49 INFO - "basedir": "/builds/slave/test", 15:55:49 INFO - "project": "", 15:55:49 INFO - "platform": "yosemite", 15:55:49 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:55:49 INFO - "slavebuilddir": "test", 15:55:49 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 15:55:49 INFO - "branch": "mozilla-inbound", 15:55:49 INFO - "repo_path": "integration/mozilla-inbound", 15:55:49 INFO - "stage_platform": "macosx64", 15:55:49 INFO - "builduid": "b9de740a4f7741fda8001beca0367b7d", 15:55:49 INFO - "revision": "66768d6a50fa4c24bd851b47b2ae0f69d78ff475" 15:55:49 INFO - }, 15:55:49 INFO - "sourcestamp": { 15:55:49 INFO - "repository": "", 15:55:49 INFO - "hasPatch": false, 15:55:49 INFO - "project": "", 15:55:49 INFO - "branch": "mozilla-inbound-macosx64-talos", 15:55:49 INFO - "changes": [ 15:55:49 INFO - { 15:55:49 INFO - "category": null, 15:55:49 INFO - "files": [ 15:55:49 INFO - { 15:55:49 INFO - "url": null, 15:55:49 INFO - "name": "https://queue.taskcluster.net/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 15:55:49 INFO - } 15:55:49 INFO - ], 15:55:49 INFO - "repository": "", 15:55:49 INFO - "rev": "66768d6a50fa4c24bd851b47b2ae0f69d78ff475", 15:55:49 INFO - "who": "nnethercote@mozilla.com", 15:55:49 INFO - "when": 1447803587, 15:55:49 INFO - "number": 6674671, 15:55:49 INFO - "comments": "Bug 1225007 (part 2) - Use LayoutDevicePixel more in Cocoa widget code. r=kats.", 15:55:49 INFO - "project": "", 15:55:49 INFO - "at": "Tue 17 Nov 2015 15:39:47", 15:55:49 INFO - "branch": "mozilla-inbound-macosx64-talos", 15:55:49 INFO - "revlink": "", 15:55:49 INFO - "properties": [ 15:55:49 INFO - [ 15:55:49 INFO - "buildid", 15:55:49 INFO - "20151117140223", 15:55:49 INFO - "Change" 15:55:49 INFO - ], 15:55:49 INFO - [ 15:55:49 INFO - "builduid", 15:55:49 INFO - "b9de740a4f7741fda8001beca0367b7d", 15:55:49 INFO - "Change" 15:55:49 INFO - ], 15:55:49 INFO - [ 15:55:49 INFO - "pgo_build", 15:55:49 INFO - "False", 15:55:49 INFO - "Change" 15:55:49 INFO - ] 15:55:49 INFO - ], 15:55:49 INFO - "revision": "66768d6a50fa4c24bd851b47b2ae0f69d78ff475" 15:55:49 INFO - } 15:55:49 INFO - ], 15:55:49 INFO - "revision": "66768d6a50fa4c24bd851b47b2ae0f69d78ff475" 15:55:49 INFO - } 15:55:49 INFO - } 15:55:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 15:55:49 INFO - Running post-action listener: _resource_record_post_action 15:55:49 INFO - ##### 15:55:49 INFO - ##### Running download-and-extract step. 15:55:49 INFO - ##### 15:55:49 INFO - Running pre-action listener: _resource_record_pre_action 15:55:49 INFO - Running main action method: download_and_extract 15:55:49 INFO - mkdir: /builds/slave/test/build/tests 15:55: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:55:49 INFO - https://queue.taskcluster.net/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:55:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/test_packages.json 15:55:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/test_packages.json 15:55:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:55:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:55:49 INFO - Downloaded 1149 bytes. 15:55:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:55:49 INFO - Using the following test package requirements: 15:55:49 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:55:49 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:55:49 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 15:55:49 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:55:49 INFO - u'jsshell-mac.zip'], 15:55:49 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:55:49 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 15:55:49 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:55:49 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:55:49 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 15:55:49 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:55:49 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 15:55:49 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:55:49 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 15:55:49 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:55:49 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:55:49 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 15:55:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:55: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:55:49 INFO - https://queue.taskcluster.net/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:55:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:55:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:55:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/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:55:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/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:55:50 INFO - Downloaded 17463535 bytes. 15:55:50 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:55:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:55:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:55:56 INFO - Return code: 0 15:55:56 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:55:56 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:55:56 INFO - https://queue.taskcluster.net/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:55:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:55:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:55:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/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:55:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/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:55:57 INFO - Downloaded 17463535 bytes. 15:55:57 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:55:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:55:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:56:03 INFO - Return code: 0 15:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:03 INFO - https://queue.taskcluster.net/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:56:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:56:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:56:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/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:56:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/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:56:04 INFO - Downloaded 11130997 bytes. 15:56:04 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:56:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:56:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 15:56:05 INFO - Return code: 0 15:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:05 INFO - https://queue.taskcluster.net/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:56:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:56:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:56:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 15:56:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zRw74V_jQyShPCgsQftNyg/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:56:08 INFO - Downloaded 108832933 bytes. 15:56:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:56:08 INFO - mkdir: /builds/slave/test/properties 15:56:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:56:08 INFO - Writing to file /builds/slave/test/properties/build_url 15:56:08 INFO - Contents: 15:56:08 INFO - build_url:https://queue.taskcluster.net/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:56:08 INFO - Running post-action listener: _resource_record_post_action 15:56:08 INFO - Running post-action listener: set_extra_try_arguments 15:56:08 INFO - ##### 15:56:08 INFO - ##### Running populate-webroot step. 15:56:08 INFO - ##### 15:56:08 INFO - Running pre-action listener: _resource_record_pre_action 15:56:08 INFO - Running main action method: populate_webroot 15:56:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:56:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:56:08 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:56:08 INFO - '../fennec_ids.txt'], 15:56:08 INFO - 'tests': ['tcheck2']}, 15:56:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:56:08 INFO - '--tppagecycles', 15:56:08 INFO - '7'], 15:56:08 INFO - 'tests': ['tsvgm']}}, 15:56:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:56:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:56:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:56:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:56:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:56:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:56:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:08 INFO - 'talos_options': ['--e10s'], 15:56:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:08 INFO - 'tests': ['damp', 'tps']}, 15:56:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:08 INFO - 'talos_options': ['--e10s'], 15:56:08 INFO - 'tests': ['damp', 'tps']}, 15:56:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:56:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:56:08 INFO - 'other': {'tests': ['a11yr', 15:56:08 INFO - 'ts_paint', 15:56:08 INFO - 'tpaint', 15:56:08 INFO - 'sessionrestore', 15:56:08 INFO - 'sessionrestore_no_auto_restore']}, 15:56:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:56:08 INFO - 'tests': ['a11yr', 15:56:08 INFO - 'ts_paint', 15:56:08 INFO - 'tpaint', 15:56:08 INFO - 'sessionrestore', 15:56:08 INFO - 'sessionrestore_no_auto_restore']}, 15:56:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:56:08 INFO - 'tests': ['a11yr', 15:56:08 INFO - 'ts_paint', 15:56:08 INFO - 'tpaint', 15:56:08 INFO - 'sessionrestore', 15:56:08 INFO - 'sessionrestore_no_auto_restore']}, 15:56:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:56:08 INFO - 'tests': ['a11yr', 15:56:08 INFO - 'ts_paint', 15:56:08 INFO - 'tpaint', 15:56:08 INFO - 'sessionrestore', 15:56:08 INFO - 'sessionrestore_no_auto_restore']}, 15:56:08 INFO - 'other_l64': {'tests': ['a11yr', 15:56:08 INFO - 'ts_paint', 15:56:08 INFO - 'tpaint', 15:56:08 INFO - 'sessionrestore', 15:56:08 INFO - 'sessionrestore_no_auto_restore']}, 15:56:08 INFO - 'other_nol64': {'tests': ['a11yr', 15:56:08 INFO - 'ts_paint', 15:56:08 INFO - 'tpaint', 15:56:08 INFO - 'sessionrestore', 15:56:08 INFO - 'sessionrestore_no_auto_restore']}, 15:56:08 INFO - 'svgr': {'tests': ['tsvgx', 15:56:08 INFO - 'tsvgr_opacity', 15:56:08 INFO - 'tart', 15:56:08 INFO - 'tscrollx', 15:56:08 INFO - 'cart']}, 15:56:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:56:08 INFO - 'tests': ['tsvgx', 15:56:08 INFO - 'tsvgr_opacity', 15:56:08 INFO - 'tart', 15:56:08 INFO - 'tscrollx', 15:56:08 INFO - 'cart']}, 15:56:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:08 INFO - 'tests': ['tp5o']}, 15:56:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:08 INFO - 'talos_options': ['--e10s'], 15:56:08 INFO - 'tests': ['tp5o']}, 15:56:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:08 INFO - 'talos_options': ['--xperf_path', 15:56:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:08 INFO - 'tests': ['tp5n']}, 15:56:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:08 INFO - 'talos_options': ['--e10s', 15:56:08 INFO - '--xperf_path', 15:56:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:08 INFO - 'tests': ['tp5n']}}, 15:56:08 INFO - 'talos.zip': {'path': '', 15:56:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:56:08 INFO - Running post-action listener: _resource_record_post_action 15:56:08 INFO - ##### 15:56:08 INFO - ##### Running create-virtualenv step. 15:56:08 INFO - ##### 15:56:08 INFO - Running pre-action listener: _resource_record_pre_action 15:56:08 INFO - Running main action method: create_virtualenv 15:56:08 INFO - Creating virtualenv /builds/slave/test/build/venv 15:56:08 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:56:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:56:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:56:08 INFO - Using real prefix '/tools/python27' 15:56:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:56:09 INFO - Installing distribute.............................................................................................................................................................................................done. 15:56:13 INFO - Installing pip.................done. 15:56:13 INFO - Return code: 0 15:56:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c5cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a03d512f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ef9f0>, '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 0x10c24edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4e28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUNOrodT82/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.jIILIRHUG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:56:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUNOrodT82/Render', 15:56:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:13 INFO - 'HOME': '/Users/cltbld', 15:56:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:13 INFO - 'LOGNAME': 'cltbld', 15:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:13 INFO - 'MOZ_NO_REMOTE': '1', 15:56:13 INFO - 'NO_EM_RESTART': '1', 15:56:13 INFO - 'PAGER': '/bin/cat', 15:56:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:13 INFO - 'PWD': '/builds/slave/test', 15:56:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:13 INFO - 'SHELL': '/bin/bash', 15:56:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIILIRHUG7/Listeners', 15:56:13 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 15:56:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:13 INFO - 'USER': 'cltbld', 15:56:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:13 INFO - 'XPC_FLAGS': '0x0', 15:56:13 INFO - 'XPC_SERVICE_NAME': '0', 15:56:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:56:13 INFO - Cleaning up... 15:56:13 INFO - Return code: 0 15:56:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c5cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a03d512f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ef9f0>, '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 0x10c24edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4e28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUNOrodT82/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.jIILIRHUG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:56:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUNOrodT82/Render', 15:56:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:13 INFO - 'HOME': '/Users/cltbld', 15:56:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:13 INFO - 'LOGNAME': 'cltbld', 15:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:13 INFO - 'MOZ_NO_REMOTE': '1', 15:56:13 INFO - 'NO_EM_RESTART': '1', 15:56:13 INFO - 'PAGER': '/bin/cat', 15:56:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:13 INFO - 'PWD': '/builds/slave/test', 15:56:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:13 INFO - 'SHELL': '/bin/bash', 15:56:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIILIRHUG7/Listeners', 15:56:13 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 15:56:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:13 INFO - 'USER': 'cltbld', 15:56:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:13 INFO - 'XPC_FLAGS': '0x0', 15:56:13 INFO - 'XPC_SERVICE_NAME': '0', 15:56:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:14 INFO - Downloading/unpacking psutil>=0.7.1 15:56:14 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:56:14 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:56:14 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:56:14 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:56:14 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:56:14 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:56:16 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:56:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:56:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:56:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:17 INFO - Installing collected packages: psutil 15:56:17 INFO - Running setup.py install for psutil 15:56:17 INFO - building 'psutil._psutil_osx' extension 15:56:17 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:56:17 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:56:17 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:56:17 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:56:17 INFO - building 'psutil._psutil_posix' extension 15:56:17 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:56:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:56:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:56:17 INFO - ^ 15:56:17 INFO - 1 warning generated. 15:56:17 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:56:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:18 INFO - Successfully installed psutil 15:56:18 INFO - Cleaning up... 15:56:18 INFO - Return code: 0 15:56:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:56:18 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:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:18 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:56:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:18 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 0x10c5cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a03d512f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ef9f0>, '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 0x10c24edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4e28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUNOrodT82/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.jIILIRHUG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:18 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:56:18 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:56:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUNOrodT82/Render', 15:56:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:18 INFO - 'HOME': '/Users/cltbld', 15:56:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:18 INFO - 'LOGNAME': 'cltbld', 15:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:18 INFO - 'MOZ_NO_REMOTE': '1', 15:56:18 INFO - 'NO_EM_RESTART': '1', 15:56:18 INFO - 'PAGER': '/bin/cat', 15:56:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:18 INFO - 'PWD': '/builds/slave/test', 15:56:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:18 INFO - 'SHELL': '/bin/bash', 15:56:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIILIRHUG7/Listeners', 15:56:18 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 15:56:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:18 INFO - 'USER': 'cltbld', 15:56:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:18 INFO - 'XPC_FLAGS': '0x0', 15:56:18 INFO - 'XPC_SERVICE_NAME': '0', 15:56:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:56:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:56:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:56:21 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:56:21 INFO - Installing collected packages: mozsystemmonitor 15:56:21 INFO - Running setup.py install for mozsystemmonitor 15:56:22 INFO - Successfully installed mozsystemmonitor 15:56:22 INFO - Cleaning up... 15:56:22 INFO - Return code: 0 15:56:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10c5cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a03d512f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ef9f0>, '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 0x10c24edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4e28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUNOrodT82/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.jIILIRHUG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:22 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:56:22 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:56:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUNOrodT82/Render', 15:56:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:22 INFO - 'HOME': '/Users/cltbld', 15:56:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:22 INFO - 'LOGNAME': 'cltbld', 15:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:22 INFO - 'MOZ_NO_REMOTE': '1', 15:56:22 INFO - 'NO_EM_RESTART': '1', 15:56:22 INFO - 'PAGER': '/bin/cat', 15:56:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:22 INFO - 'PWD': '/builds/slave/test', 15:56:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:22 INFO - 'SHELL': '/bin/bash', 15:56:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIILIRHUG7/Listeners', 15:56:22 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 15:56:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:22 INFO - 'USER': 'cltbld', 15:56:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:22 INFO - 'XPC_FLAGS': '0x0', 15:56:22 INFO - 'XPC_SERVICE_NAME': '0', 15:56:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:22 INFO - Downloading/unpacking blobuploader==1.2.4 15:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:25 INFO - Downloading blobuploader-1.2.4.tar.gz 15:56:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:56:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:56:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:56:25 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:56:25 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:56:25 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:56:25 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:56:25 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:56:25 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:56:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:56:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:56:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:56:26 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:56:26 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:56:26 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:56:26 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:56:26 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:56:26 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:56:26 INFO - Downloading docopt-0.6.1.tar.gz 15:56:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:56:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:56:26 INFO - Installing collected packages: blobuploader, requests, docopt 15:56:26 INFO - Running setup.py install for blobuploader 15:56:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:56:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:56:26 INFO - Running setup.py install for requests 15:56:27 INFO - Running setup.py install for docopt 15:56:27 INFO - Successfully installed blobuploader requests docopt 15:56:27 INFO - Cleaning up... 15:56:27 INFO - Return code: 0 15:56:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:27 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 0x10c5cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a03d512f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ef9f0>, '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 0x10c24edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4e28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUNOrodT82/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.jIILIRHUG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:27 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:56:27 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:56:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUNOrodT82/Render', 15:56:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:27 INFO - 'HOME': '/Users/cltbld', 15:56:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:27 INFO - 'LOGNAME': 'cltbld', 15:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:27 INFO - 'MOZ_NO_REMOTE': '1', 15:56:27 INFO - 'NO_EM_RESTART': '1', 15:56:27 INFO - 'PAGER': '/bin/cat', 15:56:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:27 INFO - 'PWD': '/builds/slave/test', 15:56:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:27 INFO - 'SHELL': '/bin/bash', 15:56:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIILIRHUG7/Listeners', 15:56:27 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 15:56:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:27 INFO - 'USER': 'cltbld', 15:56:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:27 INFO - 'XPC_FLAGS': '0x0', 15:56:27 INFO - 'XPC_SERVICE_NAME': '0', 15:56:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:56:28 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-rH9B88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:56:28 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-oavJo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:56:28 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-mAcftp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:56:28 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-sVFpJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:56:28 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-b_SpkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:56:28 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-M2RAEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:56:28 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-A4M2OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:56:29 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-mwiPDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:56:29 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-QVHPqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:56:29 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-oqpVno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:56:29 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-JWspIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:56:29 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-udbBhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:56:29 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-2MS441-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:56:29 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-Q8Ynic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:29 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-O6c2R7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:56:30 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-2Yu7K4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:56:30 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-KYvFd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:56:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:56:30 INFO - Running setup.py install for manifestparser 15:56:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:56:30 INFO - Running setup.py install for mozcrash 15:56:30 INFO - Running setup.py install for mozdebug 15:56:30 INFO - Running setup.py install for mozdevice 15:56:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:56:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:56:31 INFO - Running setup.py install for mozfile 15:56:31 INFO - Running setup.py install for mozhttpd 15:56:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:56:31 INFO - Running setup.py install for mozinfo 15:56:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:56:31 INFO - Running setup.py install for mozInstall 15:56:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:56:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:56:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:56:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:56:31 INFO - Running setup.py install for mozleak 15:56:32 INFO - Running setup.py install for mozlog 15:56:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:56:32 INFO - Running setup.py install for moznetwork 15:56:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:56:32 INFO - Running setup.py install for mozprocess 15:56:32 INFO - Running setup.py install for mozprofile 15:56:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:56:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:56:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:56:32 INFO - Running setup.py install for mozrunner 15:56:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Running setup.py install for mozscreenshot 15:56:33 INFO - Running setup.py install for moztest 15:56:33 INFO - Running setup.py install for mozversion 15:56:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:56:33 INFO - Cleaning up... 15:56:33 INFO - Return code: 0 15:56:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:56:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x10c5cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a03d512f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ef9f0>, '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 0x10c24edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4e28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUNOrodT82/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.jIILIRHUG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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:56:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUNOrodT82/Render', 15:56:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:33 INFO - 'HOME': '/Users/cltbld', 15:56:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:33 INFO - 'LOGNAME': 'cltbld', 15:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:33 INFO - 'MOZ_NO_REMOTE': '1', 15:56:33 INFO - 'NO_EM_RESTART': '1', 15:56:33 INFO - 'PAGER': '/bin/cat', 15:56:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:33 INFO - 'PWD': '/builds/slave/test', 15:56:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:33 INFO - 'SHELL': '/bin/bash', 15:56:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIILIRHUG7/Listeners', 15:56:33 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 15:56:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:33 INFO - 'USER': 'cltbld', 15:56:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:33 INFO - 'XPC_FLAGS': '0x0', 15:56:33 INFO - 'XPC_SERVICE_NAME': '0', 15:56:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:56:34 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-e9FuMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:56:34 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:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:56:34 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-1zIvv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:56:34 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:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:56:34 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-jeC6LB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:56:34 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:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:56:34 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-AYSKg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:56:34 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:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:56:34 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-mDDoIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:56:34 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:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:56:34 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-MiFM3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:56:34 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:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:56:34 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-VrL6ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:56:35 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:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:56:35 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-DaZKrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:56:35 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:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:56:35 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-0Nwruk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:56:35 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:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:56:35 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-yXGAEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:56:35 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:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:56:35 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-5wrHLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:56:35 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:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:56:35 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-SuN1Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:56:35 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:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:56:35 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-eSJdSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:56:35 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:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:56:35 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-wRcrtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:56:36 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:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:36 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-DnWBjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:36 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:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:56:36 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-2zweK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:56:36 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:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:56:36 INFO - Running setup.py (path:/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/pip-94l9Gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:56:36 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:56:36 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:56:36 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:56:36 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:56:36 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:56:36 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:56:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:56:36 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:56:36 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:56:36 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:56:36 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:56:36 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:56:36 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:56:39 INFO - Downloading blessings-1.5.1.tar.gz 15:56:39 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:56:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:56:39 INFO - Installing collected packages: blessings 15:56:39 INFO - Running setup.py install for blessings 15:56:39 INFO - Successfully installed blessings 15:56:39 INFO - Cleaning up... 15:56:39 INFO - Return code: 0 15:56:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:56:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:56:39 INFO - Reading from file tmpfile_stdout 15:56:39 INFO - Current package versions: 15:56:39 INFO - blessings == 1.5.1 15:56:39 INFO - blobuploader == 1.2.4 15:56:39 INFO - docopt == 0.6.1 15:56:39 INFO - manifestparser == 1.1 15:56:39 INFO - mozInstall == 1.12 15:56:39 INFO - mozcrash == 0.16 15:56:39 INFO - mozdebug == 0.1 15:56:39 INFO - mozdevice == 0.47 15:56:39 INFO - mozfile == 1.2 15:56:39 INFO - mozhttpd == 0.7 15:56:39 INFO - mozinfo == 0.9 15:56:39 INFO - mozleak == 0.1 15:56:39 INFO - mozlog == 3.0 15:56:39 INFO - moznetwork == 0.27 15:56:39 INFO - mozprocess == 0.22 15:56:39 INFO - mozprofile == 0.27 15:56:39 INFO - mozrunner == 6.11 15:56:39 INFO - mozscreenshot == 0.1 15:56:39 INFO - mozsystemmonitor == 0.0 15:56:39 INFO - moztest == 0.7 15:56:39 INFO - mozversion == 1.4 15:56:39 INFO - psutil == 3.1.1 15:56:39 INFO - requests == 1.2.3 15:56:39 INFO - wsgiref == 0.1.2 15:56:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56:39 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:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:39 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:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:39 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 0x10c5cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a03d512f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4ef9f0>, '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 0x10c24edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4e28c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUNOrodT82/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.jIILIRHUG7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:39 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:56:39 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:56:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUNOrodT82/Render', 15:56:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:39 INFO - 'HOME': '/Users/cltbld', 15:56:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:39 INFO - 'LOGNAME': 'cltbld', 15:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:39 INFO - 'MOZ_NO_REMOTE': '1', 15:56:39 INFO - 'NO_EM_RESTART': '1', 15:56:39 INFO - 'PAGER': '/bin/cat', 15:56:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:39 INFO - 'PWD': '/builds/slave/test', 15:56:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:39 INFO - 'SHELL': '/bin/bash', 15:56:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIILIRHUG7/Listeners', 15:56:39 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 15:56:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:39 INFO - 'USER': 'cltbld', 15:56:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:39 INFO - 'XPC_FLAGS': '0x0', 15:56:39 INFO - 'XPC_SERVICE_NAME': '0', 15:56:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:40 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:56:40 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:56:40 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:56:40 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:56:40 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:56:40 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:56:40 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:56:40 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:56:40 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:56:40 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:56:40 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:56:40 INFO - Cleaning up... 15:56:40 INFO - Return code: 0 15:56:40 INFO - Running post-action listener: _resource_record_post_action 15:56:40 INFO - Running post-action listener: _start_resource_monitoring 15:56:40 INFO - Starting resource monitoring. 15:56:40 INFO - ##### 15:56:40 INFO - ##### Running install step. 15:56:40 INFO - ##### 15:56:40 INFO - Running pre-action listener: _resource_record_pre_action 15:56:40 INFO - Running main action method: install 15:56:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:56:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:56:40 INFO - Reading from file tmpfile_stdout 15:56:40 INFO - Detecting whether we're running mozinstall >=1.0... 15:56:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:56:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:56:40 INFO - Reading from file tmpfile_stdout 15:56:40 INFO - Output received: 15:56:40 INFO - Usage: mozinstall [options] installer 15:56:40 INFO - Options: 15:56:40 INFO - -h, --help show this help message and exit 15:56:40 INFO - -d DEST, --destination=DEST 15:56:40 INFO - Directory to install application into. [default: 15:56:40 INFO - "/builds/slave/test"] 15:56:40 INFO - --app=APP Application being installed. [default: firefox] 15:56:40 INFO - mkdir: /builds/slave/test/build/application 15:56:40 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:56:40 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:57:22 INFO - Reading from file tmpfile_stdout 15:57:22 INFO - Output received: 15:57:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:57:22 INFO - Running post-action listener: _resource_record_post_action 15:57:22 INFO - ##### 15:57:22 INFO - ##### Running run-tests step. 15:57:22 INFO - ##### 15:57:22 INFO - Running pre-action listener: _resource_record_pre_action 15:57:22 INFO - Running main action method: run_tests 15:57:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:57:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:57:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:57:22 INFO - 2015-11-17 15:57:22.672 screenresolution[1959:14115] starting screenresolution argv=screenresolution get 15:57:22 INFO - 2015-11-17 15:57:22.676 screenresolution[1959:14115] Display 0: 1600x1200x32@60 15:57:22 INFO - 2015-11-17 15:57:22.684 screenresolution[1960:14117] starting screenresolution argv=screenresolution list 15:57:22 INFO - Available Modes on Display 0 15:57:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:57:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:57:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:57:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:57:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:57:22 INFO - Intel HD Graphics 3000: 15:57:22 INFO - Chipset Model: Intel HD Graphics 3000 15:57:22 INFO - Type: GPU 15:57:22 INFO - Bus: Built-In 15:57:22 INFO - VRAM (Total): 512 MB 15:57:22 INFO - VRAM (Dynamic, Max): 10 15:57:22 INFO - Vendor: Intel (0x8086) 15:57:22 INFO - Device ID: 0x0116 15:57:22 INFO - Revision ID: 0x0009 15:57:22 INFO - Displays: 15:57:22 INFO - Display: 15:57:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:57:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:57:22 INFO - Display Serial Number: 1600x1200 60 15:57:22 INFO - Main Display: Yes 15:57:22 INFO - Mirror: Off 15:57:22 INFO - Online: Yes 15:57:22 INFO - Rotation: Supported 15:57:22 INFO - Return code: 0 15:57:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:57:22 INFO - Python 2.7.3 15:57:22 INFO - Return code: 0 15:57:22 INFO - grabbing minidump binary from tooltool 15:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:57:22 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 0x10c4ef9f0>, '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 0x10c24edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4e28c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:57:22 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:57:22 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:57:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:57:23 INFO - Return code: 0 15:57:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:57:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:57:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:57:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:57:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:57:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0021', '--webServer', 'localhost'] in /builds/slave/test/build 15:57:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0021 --webServer localhost 15:57:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gUNOrodT82/Render', 15:57:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:57:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:57:23 INFO - 'HOME': '/Users/cltbld', 15:57:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:57:23 INFO - 'LOGNAME': 'cltbld', 15:57:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:57:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:23 INFO - 'MOZ_NO_REMOTE': '1', 15:57:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:57:23 INFO - 'NO_EM_RESTART': '1', 15:57:23 INFO - 'PAGER': '/bin/cat', 15:57:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:23 INFO - 'PWD': '/builds/slave/test', 15:57:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:57:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:57:23 INFO - 'SHELL': '/bin/bash', 15:57:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jIILIRHUG7/Listeners', 15:57:23 INFO - 'TMPDIR': '/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/', 15:57:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:57:23 INFO - 'USER': 'cltbld', 15:57:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:57:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:23 INFO - 'XPC_FLAGS': '0x0', 15:57:23 INFO - 'XPC_SERVICE_NAME': '0', 15:57:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:57:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0021', '--webServer', 'localhost'] with output_timeout 3600 15:57:23 INFO - mozversion INFO | application_buildid: 20151117140223 15:57:23 INFO - mozversion INFO | application_changeset: 66768d6a50fa4c24bd851b47b2ae0f69d78ff475 15:57:23 INFO - mozversion INFO | application_display_name: Nightly 15:57:23 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:57:23 INFO - mozversion INFO | application_name: Firefox 15:57:23 INFO - mozversion INFO | application_remotingname: firefox 15:57:23 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:57:23 INFO - mozversion INFO | application_vendor: Mozilla 15:57:23 INFO - mozversion INFO | application_version: 45.0a1 15:57:23 INFO - mozversion INFO | platform_buildid: 20151117140223 15:57:23 INFO - mozversion INFO | platform_changeset: 66768d6a50fa4c24bd851b47b2ae0f69d78ff475 15:57:23 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:57:23 INFO - mozversion INFO | platform_version: 45.0a1 15:57:23 INFO - 2015-11-17 15:57:23,357 DEBUG : using testdate: 1447804643 15:57:23 INFO - 2015-11-17 15:57:23,357 DEBUG : actual date: 1447804643 15:57:23 INFO - 2015-11-17 15:57:23,367 INFO : starting webserver on 'localhost:49487' 15:57:23 INFO - 2015-11-17 15:57:23,369 INFO : Starting test suite t-yosemite-r5-0021.e 15:57:23 INFO - 2015-11-17 15:57:23,369 INFO : Starting test dromaeo_css 15:57:23 INFO - 2015-11-17 15:57:23,369 DEBUG : operating with platform_type : mac_ 15:57:23 INFO - 2015-11-17 15:57:23,370 INFO : Initialising browser for dromaeo_css test... 15:57:23 INFO - 2015-11-17 15:57:23,385 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmpaHbO5L/profile http://localhost:49487/getInfo.html 15:57:26 INFO - 2015-11-17 15:57:26,715 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:57:26 INFO - 2015-11-17 15:57:26,715 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:57:26 INFO - 2015-11-17 15:57:26,715 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:57:26 INFO - 2015-11-17 15:57:26,715 DEBUG : BROWSER_OUTPUT: __metrics 15:57:27 INFO - 2015-11-17 15:57:27,439 INFO : Browser initialized. 15:57:27 INFO - 2015-11-17 15:57:27,439 INFO : Running cycle 1/1 for dromaeo_css test... 15:57:27 INFO - 2015-11-17 15:57:27,439 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmpaHbO5L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:57:39 INFO - 2015-11-17 15:57:39,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 241127424 15:57:39 INFO - 2015-11-17 15:57:39,729 DEBUG : BROWSER_OUTPUT: 15:58:29 INFO - 2015-11-17 15:58:29,450 DEBUG : BROWSER_OUTPUT: 1447804709448 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:00:39 INFO - 2015-11-17 16:00:39,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49487/tests/dromaeo/cssquery-ext.html) 16:00:40 INFO - 2015-11-17 16:00:40,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 265588736 16:00:40 INFO - 2015-11-17 16:00:40,571 DEBUG : BROWSER_OUTPUT: 16:03:42 INFO - 2015-11-17 16:03:42,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/dromaeo/cssquery-ext.html (next: http://localhost:49487/tests/dromaeo/cssquery-jquery.html) 16:03:43 INFO - 2015-11-17 16:03:43,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 271519744 16:03:43 INFO - 2015-11-17 16:03:43,123 DEBUG : BROWSER_OUTPUT: 16:06:44 INFO - 2015-11-17 16:06:44,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49487/tests/dromaeo/cssquery-mootools.html) 16:06:45 INFO - 2015-11-17 16:06:45,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 275558400 16:06:45 INFO - 2015-11-17 16:06:45,435 DEBUG : BROWSER_OUTPUT: 16:09:47 INFO - 2015-11-17 16:09:47,189 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49487/tests/dromaeo/cssquery-prototype.html) 16:09:47 INFO - 2015-11-17 16:09:47,773 DEBUG : BROWSER_OUTPUT: RSS: Main: 278978560 16:09:47 INFO - 2015-11-17 16:09:47,773 DEBUG : BROWSER_OUTPUT: 16:12:50 INFO - 2015-11-17 16:12:50,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49487/tests/dromaeo/cssquery-yui.html) 16:12:51 INFO - 2015-11-17 16:12:51,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 284176384 16:12:51 INFO - 2015-11-17 16:12:51,029 DEBUG : BROWSER_OUTPUT: 16:15:53 INFO - 2015-11-17 16:15:53,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/dromaeo/cssquery-yui.html (next: http://localhost:49487/tests/dromaeo/cssquery-dojo.html) 16:15:53 INFO - 2015-11-17 16:15:53,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 288292864 16:15:53 INFO - 2015-11-17 16:15:53,701 DEBUG : BROWSER_OUTPUT: 16:15:53 INFO - 2015-11-17 16:15:53,701 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:15:53 INFO - 2015-11-17 16:15:53,702 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:15:53 INFO - 2015-11-17 16:15:53,702 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:15:53 INFO - 2015-11-17 16:15:53,702 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:15:53 INFO - 2015-11-17 16:15:53,702 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2551.476947225818;2601.75283348082;2612.7648511633947;2658.8803503842323;2663.360793409582;4196.9370459443135;4349.195398851215;4389.868303950882;4420.447444069491;4519.118771839492;4179.66562674986;4277.636400905919;4348.326009468537;4356.390105385249;4405.118976204756;4053.250148722481;4079.2453396121664;4101.815418306169;4144.8756537303925;4173.123644034757;4043.757374557536;4069.3285607874664;4103.405006274089;4108.753474791507;4116.6912481564;3883.262180185756;3940.6453419192126;4038.8788336349958;4085.9591404085877;4129.678502879065;4093.9181216375805;4106.897327566805;4130.442390277304;4152.937705934413;4178.749275043507;4086.8978275543054;4096.5903409658795;4120.793960302003;4121.5466298707115;4128.896777580554;4077.2660921034203;4174.186033723425;4375.606195442426;4427;4428.202923473774;4687.9531204687855;4734.218853889104;4783.760811959388;4792.065547218293;4806.975965120152;4552.089582083563;4762.476127625959;4787.832425865078;4846.491118432585;4869.780859861315;4328.2209202343565;4399.868003959887;4407.1185762847235;4465.776711164429;4470.441194850644;4736.834210802605;4759.405074365704;4778.737169455644;4803.831865884677;4816.566509014206;4320.567943205654;4361.302191649321;4564.0871825635;4581.40441742578;4633.698809577367;4469.888252793706;4541.455025396974;4582.312653101994;4595.954040459619;4600.447946246405;4695.295705644181;4697.31888876111;4733.881652958635;4765;4820.228763397839;4564.3838081859185;4616.146012987608;4640.257558790645;4682.227432473604;4694.248920172756;3670.284294562588;3679.043448703303;3691.963080369162;3714.60996595359;3720.1071742781537;3327.4842399428126;3334.866605335808;3336.59960804705;3380.4084285250474;3409.16475463513;4367.737935723867;4485.730856148642;4494.797734101973;4515.525869783691;4530.139273538017;4743;4770.403699537558;4773.737444440589;4855.660103792771;4901.632377571696;4549.27211646135;4561.840335588305;4575.81696732127;4618.953810461852;4656.767161641905;3915.5888631693833;4039.8788036358956;4062.4921884764403;4112.403701463271;4132.752034877917;4743.976280118577;4891.241857512091;4930.1865192243595;4955.083309587666;4961.578265847299;4634.629229661551;4774.069056534081;4798.136335459651;4861.1979023460735;4883.438404583376;4724.4094488188975;4766.213574760126;4818.734969576707;4874.610031197567;4887.047025829929;4603.286490593963;4624.28323609841;4669.649776266861;4672.439307283148;4697.459792123949;4661.743604101807;4726.19654658702;4726.952730472789;4743.430788305287;4829.5653391194965;4479.148961697267;4524.253498172765;4579.381783459324;4608.907821843612;4610.608098311681;4625.976870115628;4644.140833945731;4665.043666048384;4684.672072954861;4701.694389864648;4197.643200328006;4207.116505533872;4500.077484115814;4517.706349087299;4594.425696787902;4457.242268814374;4551.385562949092;4567.314902764612;4573.153966516205;4587.839425620087;4457.576530229752;4463.419755431773;4497.662675299301;4502.954970450384;4551.499335073073 16:15:53 INFO - 2015-11-17 16:15:53,702 DEBUG : BROWSER_OUTPUT: |1;ext.html;461.32646336348927;481.4992407895787;483.6300230323803;494.37214737283637;507.96375394195843;30766.84616576917;31721.365572688534;31887.36225275493;31920.36159276813;31956.680433195692;35125.47311790325;36263;36354.45468317977;36370.63629363706;36399;7764.572948487817;7896.328812050982;8028.839423211532;8038.799030024237;8050.959745201266;7765.339946104588;7803.60981950903;7841.333486653612;7922.247386498302;7934.087579928296;7782.9221707783045;7889.447738658297;7964.800879978018;7972.322352600036;7983.880241796378;7757.534547927143;7782.338501227402;7787.727429539939;7863.56750378729;7919.564423956737;7617.314441700273;7698.461107722462;7747.767566973;7765.184655611192;7807.6486558105025;33513.497297540554;33746.325073498636;33783.83108084444;33977.15057123567;34245.31509369799;2541.606051062088;2586.6378706981036;2738.0964281786964;2921.35730139369;3042.0721679887624;23218.419539511477;23323.74551036527;23342;23553.41116472085;23827.404314892094;2008.8694234874686;2010.0452285164577;2032.4613977296028;2038.1439795286014;2123.607132680459;225111;226388;226692;226899;227501.99999999834;43798;45744;48603.78490537694;48849.5115048845;49253.75373123112;51286.97426051458;52331.47668523342;52529;52710.209346859825;52951.20573191405;13220.33898305081;13347.265900375378;13362.665933351744;13403.128796628189;13415.463381464631;10208.693739187836;10279.845802312972;10296.485175741183;10341.172706183488;10359.067683908484;15679.764803527956;15857.762133568005;15873.603159920864;15877.603059923595;15992.04047757115;7133.964330178316;7334.853302933911;7362.263773622595;7381.594012329266;7406.259374062551;720.7081132141491;820.9179082091744;822.296936119621;823.6005537314397;897.2597606974142;23444.88277558601;23704.525909481712;23782.7621723784;23796.167134150222;23912.521749564912;814.0150417994294;868.4268382867277;868.8957325121025;955.3312681123242;1016.9880968436453;12289.1397602167;12413.31726755019;12427.937860310822;12503.124781265224;12512.436940337706;252120;257078;257822;258955;261743;44659;45102.77448612736;45419.31871021937;45431.31853022207;45445.318320225226;1193.5892864218104;1200.3758045816128;1200.7238335182956;1202.3507306054807;1213.3084142038954;23198.956046978263;23563.52872942566;23641.81790910482;23687.763122368557;23726.762732372456;39688.00779980524;39733.40399893946;39842.80078599588;40082.39876401798;40157;230003;232275;233867;234058;234839;26451.60322595124;27057.1882843515;27284.454310913272;27316.31709207286;27507;31946.68053319437;32124.518132228503;32229.677703223606;32760;32881.177970550925;26839.597406039316;27404.314892127855;28143.43713125767;28253.15240542787;28429.289267768472;27113.72886271191;27347.179584612495;27359.45281094407;27742.722572774015;27870.3032424191;28735.425291493633;29109.41781164407;29722;29865;29956.400871982874;24499.38751531226;24533.264002079966;25420.237392878244;25423.6186457207;25960.870195648902;19161.712574311117;19205.519862003563;19419.51451213731;19425.51436214106;19666.50833729168 16:15:53 INFO - 2015-11-17 16:15:53,704 DEBUG : BROWSER_OUTPUT: |2;jquery.html;283.93895312507806;284.3914023988663;285.9799814013019;287.1500358937545;293.7179212736405;12828.230306181613;14340.211288379149;14715.190664513448;14719.484818031371;15181.240937953085;14449.78325325121;14714.63213419665;15368.385264589402;15434.459793907215;15482.535523934272;4493.932591011137;4550.772461376942;4632.0967411354795;4637.814487420499;4675.135100006492;4556.1343344764555;4589.816407343702;4612.60792832608;4613.861584152481;4616.30755386693;3295.8187299698507;4556.589906908378;4561.247394179956;4817.181079216524;5080.745962701869;4993.800247990076;5054.342935418372;5066.645334826564;5077.873053173664;5094.286799848006;4264.040590867061;4349.69552131351;4360.367746676714;4364.716293440948;4369.6285815705705;17217.913910430492;17432.733744613244;17500.737488937677;17612.207450664624;17786.644267114716;1382.0947279531822;1484.7995520604688;1616.7898173237404;1735.8871673341318;1834.9908250458795;7748.728794492222;7885.842283154362;7966.601669916481;7987.720429784929;8050.4364694471415;1293.6765808547864;1316.2826259688493;1323.133347657286;1341.222091187109;1347.986520134796;48257;48365;49419;49688;50424.49575504235;5325.147976323769;5379.623426360117;5396.568274538027;5452.563794896399;5458.372287186945;6111.449969502677;6118.755249789959;6196.442320191204;6197.783077592353;6200.131981522591;4494.258447356149;4564.2012647786505;4578.175928332932;4585.656075794329;4652.278896771006;4923.8276660316715;4932.358793356912;4939.2838038484215;4961.156603377434;5041.521055499722;2418.5646583614766;2462.753724627523;2462.876856157185;2471.468634243646;2497.7876880465365;868.1492137705085;872.4939535069644;875.2385424680568;877.1009715042132;921.9400738951947;347.1858491836639;349.4880000798791;353.9805310707884;366.57477326301364;367.38096307721577;8194.918050819535;8304.460210086325;8525.14748525155;8603.5698215089;8626.137386261324;355.4650251371669;356.62019948754494;360.48810688821413;362.75332773714126;364.4733360294402;4561.817527298937;4646.97676511622;4720.457147428021;4764.880877978078;4800.639952003614;432312;445479;477205;483756;484389;57724.422755771906;60368;60870.69564652237;61235;63071;360.12489650149865;360.2866324677154;363.5128927237462;364.02622983518455;366.12678761154837;7850.33272171849;7879.0939042010905;7916.445848790529;8036.23655752726;8106.067802202822;28130;28491.572626411034;28696.139115826558;28741.521107162767;28802.855985720777;40869.79565102155;41450;41502.43426974404;41595.7920210397;41741;5037.622178336713;5131.025105229995;5133.383993920604;5198.766055527586;5200.349956255468;9496.762580935532;9573.808523829344;9701.70894873155;9923;9935.403875767477;7882.290593846581;8478.83042339162;8483.703070392507;8511.276541493795;8648.654053837776;6699.598024118569;8018.879716804136;8162;8280.958595206985;8317.95841020791;8355;8376.246137847624;8394.1605839418;8590.527520986405;8606.225439710455;4913.729744863924;5067.569256613229;5096.311997880387;5172.974135129451;5177.974110129425;8304.169583041648;8308.379865926086;8404.453710508797;8408.117147699404;8511.702090426805 16:15:53 INFO - 2015-11-17 16:15:53,707 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1460.620238737928;1462.9414823407064;1507.9095254284744;1509.5169545745366;1537.5925379774362;5499.395066542677;5596.692181929992;6175.25896892373;6447.161868957029;6467.5472716909835;5887.205227294314;5999.400059993998;6098.7865424710035;6101.023836186211;6103.908441373383;1782.0733218726255;1787.6603445345409;1813.07533158089;1814.2017512294549;1814.3014939248353;1782.3583509936414;1783.6343549572307;1810.9858479251661;1812.5196822841958;1844.9631007379912;1795.64087182564;1825.3337531800864;1828;1849.195599914035;1850.9259629614799;1720.501054694137;1752.3253547384222;1775.520609435458;1775.8312960268818;1798.2627122879621;1802.8828126171888;1841.2819000589782;1841.6316736652589;1843.8524918006526;1868.4768264885718;6125.448709616156;6133.172021777048;6199.163112979735;6201.658908760016;6204.038374052029;3703.740738148331;3867.825947832326;3872.5740168581433;3874.3994680824517;3875.1280961783655;2025.1899240303849;2065.2874758208395;2278.8176945844293;2338.6141286687675;2354.5290941811536;732.641005907107;1263.387257180267;1284.9743005139844;1293.6377814212035;1380.2201756007823;8003.799905002422;8030.839383212361;8078.555679437687;8106;8108.513489190667;3188.2507610711464;3307.9503807442907;3342.4317865962844;3351.0952042948265;3353;6708.262091170065;6719.26088130315;6727.865442691119;6734.730610775514;6756.898646520306;3731.794751288651;3787.223619158121;3789.1663833956486;3791.1659434924272;3792.1088544192094;3508.245727168671;3520;3520.1023738946915;3533.8939831805087;3537.876174333886;2599.961000584955;2645.7354264573773;2664.77349425301;2665.6667916510437;2665.9600105998425;778.4239662649599;785.9017622797151;791.4301702773994;796.366888323784;799.3724925933114;1053.1627356251797;1097.1990446973593;1107.5791199344358;1135.6649788312302;1136.1478890831877;5804.158397032406;5903.35063143054;5994.970025149846;5998.070299103646;6016.217891674054;374.69649583836633;375.56434535938183;377.2059814091353;378.50982977044794;380.1351924372076;4581.679282450196;4629.675922685447;4648.558386953234;4703.17694403478;4708.387909571734;7155.749548765768;7227.349538541556;7331.816704582321;7398.593077380796;7443.702251909971;7225.349718525358;7312.341889229889;7369.926300737031;7382;7394.963025184839;5758.193852860519;5826.504747096459;5843.678597677083;5865.88268234633;5896.823095307148;5662.57530685192;5706.9714651426475;5741.569382296261;5769.68266745333;5770.567207459373;6491.870162596816;6491.935080649322;6527.445167160845;6642.867142657024;6643.900341494785;6300.149479820349;6703.93296067033;6704.564203326768;6713.328667133248;6822.351876571718;5388.191771234347;5392.676439413648;5393.029254734185;5461.972690136524;5475.534579560623;5775.191473193672;5784.855378615568;5801.36185019639;5843.181954526284;5851.590388672752;5373.623846330719;5453.291072160752;5459.781608735606;5499;5579.69311687861;5248.921266180934;5336.386315573759;5407.702576358338;5450.945490545044;5467.9453205467435;5446.237526746179;5478.561715062865;5490.5882058844945;5496.367917689517;5558.24963629921;4908.509149085063;4959.429665588504;5038.01758657073;5038.118329292286;5043;4397.098594787997;4448.088141930961;5003.54968052877;5040.621953353587;5117.8720531987 16:15:53 INFO - 2015-11-17 16:15:53,709 DEBUG : BROWSER_OUTPUT: |4;prototype.html;247.49634493805107;264.1257437880614;268.0831556078213;270.388921038453;272.0424107142857;5307.840764777054;5370.382406023304;5473.452654734525;5491.670499770016;5537.141743029832;5234.555062819655;5354.437784032679;5388.0570900092525;5472.72636368182;5502.257195278637;4075.735077219971;4075.7976396962817;4121.258173528764;4127.23646125467;4169.4162817205615;4111.342185250361;4123.0310876943895;4144.772037537934;4170.416141740159;4182.477190351206;4006.1587066716024;4050.3519436890106;4058.0666446717273;4061.7969101544804;4130.91738165238;4051.149258655671;4054.412110243998;4067.08490589615;4107.691923105779;4124.938125928114;3488.529048578435;3502.4921386399083;3538.433850583894;3540.7521473496868;3557.3774589447003;5205.193195054772;5258.579313654898;5316.9734151329385;5318.867028324285;5330.040592693314;4422.889427764299;4634.490206077328;4642.489326174118;4696.53034696531;4702.012577358759;5365.302510673588;5554.389017208145;5597.804076857331;5700.885982280372;5749;3815.4086116651965;3823.9044023899346;3848.6536211741077;3853.2293541291856;3875.65119139276;5965.254343207099;5966.134910437962;5998.25021872266;6022.909656355202;6031.155638210654;3787.16682329887;3899.1032062625754;3902.102516421239;3951.723379363417;3973.8609148679657;3970.722049456568;3981.6217459341315;3990.700697447703;4035.535913369941;4050.8987275318354;4632.119897219518;4646.558576935186;4686.5782079613;4688.991866748665;4695.229814409515;5692.060809966392;5726.8546290742015;5768.884622307531;5772.7113644317615;5785.797497087582;1392.6727219103502;1411.5976946570179;1411.8164638596916;1419.1201455097698;1419.282667971745;908.6637943960777;921.2215677752289;930.7952250504878;934.9672761453317;937.5124935033881;5513.145462453326;5527.309086364205;5527.861803454945;5532.004239236976;5535.308086489189;5934.198883150806;5947;5996;5997.250343707036;6003.969980150071;5473.233747275384;5526.392096869341;5547.528460080857;5556.666600004012;5565.777368905198;3144.0567829651013;3173.777835551535;3210.614726232867;3252.9674703253136;3255.5279484474618;6128.3565225651555;6194.783182588588;6197.411245931629;6252.968735156295;6276.403741644536;6161.260648722182;6220.440160385587;6233.252009758768;6240.282367527792;6240.625562466266;5976.372480889531;6071.483923866344;6254.437100661054;6256.843578910563;6260.342664020212;5882.705864706833;5995.430434108753;5996.820095397145;6055.6063855849225;6091;5875.559333049953;5890.0575907856255;5933.22868027171;5942.554308426799;5962.612430192024;6169.56813023102;6188.1027251049245;6266.530010249341;6280.497560195265;6284.151639528605;3737.2151848112203;3862.227554489057;3873.5158105236846;3874.5544262409057;3898.4152377142523;5945.910811337747;5954.37479064692;5973.5519836013345;5992.370801065826;6015.4586087252355;5747.626404283708;5767.625104368202;5788.855278618068;5798.710064496842;5835.44563266489;5561.860953476195;5704.828855134353;5730.598858079894;5805.390434004369;5842.444967728059;5589.385167631476;5603.93525230205;5667.971660141673;5672.886542269214;5676.801311954062;5731.598788084794;5750.741216645345;5755.510781583613;5815.738291776965;5823.708814559171;5444.128939369682;5671.262735844314;5680.233168522197;5725.8568535786935;5727.5417966561745 16:15:53 INFO - 2015-11-17 16:15:53,714 DEBUG : BROWSER_OUTPUT: |5;yui.html;601.8375038739543;616.291265045198;620.7548018532677;632.8576070384164;650.1937597379249;11581.478833452495;11907.7618447631;12062.758744825098;13620.046596738232;13655;12342.753144937118;12428.316442595653;12502.374881255924;12520.874791252085;12529.310887901185;513.3608657221746;583.3146053387275;711.3029231353252;720.794573546538;734.7097896330946;717.5085066729281;720.8486217894249;725.4994054102652;739.0023468317781;739.8150462384403;752.8419032003259;757.5606148433923;757.746155038063;759.0853022108374;770.5800338815332;753.8040109571551;754.0611938137027;757.2578872704726;760.2397602397602;765.5368502056232;550.7631718361104;552.3344370034099;552.505507570722;556.1768582497886;557.6486813307631;11462.942685286604;11571.884281157165;11577.305361678325;11609.535618575246;11723.648290551297;7379.9262007379775;7669.769906902746;7971.40214483916;8006.519608823431;8136.796580085545;7504.699812007513;7517.17311095779;7741.4193935454505;7780.844383112362;7785.649645765954;2421.6367544868235;2480.4543000540034;2491.676082109332;2515.1071369663687;2554.3103362092315;39711.40432893509;39814.0837516946;40185;40206.59793402028;40617.18765624671;5488.615796894179;5579.107342825209;5696.088625819932;5803.274590676166;5846.181534585162;9716.75708107303;9727.951360243154;9850.605975761033;9851.408915465096;9869.851952220723;4677.789499472532;4697.060587882437;4736;4942.703437793743;5005.5745261653165;2985.223841801104;3157.589513363248;3198.392305461955;3294.472884338494;3344.782589131699;2194.034624765098;2201.2845825106906;2207.7461091974305;2215.4239897626735;2222.688823564702;334.0396360463667;340.3193612774451;340.40089442581234;341.60715177545524;342.1855982761013;411.50824764406246;470.70110479845545;485.9684120532154;491.89178380756175;525.5060243371219;6486.318936511599;6593.8351541210895;6623.30455302196;6781.728730850809;6790.5925644461495;378.96968242541084;440.58144762475774;490.7350030983229;514.2132537218063;524.9081410753103;3000.234940090263;3067.417190733798;3153.716165545112;3163.9683603164135;3214.8071115732664;45991.31013034807;46704.5329546707;46752.532474674816;47313;47338.289925651145;40667.389989150186;40779;42799;45362.77318613386;45433.77283113563;40465.59534404677;40955.97610059713;40992.59007409888;41053.589464104974;41395;6836.38472537474;7143.785686429415;7225.060742103493;7230.710771569078;7287.429159711809;29401;30081.849590752783;30220.395592087596;30801.537976929914;31148.68851311458;39550;39737.80131099326;41004.79497602493;41193;41578.37632435576;6584.308647591934;6599.67001649906;6648.800535983928;6718.093057437183;6747.325267473213;9231;9538.95230523843;9544.665936692183;9607.13535781783;10073.294869359075;8793.692220772242;8875;8890.822183556422;9260.56723336965;9668.226541876493;9168.724938251864;9228.907710922806;9248.953755231181;9323.254139668674;9447.716568502956;8696.347773917108;8715;8901;9044.954775226344;9064.954675226581;7348.889766653398;7354.227806080498;7624.390048796194;7714.80420534818;7718.459707820399;7126.608036557832;7568.172507169559;7574.848503030019;7990.520568765893;8068.1528439513 16:15:53 INFO - 2015-11-17 16:15:53,714 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:15:53 INFO - 2015-11-17 16:15:53,714 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:15:53 INFO - 2015-11-17 16:15:53,714 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,299 16:15:53 INFO - 2015-11-17 16:15:53,714 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:15:53 INFO - 2015-11-17 16:15:53,714 DEBUG : BROWSER_OUTPUT: __startTimestamp1447805753695__endTimestamp 16:15:53 INFO - 2015-11-17 16:15:53,715 DEBUG : BROWSER_OUTPUT: 16:15:53 INFO - 2015-11-17 16:15:53,715 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:15:53 INFO - 2015-11-17 16:15:53,715 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:15:53 INFO - 2015-11-17 16:15:53,715 DEBUG : BROWSER_OUTPUT: 16:15:53 INFO - 2015-11-17 16:15:53,715 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4386.63 Median:4524.25 stddev:469.88 (10.4%) stddev-sans-first:448.73 16:15:53 INFO - 2015-11-17 16:15:53,715 DEBUG : BROWSER_OUTPUT: Values: 2551.5 2601.8 2612.8 2658.9 2663.4 4196.9 4349.2 4389.9 4420.4 4519.1 4179.7 4277.6 4348.3 4356.4 4405.1 4053.3 4079.2 4101.8 4144.9 4173.1 4043.8 4069.3 4103.4 4108.8 4116.7 3883.3 3940.6 4038.9 4086.0 4129.7 4093.9 4106.9 4130.4 4152.9 4178.7 4086.9 4096.6 4120.8 4121.5 4128.9 4077.3 4174.2 4375.6 4427.0 4428.2 4688.0 4734.2 4783.8 4792.1 4807.0 4552.1 4762.5 4787.8 4846.5 4869.8 4328.2 4399.9 4407.1 4465.8 4470.4 4736.8 4759.4 4778.7 4803.8 4816.6 4320.6 4361.3 4564.1 4581.4 4633.7 4469.9 4541.5 4582.3 4596.0 4600.4 4695.3 4697.3 4733.9 4765.0 4820.2 4564.4 4616.1 4640.3 4682.2 4694.2 3670.3 3679.0 3692.0 3714.6 3720.1 3327.5 3334.9 3336.6 3380.4 3409.2 4367.7 4485.7 4494.8 4515.5 4530.1 4743.0 4770.4 4773.7 4855.7 4901.6 4549.3 4561.8 4575.8 4619.0 4656.8 3915.6 4039.9 4062.5 4112.4 4132.8 4744.0 4891.2 4930.2 4955.1 4961.6 4634.6 4774.1 4798.1 4861.2 4883.4 4724.4 4766.2 4818.7 4874.6 4887.0 4603.3 4624.3 4669.6 4672.4 4697.5 4661.7 4726.2 4727.0 4743.4 4829.6 4479.1 4524.3 4579.4 4608.9 4610.6 4626.0 4644.1 4665.0 4684.7 4701.7 4197.6 4207.1 4500.1 4517.7 4594.4 4457.2 4551.4 4567.3 4573.2 4587.8 4457.6 4463.4 4497.7 4503.0 4551.5 16:15:53 INFO - 2015-11-17 16:15:53,716 DEBUG : BROWSER_OUTPUT: 16:15:53 INFO - 2015-11-17 16:15:53,716 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38048.06 Median:16015.39 stddev:62496.02 (390.2%) stddev-sans-first:62607.62 16:15:53 INFO - 2015-11-17 16:15:53,716 DEBUG : BROWSER_OUTPUT: Values: 461.3 481.5 483.6 494.4 508.0 30766.8 31721.4 31887.4 31920.4 31956.7 35125.5 36263.0 36354.5 36370.6 36399.0 7764.6 7896.3 8028.8 8038.8 8051.0 7765.3 7803.6 7841.3 7922.2 7934.1 7782.9 7889.4 7964.8 7972.3 7983.9 7757.5 7782.3 7787.7 7863.6 7919.6 7617.3 7698.5 7747.8 7765.2 7807.6 33513.5 33746.3 33783.8 33977.2 34245.3 2541.6 2586.6 2738.1 2921.4 3042.1 23218.4 23323.7 23342.0 23553.4 23827.4 2008.9 2010.0 2032.5 2038.1 2123.6 225111.0 226388.0 226692.0 226899.0 227502.0 43798.0 45744.0 48603.8 48849.5 49253.8 51287.0 52331.5 52529.0 52710.2 52951.2 13220.3 13347.3 13362.7 13403.1 13415.5 10208.7 10279.8 10296.5 10341.2 10359.1 15679.8 15857.8 15873.6 15877.6 15992.0 7134.0 7334.9 7362.3 7381.6 7406.3 720.7 820.9 822.3 823.6 897.3 23444.9 23704.5 23782.8 23796.2 23912.5 814.0 868.4 868.9 955.3 1017.0 12289.1 12413.3 12427.9 12503.1 12512.4 252120.0 257078.0 257822.0 258955.0 261743.0 44659.0 45102.8 45419.3 45431.3 45445.3 1193.6 1200.4 1200.7 1202.4 1213.3 23199.0 23563.5 23641.8 23687.8 23726.8 39688.0 39733.4 39842.8 40082.4 40157.0 230003.0 232275.0 233867.0 234058.0 234839.0 26451.6 27057.2 27284.5 27316.3 27507.0 31946.7 32124.5 32229.7 32760.0 32881.2 26839.6 27404.3 28143.4 28253.2 28429.3 27113.7 27347.2 27359.5 27742.7 27870.3 28735.4 29109.4 29722.0 29865.0 29956.4 24499.4 24533.3 25420.2 25423.6 25960.9 19161.7 19205.5 19419.5 19425.5 19666.5 16:15:53 INFO - 2015-11-17 16:15:53,716 DEBUG : BROWSER_OUTPUT: 16:15:53 INFO - 2015-11-17 16:15:53,717 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22928.24 Median:4808.91 stddev:76163.82 (1583.8%) stddev-sans-first:76358.50 16:15:53 INFO - 2015-11-17 16:15:53,717 DEBUG : BROWSER_OUTPUT: Values: 283.9 284.4 286.0 287.2 293.7 12828.2 14340.2 14715.2 14719.5 15181.2 14449.8 14714.6 15368.4 15434.5 15482.5 4493.9 4550.8 4632.1 4637.8 4675.1 4556.1 4589.8 4612.6 4613.9 4616.3 3295.8 4556.6 4561.2 4817.2 5080.7 4993.8 5054.3 5066.6 5077.9 5094.3 4264.0 4349.7 4360.4 4364.7 4369.6 17217.9 17432.7 17500.7 17612.2 17786.6 1382.1 1484.8 1616.8 1735.9 1835.0 7748.7 7885.8 7966.6 7987.7 8050.4 1293.7 1316.3 1323.1 1341.2 1348.0 48257.0 48365.0 49419.0 49688.0 50424.5 5325.1 5379.6 5396.6 5452.6 5458.4 6111.4 6118.8 6196.4 6197.8 6200.1 4494.3 4564.2 4578.2 4585.7 4652.3 4923.8 4932.4 4939.3 4961.2 5041.5 2418.6 2462.8 2462.9 2471.5 2497.8 868.1 872.5 875.2 877.1 921.9 347.2 349.5 354.0 366.6 367.4 8194.9 8304.5 8525.1 8603.6 8626.1 355.5 356.6 360.5 362.8 364.5 4561.8 4647.0 4720.5 4764.9 4800.6 432312.0 445479.0 477205.0 483756.0 484389.0 57724.4 60368.0 60870.7 61235.0 63071.0 360.1 360.3 363.5 364.0 366.1 7850.3 7879.1 7916.4 8036.2 8106.1 28130.0 28491.6 28696.1 28741.5 28802.9 40869.8 41450.0 41502.4 41595.8 41741.0 5037.6 5131.0 5133.4 5198.8 5200.3 9496.8 9573.8 9701.7 9923.0 9935.4 7882.3 8478.8 8483.7 8511.3 8648.7 6699.6 8018.9 8162.0 8281.0 8318.0 8355.0 8376.2 8394.2 8590.5 8606.2 4913.7 5067.6 5096.3 5173.0 5178.0 8304.2 8308.4 8404.5 8408.1 8511.7 16:15:53 INFO - 2015-11-17 16:15:53,717 DEBUG : BROWSER_OUTPUT: 16:15:53 INFO - 2015-11-17 16:15:53,717 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4271.15 Median:5355.01 stddev:2179.68 (40.7%) stddev-sans-first:2175.56 16:15:53 INFO - 2015-11-17 16:15:53,718 DEBUG : BROWSER_OUTPUT: Values: 1460.6 1462.9 1507.9 1509.5 1537.6 5499.4 5596.7 6175.3 6447.2 6467.5 5887.2 5999.4 6098.8 6101.0 6103.9 1782.1 1787.7 1813.1 1814.2 1814.3 1782.4 1783.6 1811.0 1812.5 1845.0 1795.6 1825.3 1828.0 1849.2 1850.9 1720.5 1752.3 1775.5 1775.8 1798.3 1802.9 1841.3 1841.6 1843.9 1868.5 6125.4 6133.2 6199.2 6201.7 6204.0 3703.7 3867.8 3872.6 3874.4 3875.1 2025.2 2065.3 2278.8 2338.6 2354.5 732.6 1263.4 1285.0 1293.6 1380.2 8003.8 8030.8 8078.6 8106.0 8108.5 3188.3 3308.0 3342.4 3351.1 3353.0 6708.3 6719.3 6727.9 6734.7 6756.9 3731.8 3787.2 3789.2 3791.2 3792.1 3508.2 3520.0 3520.1 3533.9 3537.9 2600.0 2645.7 2664.8 2665.7 2666.0 778.4 785.9 791.4 796.4 799.4 1053.2 1097.2 1107.6 1135.7 1136.1 5804.2 5903.4 5995.0 5998.1 6016.2 374.7 375.6 377.2 378.5 380.1 4581.7 4629.7 4648.6 4703.2 4708.4 7155.7 7227.3 7331.8 7398.6 7443.7 7225.3 7312.3 7369.9 7382.0 7395.0 5758.2 5826.5 5843.7 5865.9 5896.8 5662.6 5707.0 5741.6 5769.7 5770.6 6491.9 6491.9 6527.4 6642.9 6643.9 6300.1 6703.9 6704.6 6713.3 6822.4 5388.2 5392.7 5393.0 5462.0 5475.5 5775.2 5784.9 5801.4 5843.2 5851.6 5373.6 5453.3 5459.8 5499.0 5579.7 5248.9 5336.4 5407.7 5450.9 5467.9 5446.2 5478.6 5490.6 5496.4 5558.2 4908.5 4959.4 5038.0 5038.1 5043.0 4397.1 4448.1 5003.5 5040.6 5117.9 16:15:53 INFO - 2015-11-17 16:15:53,719 DEBUG : BROWSER_OUTPUT: 16:15:53 INFO - 2015-11-17 16:15:53,720 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4789.82 Median:5529.93 stddev:1487.78 (26.9%) stddev-sans-first:1452.37 16:15:53 INFO - 2015-11-17 16:15:53,722 DEBUG : BROWSER_OUTPUT: Values: 247.5 264.1 268.1 270.4 272.0 5307.8 5370.4 5473.5 5491.7 5537.1 5234.6 5354.4 5388.1 5472.7 5502.3 4075.7 4075.8 4121.3 4127.2 4169.4 4111.3 4123.0 4144.8 4170.4 4182.5 4006.2 4050.4 4058.1 4061.8 4130.9 4051.1 4054.4 4067.1 4107.7 4124.9 3488.5 3502.5 3538.4 3540.8 3557.4 5205.2 5258.6 5317.0 5318.9 5330.0 4422.9 4634.5 4642.5 4696.5 4702.0 5365.3 5554.4 5597.8 5700.9 5749.0 3815.4 3823.9 3848.7 3853.2 3875.7 5965.3 5966.1 5998.3 6022.9 6031.2 3787.2 3899.1 3902.1 3951.7 3973.9 3970.7 3981.6 3990.7 4035.5 4050.9 4632.1 4646.6 4686.6 4689.0 4695.2 5692.1 5726.9 5768.9 5772.7 5785.8 1392.7 1411.6 1411.8 1419.1 1419.3 908.7 921.2 930.8 935.0 937.5 5513.1 5527.3 5527.9 5532.0 5535.3 5934.2 5947.0 5996.0 5997.3 6004.0 5473.2 5526.4 5547.5 5556.7 5565.8 3144.1 3173.8 3210.6 3253.0 3255.5 6128.4 6194.8 6197.4 6253.0 6276.4 6161.3 6220.4 6233.3 6240.3 6240.6 5976.4 6071.5 6254.4 6256.8 6260.3 5882.7 5995.4 5996.8 6055.6 6091.0 5875.6 5890.1 5933.2 5942.6 5962.6 6169.6 6188.1 6266.5 6280.5 6284.2 3737.2 3862.2 3873.5 3874.6 3898.4 5945.9 5954.4 5973.6 5992.4 6015.5 5747.6 5767.6 5788.9 5798.7 5835.4 5561.9 5704.8 5730.6 5805.4 5842.4 5589.4 5603.9 5668.0 5672.9 5676.8 5731.6 5750.7 5755.5 5815.7 5823.7 5444.1 5671.3 5680.2 5725.9 5727.5 16:15:53 INFO - 2015-11-17 16:15:53,722 DEBUG : BROWSER_OUTPUT: 16:15:53 INFO - 2015-11-17 16:15:53,722 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11199.72 Median:554.34 stddev:13720.32 (2475.1%) stddev-sans-first:13735.73 16:15:53 INFO - 2015-11-17 16:15:53,722 DEBUG : BROWSER_OUTPUT: Values: 601.8 616.3 620.8 632.9 650.2 11581.5 11907.8 12062.8 13620.0 13655.0 12342.8 12428.3 12502.4 12520.9 12529.3 513.4 583.3 711.3 720.8 734.7 717.5 720.8 725.5 739.0 739.8 752.8 757.6 757.7 759.1 770.6 753.8 754.1 757.3 760.2 765.5 550.8 552.3 552.5 556.2 557.6 11462.9 11571.9 11577.3 11609.5 11723.6 7379.9 7669.8 7971.4 8006.5 8136.8 7504.7 7517.2 7741.4 7780.8 7785.6 2421.6 2480.5 2491.7 2515.1 2554.3 39711.4 39814.1 40185.0 40206.6 40617.2 5488.6 5579.1 5696.1 5803.3 5846.2 9716.8 9728.0 9850.6 9851.4 9869.9 4677.8 4697.1 4736.0 4942.7 5005.6 2985.2 3157.6 3198.4 3294.5 3344.8 2194.0 2201.3 2207.7 2215.4 2222.7 334.0 340.3 340.4 341.6 342.2 411.5 470.7 486.0 491.9 525.5 6486.3 6593.8 6623.3 6781.7 6790.6 379.0 440.6 490.7 514.2 524.9 3000.2 3067.4 3153.7 3164.0 3214.8 45991.3 46704.5 46752.5 47313.0 47338.3 40667.4 40779.0 42799.0 45362.8 45433.8 40465.6 40956.0 40992.6 41053.6 41395.0 6836.4 7143.8 7225.1 7230.7 7287.4 29401.0 30081.8 30220.4 30801.5 31148.7 39550.0 39737.8 41004.8 41193.0 41578.4 6584.3 6599.7 6648.8 6718.1 6747.3 9231.0 9539.0 9544.7 9607.1 10073.3 8793.7 8875.0 8890.8 9260.6 9668.2 9168.7 9228.9 9249.0 9323.3 9447.7 8696.3 8715.0 8901.0 9045.0 9065.0 7348.9 7354.2 7624.4 7714.8 7718.5 7126.6 7568.2 7574.8 7990.5 8068.2 16:15:53 INFO - 2015-11-17 16:15:53,722 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:15:53 INFO - 2015-11-17 16:15:53,722 DEBUG : BROWSER_OUTPUT: 16:15:54 INFO - 2015-11-17 16:15:54,414 INFO : Browser exited with error code: 0 16:15:54 INFO - 2015-11-17 16:15:54,447 INFO : Completed test dromaeo_css (00:18:31) 16:15:54 INFO - 2015-11-17 16:15:54,447 INFO : Starting test kraken 16:15:54 INFO - 2015-11-17 16:15:54,448 DEBUG : operating with platform_type : mac_ 16:15:54 INFO - 2015-11-17 16:15:54,448 INFO : Initialising browser for kraken test... 16:15:54 INFO - 2015-11-17 16:15:54,462 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmpXKSXdH/profile http://localhost:49487/getInfo.html 16:15:57 INFO - 2015-11-17 16:15:57,802 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:15:57 INFO - 2015-11-17 16:15:57,802 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:15:57 INFO - 2015-11-17 16:15:57,802 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:15:57 INFO - 2015-11-17 16:15:57,802 DEBUG : BROWSER_OUTPUT: __metrics 16:15:58 INFO - 2015-11-17 16:15:58,517 INFO : Browser initialized. 16:15:58 INFO - 2015-11-17 16:15:58,517 INFO : Running cycle 1/1 for kraken test... 16:15:58 INFO - 2015-11-17 16:15:58,518 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmpXKSXdH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:16:10 INFO - 2015-11-17 16:16:10,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 242524160 16:16:10 INFO - 2015-11-17 16:16:10,730 DEBUG : BROWSER_OUTPUT: 16:16:13 INFO - 2015-11-17 16:16:13,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49487/tests/kraken/driver.html?testName=audio-beat-detection) 16:16:14 INFO - 2015-11-17 16:16:14,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 261439488 16:16:14 INFO - 2015-11-17 16:16:14,253 DEBUG : BROWSER_OUTPUT: 16:16:17 INFO - 2015-11-17 16:16:17,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49487/tests/kraken/driver.html?testName=audio-dft) 16:16:17 INFO - 2015-11-17 16:16:17,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 268816384 16:16:17 INFO - 2015-11-17 16:16:17,908 DEBUG : BROWSER_OUTPUT: 16:16:21 INFO - 2015-11-17 16:16:21,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49487/tests/kraken/driver.html?testName=audio-fft) 16:16:21 INFO - 2015-11-17 16:16:21,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 269008896 16:16:21 INFO - 2015-11-17 16:16:21,809 DEBUG : BROWSER_OUTPUT: 16:16:23 INFO - 2015-11-17 16:16:23,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49487/tests/kraken/driver.html?testName=audio-oscillator) 16:16:24 INFO - 2015-11-17 16:16:24,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 268951552 16:16:24 INFO - 2015-11-17 16:16:24,589 DEBUG : BROWSER_OUTPUT: 16:16:26 INFO - 2015-11-17 16:16:26,993 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49487/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:16:27 INFO - 2015-11-17 16:16:27,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 269021184 16:16:27 INFO - 2015-11-17 16:16:27,574 DEBUG : BROWSER_OUTPUT: 16:16:31 INFO - 2015-11-17 16:16:31,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49487/tests/kraken/driver.html?testName=imaging-darkroom) 16:16:31 INFO - 2015-11-17 16:16:31,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 267845632 16:16:31 INFO - 2015-11-17 16:16:31,653 DEBUG : BROWSER_OUTPUT: 16:16:35 INFO - 2015-11-17 16:16:35,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49487/tests/kraken/driver.html?testName=imaging-desaturate) 16:16:35 INFO - 2015-11-17 16:16:35,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 266272768 16:16:35 INFO - 2015-11-17 16:16:35,888 DEBUG : BROWSER_OUTPUT: 16:16:39 INFO - 2015-11-17 16:16:39,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49487/tests/kraken/driver.html?testName=json-parse-financial) 16:16:39 INFO - 2015-11-17 16:16:39,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 266727424 16:16:39 INFO - 2015-11-17 16:16:39,748 DEBUG : BROWSER_OUTPUT: 16:16:41 INFO - 2015-11-17 16:16:41,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49487/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:16:42 INFO - 2015-11-17 16:16:42,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 267907072 16:16:42 INFO - 2015-11-17 16:16:42,157 DEBUG : BROWSER_OUTPUT: 16:16:44 INFO - 2015-11-17 16:16:44,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49487/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:16:44 INFO - 2015-11-17 16:16:44,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 268181504 16:16:44 INFO - 2015-11-17 16:16:44,863 DEBUG : BROWSER_OUTPUT: 16:16:47 INFO - 2015-11-17 16:16:47,233 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49487/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:16:47 INFO - 2015-11-17 16:16:47,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 268472320 16:16:47 INFO - 2015-11-17 16:16:47,825 DEBUG : BROWSER_OUTPUT: 16:16:50 INFO - 2015-11-17 16:16:50,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:16:51 INFO - 2015-11-17 16:16:51,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 268689408 16:16:51 INFO - 2015-11-17 16:16:51,426 DEBUG : BROWSER_OUTPUT: 16:16:54 INFO - 2015-11-17 16:16:54,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:16:55 INFO - 2015-11-17 16:16:55,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 269152256 16:16:55 INFO - 2015-11-17 16:16:55,002 DEBUG : BROWSER_OUTPUT: 16:16:56 INFO - 2015-11-17 16:16:56,923 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49487/tests/kraken/driver.html?testName=ai-astar) 16:16:57 INFO - 2015-11-17 16:16:57,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 270397440 16:16:57 INFO - 2015-11-17 16:16:57,176 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,177 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:16:57 INFO - 2015-11-17 16:16:57,177 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:16:57 INFO - 2015-11-17 16:16:57,177 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:16:57 INFO - 2015-11-17 16:16:57,178 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:16:57 INFO - 2015-11-17 16:16:57,178 DEBUG : BROWSER_OUTPUT: |0;ai-astar;136;128;138;136;137;149;136;137;136;129 16:16:57 INFO - 2015-11-17 16:16:57,178 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;184;162;191;201;155;180;183;158;196;159 16:16:57 INFO - 2015-11-17 16:16:57,178 DEBUG : BROWSER_OUTPUT: |2;audio-dft;201;209;200;201;200;201;203;198;198;205 16:16:57 INFO - 2015-11-17 16:16:57,178 DEBUG : BROWSER_OUTPUT: |3;audio-fft;82;91;102;146;80;82;85;86;114;81 16:16:57 INFO - 2015-11-17 16:16:57,178 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;104;109;156;107;109;110;150;109;111;157 16:16:57 INFO - 2015-11-17 16:16:57,179 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;149;142;142;142;142;142;142;142;142;150 16:16:57 INFO - 2015-11-17 16:16:57,179 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;156;157;156;157;157;165;161;157;157;157 16:16:57 INFO - 2015-11-17 16:16:57,179 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;118;137;122;128;117;118;126;125;122;118 16:16:57 INFO - 2015-11-17 16:16:57,179 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;77;79;82;82;83;82;84;93;81;83 16:16:57 INFO - 2015-11-17 16:16:57,179 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;82;85;85;87;87;86;87;87;88;88 16:16:57 INFO - 2015-11-17 16:16:57,179 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;103;106;108;108;106;106;107;109;110;105 16:16:57 INFO - 2015-11-17 16:16:57,180 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;157;163;176;158;153;164;168;169;157;156 16:16:57 INFO - 2015-11-17 16:16:57,180 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;187;189;188;187;188;188;180;190;181;175 16:16:57 INFO - 2015-11-17 16:16:57,180 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;82;94;87;87;88;86;87;89;87;88 16:16:57 INFO - 2015-11-17 16:16:57,180 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:16:57 INFO - 2015-11-17 16:16:57,180 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:16:57 INFO - 2015-11-17 16:16:57,180 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,756 16:16:57 INFO - 2015-11-17 16:16:57,182 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:16:57 INFO - 2015-11-17 16:16:57,182 DEBUG : BROWSER_OUTPUT: __startTimestamp1447805817176__endTimestamp 16:16:57 INFO - 2015-11-17 16:16:57,182 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,182 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:16:57 INFO - 2015-11-17 16:16:57,183 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:16:57 INFO - 2015-11-17 16:16:57,183 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,183 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:136.20 Median:136.50 stddev:5.65 (4.1%) stddev-sans-first:6.00 16:16:57 INFO - 2015-11-17 16:16:57,183 DEBUG : BROWSER_OUTPUT: Values: 136.0 128.0 138.0 136.0 137.0 149.0 136.0 137.0 136.0 129.0 16:16:57 INFO - 2015-11-17 16:16:57,183 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,184 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:176.90 Median:183.50 stddev:17.06 (9.3%) stddev-sans-first:17.91 16:16:57 INFO - 2015-11-17 16:16:57,184 DEBUG : BROWSER_OUTPUT: Values: 184.0 162.0 191.0 201.0 155.0 180.0 183.0 158.0 196.0 159.0 16:16:57 INFO - 2015-11-17 16:16:57,184 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,184 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:201.60 Median:201.00 stddev:3.34 (1.7%) stddev-sans-first:3.54 16:16:57 INFO - 2015-11-17 16:16:57,184 DEBUG : BROWSER_OUTPUT: Values: 201.0 209.0 200.0 201.0 200.0 201.0 203.0 198.0 198.0 205.0 16:16:57 INFO - 2015-11-17 16:16:57,184 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,185 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:94.90 Median:82.00 stddev:20.99 (25.6%) stddev-sans-first:21.74 16:16:57 INFO - 2015-11-17 16:16:57,185 DEBUG : BROWSER_OUTPUT: Values: 82.0 91.0 102.0 146.0 80.0 82.0 85.0 86.0 114.0 81.0 16:16:57 INFO - 2015-11-17 16:16:57,185 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,185 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:122.20 Median:110.50 stddev:22.32 (20.2%) stddev-sans-first:22.69 16:16:57 INFO - 2015-11-17 16:16:57,186 DEBUG : BROWSER_OUTPUT: Values: 104.0 109.0 156.0 107.0 109.0 110.0 150.0 109.0 111.0 157.0 16:16:57 INFO - 2015-11-17 16:16:57,187 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,187 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:143.50 Median:142.00 stddev:3.17 (2.2%) stddev-sans-first:2.67 16:16:57 INFO - 2015-11-17 16:16:57,187 DEBUG : BROWSER_OUTPUT: Values: 149.0 142.0 142.0 142.0 142.0 142.0 142.0 142.0 142.0 150.0 16:16:57 INFO - 2015-11-17 16:16:57,187 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,187 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:158.00 Median:157.00 stddev:2.83 (1.8%) stddev-sans-first:2.91 16:16:57 INFO - 2015-11-17 16:16:57,188 DEBUG : BROWSER_OUTPUT: Values: 156.0 157.0 156.0 157.0 157.0 165.0 161.0 157.0 157.0 157.0 16:16:57 INFO - 2015-11-17 16:16:57,188 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,188 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:123.10 Median:123.50 stddev:6.21 (5.0%) stddev-sans-first:6.30 16:16:57 INFO - 2015-11-17 16:16:57,188 DEBUG : BROWSER_OUTPUT: Values: 118.0 137.0 122.0 128.0 117.0 118.0 126.0 125.0 122.0 118.0 16:16:57 INFO - 2015-11-17 16:16:57,188 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,188 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:82.60 Median:82.50 stddev:4.20 (5.1%) stddev-sans-first:3.93 16:16:57 INFO - 2015-11-17 16:16:57,188 DEBUG : BROWSER_OUTPUT: Values: 77.0 79.0 82.0 82.0 83.0 82.0 84.0 93.0 81.0 83.0 16:16:57 INFO - 2015-11-17 16:16:57,188 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,189 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:86.20 Median:87.00 stddev:1.81 (2.1%) stddev-sans-first:1.12 16:16:57 INFO - 2015-11-17 16:16:57,189 DEBUG : BROWSER_OUTPUT: Values: 82.0 85.0 85.0 87.0 87.0 86.0 87.0 87.0 88.0 88.0 16:16:57 INFO - 2015-11-17 16:16:57,189 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,189 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:106.80 Median:107.50 stddev:2.04 (1.9%) stddev-sans-first:1.64 16:16:57 INFO - 2015-11-17 16:16:57,189 DEBUG : BROWSER_OUTPUT: Values: 103.0 106.0 108.0 108.0 106.0 106.0 107.0 109.0 110.0 105.0 16:16:57 INFO - 2015-11-17 16:16:57,190 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,190 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:162.10 Median:163.50 stddev:7.22 (4.4%) stddev-sans-first:7.42 16:16:57 INFO - 2015-11-17 16:16:57,190 DEBUG : BROWSER_OUTPUT: Values: 157.0 163.0 176.0 158.0 153.0 164.0 168.0 169.0 157.0 156.0 16:16:57 INFO - 2015-11-17 16:16:57,190 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,190 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.30 Median:188.00 stddev:4.90 (2.6%) stddev-sans-first:5.16 16:16:57 INFO - 2015-11-17 16:16:57,190 DEBUG : BROWSER_OUTPUT: Values: 187.0 189.0 188.0 187.0 188.0 188.0 180.0 190.0 181.0 175.0 16:16:57 INFO - 2015-11-17 16:16:57,190 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,192 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:87.50 Median:87.50 stddev:2.95 (3.4%) stddev-sans-first:2.37 16:16:57 INFO - 2015-11-17 16:16:57,192 DEBUG : BROWSER_OUTPUT: Values: 82.0 94.0 87.0 87.0 88.0 86.0 87.0 89.0 87.0 88.0 16:16:57 INFO - 2015-11-17 16:16:57,192 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:16:57 INFO - 2015-11-17 16:16:57,192 DEBUG : BROWSER_OUTPUT: 16:16:57 INFO - 2015-11-17 16:16:57,953 INFO : Browser exited with error code: 0 16:16:58 INFO - 2015-11-17 16:16:58,010 INFO : Completed test kraken (00:01:03) 16:16:58 INFO - 2015-11-17 16:16:58,010 INFO : Starting test v8_7 16:16:58 INFO - 2015-11-17 16:16:58,010 DEBUG : operating with platform_type : mac_ 16:16:58 INFO - 2015-11-17 16:16:58,010 INFO : Initialising browser for v8_7 test... 16:16:58 INFO - 2015-11-17 16:16:58,025 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmpq05hKV/profile http://localhost:49487/getInfo.html 16:17:01 INFO - 2015-11-17 16:17:01,309 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:17:01 INFO - 2015-11-17 16:17:01,309 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:17:01 INFO - 2015-11-17 16:17:01,310 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:17:01 INFO - 2015-11-17 16:17:01,310 DEBUG : BROWSER_OUTPUT: __metrics 16:17:02 INFO - 2015-11-17 16:17:02,026 INFO : Browser initialized. 16:17:02 INFO - 2015-11-17 16:17:02,026 INFO : Running cycle 1/1 for v8_7 test... 16:17:02 INFO - 2015-11-17 16:17:02,026 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/tmpq05hKV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:17:14 INFO - 2015-11-17 16:17:14,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 241840128 16:17:14 INFO - 2015-11-17 16:17:14,262 DEBUG : BROWSER_OUTPUT: 16:17:36 INFO - 2015-11-17 16:17:36,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49487/tests/v8_7/run.html (next: http://localhost:49487/tests/v8_7/run.html) 16:17:37 INFO - 2015-11-17 16:17:37,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 261910528 16:17:37 INFO - 2015-11-17 16:17:37,118 DEBUG : BROWSER_OUTPUT: 16:17:37 INFO - 2015-11-17 16:17:37,118 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:17:37 INFO - 2015-11-17 16:17:37,118 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:17:37 INFO - 2015-11-17 16:17:37,118 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:17:37 INFO - 2015-11-17 16:17:37,118 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:17:37 INFO - 2015-11-17 16:17:37,118 DEBUG : BROWSER_OUTPUT: |0;Richards;860.5851979345955 16:17:37 INFO - 2015-11-17 16:17:37,118 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;237.30422401518746 16:17:37 INFO - 2015-11-17 16:17:37,118 DEBUG : BROWSER_OUTPUT: |2;Encrypt;376.6478342749529 16:17:37 INFO - 2015-11-17 16:17:37,118 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6731.543624161074 16:17:37 INFO - 2015-11-17 16:17:37,119 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1343.6241610738255 16:17:37 INFO - 2015-11-17 16:17:37,119 DEBUG : BROWSER_OUTPUT: |5;Earley;1054.7945205479452 16:17:37 INFO - 2015-11-17 16:17:37,119 DEBUG : BROWSER_OUTPUT: |6;Boyer;15630.76923076923 16:17:37 INFO - 2015-11-17 16:17:37,119 DEBUG : BROWSER_OUTPUT: |7;RegExp;34637.93103448276 16:17:37 INFO - 2015-11-17 16:17:37,119 DEBUG : BROWSER_OUTPUT: |8;Splay;702.2471910112359 16:17:37 INFO - 2015-11-17 16:17:37,119 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6783.783783783784 16:17:37 INFO - 2015-11-17 16:17:37,119 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:17:37 INFO - 2015-11-17 16:17:37,119 DEBUG : BROWSER_OUTPUT: __startTimestamp1447805857111__endTimestamp 16:17:37 INFO - 2015-11-17 16:17:37,119 DEBUG : BROWSER_OUTPUT: 16:17:37 INFO - 2015-11-17 16:17:37,120 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:17:37 INFO - 2015-11-17 16:17:37,120 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:17:37 INFO - 2015-11-17 16:17:37,120 DEBUG : BROWSER_OUTPUT: 16:17:37 INFO - 2015-11-17 16:17:37,120 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:860.59 Median:860.59 stddev:0.00 (0.0%) 16:17:37 INFO - 2015-11-17 16:17:37,120 DEBUG : BROWSER_OUTPUT: Values: 860.6 16:17:37 INFO - 2015-11-17 16:17:37,120 DEBUG : BROWSER_OUTPUT: 16:17:37 INFO - 2015-11-17 16:17:37,120 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:237.30 Median:237.30 stddev:0.00 (0.0%) 16:17:37 INFO - 2015-11-17 16:17:37,120 DEBUG : BROWSER_OUTPUT: Values: 237.3 16:17:37 INFO - 2015-11-17 16:17:37,120 DEBUG : BROWSER_OUTPUT: 16:17:37 INFO - 2015-11-17 16:17:37,120 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:376.65 Median:376.65 stddev:0.00 (0.0%) 16:17:37 INFO - 2015-11-17 16:17:37,120 DEBUG : BROWSER_OUTPUT: Values: 376.6 16:17:37 INFO - 2015-11-17 16:17:37,120 DEBUG : BROWSER_OUTPUT: 16:17:37 INFO - 2015-11-17 16:17:37,121 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6731.54 Median:6731.54 stddev:0.00 (0.0%) 16:17:37 INFO - 2015-11-17 16:17:37,121 DEBUG : BROWSER_OUTPUT: Values: 6731.5 16:17:37 INFO - 2015-11-17 16:17:37,121 DEBUG : BROWSER_OUTPUT: 16:17:37 INFO - 2015-11-17 16:17:37,121 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1343.62 Median:1343.62 stddev:0.00 (0.0%) 16:17:37 INFO - 2015-11-17 16:17:37,121 DEBUG : BROWSER_OUTPUT: Values: 1343.6 16:17:37 INFO - 2015-11-17 16:17:37,121 DEBUG : BROWSER_OUTPUT: 16:17:37 INFO - 2015-11-17 16:17:37,121 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1054.79 Median:1054.79 stddev:0.00 (0.0%) 16:17:37 INFO - 2015-11-17 16:17:37,121 DEBUG : BROWSER_OUTPUT: Values: 1054.8 16:17:37 INFO - 2015-11-17 16:17:37,121 DEBUG : BROWSER_OUTPUT: 16:17:37 INFO - 2015-11-17 16:17:37,121 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15630.77 Median:15630.77 stddev:0.00 (0.0%) 16:17:37 INFO - 2015-11-17 16:17:37,121 DEBUG : BROWSER_OUTPUT: Values: 15630.8 16:17:37 INFO - 2015-11-17 16:17:37,121 DEBUG : BROWSER_OUTPUT: 16:17:37 INFO - 2015-11-17 16:17:37,121 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34637.93 Median:34637.93 stddev:0.00 (0.0%) 16:17:37 INFO - 2015-11-17 16:17:37,122 DEBUG : BROWSER_OUTPUT: Values: 34637.9 16:17:37 INFO - 2015-11-17 16:17:37,122 DEBUG : BROWSER_OUTPUT: 16:17:37 INFO - 2015-11-17 16:17:37,122 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:702.25 Median:702.25 stddev:0.00 (0.0%) 16:17:37 INFO - 2015-11-17 16:17:37,122 DEBUG : BROWSER_OUTPUT: Values: 702.2 16:17:37 INFO - 2015-11-17 16:17:37,122 DEBUG : BROWSER_OUTPUT: 16:17:37 INFO - 2015-11-17 16:17:37,122 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6783.78 Median:6783.78 stddev:0.00 (0.0%) 16:17:37 INFO - 2015-11-17 16:17:37,122 DEBUG : BROWSER_OUTPUT: Values: 6783.8 16:17:37 INFO - 2015-11-17 16:17:37,122 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:17:37 INFO - 2015-11-17 16:17:37,122 DEBUG : BROWSER_OUTPUT: 16:17:37 INFO - 2015-11-17 16:17:37,893 INFO : Browser exited with error code: 0 16:17:37 INFO - 2015-11-17 16:17:37,916 INFO : Completed test v8_7 (00:00:39) 16:17:38 INFO - 2015-11-17 16:17:38,085 INFO : Completed test suite (00:20:14) 16:17:38 INFO - 2015-11-17 16:17:38,085 DEBUG : Working with test: dromaeo_css 16:17:38 INFO - 2015-11-17 16:17:38,086 DEBUG : Generating results file: dromaeo_css 16:17:38 INFO - 2015-11-17 16:17:38,087 DEBUG : Working with test: kraken 16:17:38 INFO - 2015-11-17 16:17:38,087 DEBUG : Generating results file: kraken 16:17:38 INFO - 2015-11-17 16:17:38,087 INFO : javascript benchmark 16:17:38 INFO - 2015-11-17 16:17:38,087 DEBUG : Working with test: v8_7 16:17:38 INFO - 2015-11-17 16:17:38,087 DEBUG : Generating results file: v8_7 16:17:38 INFO - 2015-11-17 16:17:38,087 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:17:38 INFO - 2015-11-17 16:17:38,142 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,57]] 16:17:38 INFO - 2015-11-17 16:17:38,142 DEBUG : process_Request line: dromaeo_css 5507.23 graph.html#tests=[[72,63,57]] 16:17:38 INFO - 2015-11-17 16:17:38,142 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:17:38 INFO - 2015-11-17 16:17:38,172 DEBUG : process_Request line: kraken 1866.90 graph.html#tests=[[232,63,57]] 16:17:38 INFO - 2015-11-17 16:17:38,172 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:17:38 INFO - 2015-11-17 16:17:38,202 DEBUG : process_Request line: v8_7 14212.48 graph.html#tests=[[230,63,57]] 16:17:38 INFO - 2015-11-17 16:17:38,203 INFO : javascript benchmark 16:17:38 INFO - 2015-11-17 16:17:38,205 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2551.476947225818, 2601.75283348082, 2612.7648511633947, 2658.8803503842323, 2663.360793409582, 4196.9370459443135, 4349.195398851215, 4389.868303950882, 4420.447444069491, 4519.118771839492, 4179.66562674986, 4277.636400905919, 4348.326009468537, 4356.390105385249, 4405.118976204756, 4053.250148722481, 4079.2453396121664, 4101.815418306169, 4144.8756537303925, 4173.123644034757, 4043.757374557536, 4069.3285607874664, 4103.405006274089, 4108.753474791507, 4116.6912481564, 3883.262180185756, 3940.6453419192126, 4038.8788336349958, 4085.9591404085877, 4129.678502879065, 4093.9181216375805, 4106.897327566805, 4130.442390277304, 4152.937705934413, 4178.749275043507, 4086.8978275543054, 4096.5903409658795, 4120.793960302003, 4121.5466298707115, 4128.896777580554, 4077.2660921034203, 4174.186033723425, 4375.606195442426, 4427.0, 4428.202923473774, 4687.9531204687855, 4734.218853889104, 4783.760811959388, 4792.065547218293, 4806.975965120152, 4552.089582083563, 4762.476127625959, 4787.832425865078, 4846.491118432585, 4869.780859861315, 4328.2209202343565, 4399.868003959887, 4407.1185762847235, 4465.776711164429, 4470.441194850644, 4736.834210802605, 4759.405074365704, 4778.737169455644, 4803.831865884677, 4816.566509014206, 4320.567943205654, 4361.302191649321, 4564.0871825635, 4581.40441742578, 4633.698809577367, 4469.888252793706, 4541.455025396974, 4582.312653101994, 4595.954040459619, 4600.447946246405, 4695.295705644181, 4697.31888876111, 4733.881652958635, 4765.0, 4820.228763397839, 4564.3838081859185, 4616.146012987608, 4640.257558790645, 4682.227432473604, 4694.248920172756, 3670.284294562588, 3679.043448703303, 3691.963080369162, 3714.60996595359, 3720.1071742781537, 3327.4842399428126, 3334.866605335808, 3336.59960804705, 3380.4084285250474, 3409.16475463513, 4367.737935723867, 4485.730856148642, 4494.797734101973, 4515.525869783691, 4530.139273538017, 4743.0, 4770.403699537558, 4773.737444440589, 4855.660103792771, 4901.632377571696, 4549.27211646135, 4561.840335588305, 4575.81696732127, 4618.953810461852, 4656.767161641905, 3915.5888631693833, 4039.8788036358956, 4062.4921884764403, 4112.403701463271, 4132.752034877917, 4743.976280118577, 4891.241857512091, 4930.1865192243595, 4955.083309587666, 4961.578265847299, 4634.629229661551, 4774.069056534081, 4798.136335459651, 4861.1979023460735, 4883.438404583376, 4724.4094488188975, 4766.213574760126, 4818.734969576707, 4874.610031197567, 4887.047025829929, 4603.286490593963, 4624.28323609841, 4669.649776266861, 4672.439307283148, 4697.459792123949, 4661.743604101807, 4726.19654658702, 4726.952730472789, 4743.430788305287, 4829.5653391194965, 4479.148961697267, 4524.253498172765, 4579.381783459324, 4608.907821843612, 4610.608098311681, 4625.976870115628, 4644.140833945731, 4665.043666048384, 4684.672072954861, 4701.694389864648, 4197.643200328006, 4207.116505533872, 4500.077484115814, 4517.706349087299, 4594.425696787902, 4457.242268814374, 4551.385562949092, 4567.314902764612, 4573.153966516205, 4587.839425620087, 4457.576530229752, 4463.419755431773, 4497.662675299301, 4502.954970450384, 4551.499335073073], "unit": "ms", "name": "dojo.html", "value": 4357.421777438842}, {"lowerIsBetter": false, "replicates": [461.32646336348927, 481.4992407895787, 483.6300230323803, 494.37214737283637, 507.96375394195843, 30766.84616576917, 31721.365572688534, 31887.36225275493, 31920.36159276813, 31956.680433195692, 35125.47311790325, 36263.0, 36354.45468317977, 36370.63629363706, 36399.0, 7764.572948487817, 7896.328812050982, 8028.839423211532, 8038.799030024237, 8050.959745201266, 7765.339946104588, 7803.60981950903, 7841.333486653612, 7922.247386498302, 7934.087579928296, 7782.9221707783045, 7889.447738658297, 7964.800879978018, 7972.322352600036, 7983.880241796378, 7757.534547927143, 7782.338501227402, 7787.727429539939, 7863.56750378729, 7919.564423956737, 7617.314441700273, 7698.461107722462, 7747.767566973, 7765.184655611192, 7807.6486558105025, 33513.497297540554, 33746.325073498636, 33783.83108084444, 33977.15057123567, 34245.31509369799, 2541.606051062088, 2586.6378706981036, 2738.0964281786964, 2921.35730139369, 3042.0721679887624, 23218.419539511477, 23323.74551036527, 23342.0, 23553.41116472085, 23827.404314892094, 2008.8694234874686, 2010.0452285164577, 2032.4613977296028, 2038.1439795286014, 2123.607132680459, 225111.0, 226388.0, 226692.0, 226899.0, 227501.99999999834, 43798.0, 45744.0, 48603.78490537694, 48849.5115048845, 49253.75373123112, 51286.97426051458, 52331.47668523342, 52529.0, 52710.209346859825, 52951.20573191405, 13220.33898305081, 13347.265900375378, 13362.665933351744, 13403.128796628189, 13415.463381464631, 10208.693739187836, 10279.845802312972, 10296.485175741183, 10341.172706183488, 10359.067683908484, 15679.764803527956, 15857.762133568005, 15873.603159920864, 15877.603059923595, 15992.04047757115, 7133.964330178316, 7334.853302933911, 7362.263773622595, 7381.594012329266, 7406.259374062551, 720.7081132141491, 820.9179082091744, 822.296936119621, 823.6005537314397, 897.2597606974142, 23444.88277558601, 23704.525909481712, 23782.7621723784, 23796.167134150222, 23912.521749564912, 814.0150417994294, 868.4268382867277, 868.8957325121025, 955.3312681123242, 1016.9880968436453, 12289.1397602167, 12413.31726755019, 12427.937860310822, 12503.124781265224, 12512.436940337706, 252120.0, 257078.0, 257822.0, 258955.0, 261743.0, 44659.0, 45102.77448612736, 45419.31871021937, 45431.31853022207, 45445.318320225226, 1193.5892864218104, 1200.3758045816128, 1200.7238335182956, 1202.3507306054807, 1213.3084142038954, 23198.956046978263, 23563.52872942566, 23641.81790910482, 23687.763122368557, 23726.762732372456, 39688.00779980524, 39733.40399893946, 39842.80078599588, 40082.39876401798, 40157.0, 230003.0, 232275.0, 233867.0, 234058.0, 234839.0, 26451.60322595124, 27057.1882843515, 27284.454310913272, 27316.31709207286, 27507.0, 31946.68053319437, 32124.518132228503, 32229.677703223606, 32760.0, 32881.177970550925, 26839.597406039316, 27404.314892127855, 28143.43713125767, 28253.15240542787, 28429.289267768472, 27113.72886271191, 27347.179584612495, 27359.45281094407, 27742.722572774015, 27870.3032424191, 28735.425291493633, 29109.41781164407, 29722.0, 29865.0, 29956.400871982874, 24499.38751531226, 24533.264002079966, 25420.237392878244, 25423.6186457207, 25960.870195648902, 19161.712574311117, 19205.519862003563, 19419.51451213731, 19425.51436214106, 19666.50833729168], "unit": "ms", "name": "ext.html", "value": 15287.052359608155}, {"lowerIsBetter": false, "replicates": [283.93895312507806, 284.3914023988663, 285.9799814013019, 287.1500358937545, 293.7179212736405, 12828.230306181613, 14340.211288379149, 14715.190664513448, 14719.484818031371, 15181.240937953085, 14449.78325325121, 14714.63213419665, 15368.385264589402, 15434.459793907215, 15482.535523934272, 4493.932591011137, 4550.772461376942, 4632.0967411354795, 4637.814487420499, 4675.135100006492, 4556.1343344764555, 4589.816407343702, 4612.60792832608, 4613.861584152481, 4616.30755386693, 3295.8187299698507, 4556.589906908378, 4561.247394179956, 4817.181079216524, 5080.745962701869, 4993.800247990076, 5054.342935418372, 5066.645334826564, 5077.873053173664, 5094.286799848006, 4264.040590867061, 4349.69552131351, 4360.367746676714, 4364.716293440948, 4369.6285815705705, 17217.913910430492, 17432.733744613244, 17500.737488937677, 17612.207450664624, 17786.644267114716, 1382.0947279531822, 1484.7995520604688, 1616.7898173237404, 1735.8871673341318, 1834.9908250458795, 7748.728794492222, 7885.842283154362, 7966.601669916481, 7987.720429784929, 8050.4364694471415, 1293.6765808547864, 1316.2826259688493, 1323.133347657286, 1341.222091187109, 1347.986520134796, 48257.0, 48365.0, 49419.0, 49688.0, 50424.49575504235, 5325.147976323769, 5379.623426360117, 5396.568274538027, 5452.563794896399, 5458.372287186945, 6111.449969502677, 6118.755249789959, 6196.442320191204, 6197.783077592353, 6200.131981522591, 4494.258447356149, 4564.2012647786505, 4578.175928332932, 4585.656075794329, 4652.278896771006, 4923.8276660316715, 4932.358793356912, 4939.2838038484215, 4961.156603377434, 5041.521055499722, 2418.5646583614766, 2462.753724627523, 2462.876856157185, 2471.468634243646, 2497.7876880465365, 868.1492137705085, 872.4939535069644, 875.2385424680568, 877.1009715042132, 921.9400738951947, 347.1858491836639, 349.4880000798791, 353.9805310707884, 366.57477326301364, 367.38096307721577, 8194.918050819535, 8304.460210086325, 8525.14748525155, 8603.5698215089, 8626.137386261324, 355.4650251371669, 356.62019948754494, 360.48810688821413, 362.75332773714126, 364.4733360294402, 4561.817527298937, 4646.97676511622, 4720.457147428021, 4764.880877978078, 4800.639952003614, 432312.0, 445479.0, 477205.0, 483756.0, 484389.0, 57724.422755771906, 60368.0, 60870.69564652237, 61235.0, 63071.0, 360.12489650149865, 360.2866324677154, 363.5128927237462, 364.02622983518455, 366.12678761154837, 7850.33272171849, 7879.0939042010905, 7916.445848790529, 8036.23655752726, 8106.067802202822, 28130.0, 28491.572626411034, 28696.139115826558, 28741.521107162767, 28802.855985720777, 40869.79565102155, 41450.0, 41502.43426974404, 41595.7920210397, 41741.0, 5037.622178336713, 5131.025105229995, 5133.383993920604, 5198.766055527586, 5200.349956255468, 9496.762580935532, 9573.808523829344, 9701.70894873155, 9923.0, 9935.403875767477, 7882.290593846581, 8478.83042339162, 8483.703070392507, 8511.276541493795, 8648.654053837776, 6699.598024118569, 8018.879716804136, 8162.0, 8280.958595206985, 8317.95841020791, 8355.0, 8376.246137847624, 8394.1605839418, 8590.527520986405, 8606.225439710455, 4913.729744863924, 5067.569256613229, 5096.311997880387, 5172.974135129451, 5177.974110129425, 8304.169583041648, 8308.379865926086, 8404.453710508797, 8408.117147699404, 8511.702090426805], "unit": "ms", "name": "jquery.html", "value": 5719.313045655653}, {"lowerIsBetter": false, "replicates": [1460.620238737928, 1462.9414823407064, 1507.9095254284744, 1509.5169545745366, 1537.5925379774362, 5499.395066542677, 5596.692181929992, 6175.25896892373, 6447.161868957029, 6467.5472716909835, 5887.205227294314, 5999.400059993998, 6098.7865424710035, 6101.023836186211, 6103.908441373383, 1782.0733218726255, 1787.6603445345409, 1813.07533158089, 1814.2017512294549, 1814.3014939248353, 1782.3583509936414, 1783.6343549572307, 1810.9858479251661, 1812.5196822841958, 1844.9631007379912, 1795.64087182564, 1825.3337531800864, 1828.0, 1849.195599914035, 1850.9259629614799, 1720.501054694137, 1752.3253547384222, 1775.520609435458, 1775.8312960268818, 1798.2627122879621, 1802.8828126171888, 1841.2819000589782, 1841.6316736652589, 1843.8524918006526, 1868.4768264885718, 6125.448709616156, 6133.172021777048, 6199.163112979735, 6201.658908760016, 6204.038374052029, 3703.740738148331, 3867.825947832326, 3872.5740168581433, 3874.3994680824517, 3875.1280961783655, 2025.1899240303849, 2065.2874758208395, 2278.8176945844293, 2338.6141286687675, 2354.5290941811536, 732.641005907107, 1263.387257180267, 1284.9743005139844, 1293.6377814212035, 1380.2201756007823, 8003.799905002422, 8030.839383212361, 8078.555679437687, 8106.0, 8108.513489190667, 3188.2507610711464, 3307.9503807442907, 3342.4317865962844, 3351.0952042948265, 3353.0, 6708.262091170065, 6719.26088130315, 6727.865442691119, 6734.730610775514, 6756.898646520306, 3731.794751288651, 3787.223619158121, 3789.1663833956486, 3791.1659434924272, 3792.1088544192094, 3508.245727168671, 3520.0, 3520.1023738946915, 3533.8939831805087, 3537.876174333886, 2599.961000584955, 2645.7354264573773, 2664.77349425301, 2665.6667916510437, 2665.9600105998425, 778.4239662649599, 785.9017622797151, 791.4301702773994, 796.366888323784, 799.3724925933114, 1053.1627356251797, 1097.1990446973593, 1107.5791199344358, 1135.6649788312302, 1136.1478890831877, 5804.158397032406, 5903.35063143054, 5994.970025149846, 5998.070299103646, 6016.217891674054, 374.69649583836633, 375.56434535938183, 377.2059814091353, 378.50982977044794, 380.1351924372076, 4581.679282450196, 4629.675922685447, 4648.558386953234, 4703.17694403478, 4708.387909571734, 7155.749548765768, 7227.349538541556, 7331.816704582321, 7398.593077380796, 7443.702251909971, 7225.349718525358, 7312.341889229889, 7369.926300737031, 7382.0, 7394.963025184839, 5758.193852860519, 5826.504747096459, 5843.678597677083, 5865.88268234633, 5896.823095307148, 5662.57530685192, 5706.9714651426475, 5741.569382296261, 5769.68266745333, 5770.567207459373, 6491.870162596816, 6491.935080649322, 6527.445167160845, 6642.867142657024, 6643.900341494785, 6300.149479820349, 6703.93296067033, 6704.564203326768, 6713.328667133248, 6822.351876571718, 5388.191771234347, 5392.676439413648, 5393.029254734185, 5461.972690136524, 5475.534579560623, 5775.191473193672, 5784.855378615568, 5801.36185019639, 5843.181954526284, 5851.590388672752, 5373.623846330719, 5453.291072160752, 5459.781608735606, 5499.0, 5579.69311687861, 5248.921266180934, 5336.386315573759, 5407.702576358338, 5450.945490545044, 5467.9453205467435, 5446.237526746179, 5478.561715062865, 5490.5882058844945, 5496.367917689517, 5558.24963629921, 4908.509149085063, 4959.429665588504, 5038.01758657073, 5038.118329292286, 5043.0, 4397.098594787997, 4448.088141930961, 5003.54968052877, 5040.621953353587, 5117.8720531987], "unit": "ms", "name": "mootools.html", "value": 3494.790362216116}, {"lowerIsBetter": false, "replicates": [247.49634493805107, 264.1257437880614, 268.0831556078213, 270.388921038453, 272.0424107142857, 5307.840764777054, 5370.382406023304, 5473.452654734525, 5491.670499770016, 5537.141743029832, 5234.555062819655, 5354.437784032679, 5388.0570900092525, 5472.72636368182, 5502.257195278637, 4075.735077219971, 4075.7976396962817, 4121.258173528764, 4127.23646125467, 4169.4162817205615, 4111.342185250361, 4123.0310876943895, 4144.772037537934, 4170.416141740159, 4182.477190351206, 4006.1587066716024, 4050.3519436890106, 4058.0666446717273, 4061.7969101544804, 4130.91738165238, 4051.149258655671, 4054.412110243998, 4067.08490589615, 4107.691923105779, 4124.938125928114, 3488.529048578435, 3502.4921386399083, 3538.433850583894, 3540.7521473496868, 3557.3774589447003, 5205.193195054772, 5258.579313654898, 5316.9734151329385, 5318.867028324285, 5330.040592693314, 4422.889427764299, 4634.490206077328, 4642.489326174118, 4696.53034696531, 4702.012577358759, 5365.302510673588, 5554.389017208145, 5597.804076857331, 5700.885982280372, 5749.0, 3815.4086116651965, 3823.9044023899346, 3848.6536211741077, 3853.2293541291856, 3875.65119139276, 5965.254343207099, 5966.134910437962, 5998.25021872266, 6022.909656355202, 6031.155638210654, 3787.16682329887, 3899.1032062625754, 3902.102516421239, 3951.723379363417, 3973.8609148679657, 3970.722049456568, 3981.6217459341315, 3990.700697447703, 4035.535913369941, 4050.8987275318354, 4632.119897219518, 4646.558576935186, 4686.5782079613, 4688.991866748665, 4695.229814409515, 5692.060809966392, 5726.8546290742015, 5768.884622307531, 5772.7113644317615, 5785.797497087582, 1392.6727219103502, 1411.5976946570179, 1411.8164638596916, 1419.1201455097698, 1419.282667971745, 908.6637943960777, 921.2215677752289, 930.7952250504878, 934.9672761453317, 937.5124935033881, 5513.145462453326, 5527.309086364205, 5527.861803454945, 5532.004239236976, 5535.308086489189, 5934.198883150806, 5947.0, 5996.0, 5997.250343707036, 6003.969980150071, 5473.233747275384, 5526.392096869341, 5547.528460080857, 5556.666600004012, 5565.777368905198, 3144.0567829651013, 3173.777835551535, 3210.614726232867, 3252.9674703253136, 3255.5279484474618, 6128.3565225651555, 6194.783182588588, 6197.411245931629, 6252.968735156295, 6276.403741644536, 6161.260648722182, 6220.440160385587, 6233.252009758768, 6240.282367527792, 6240.625562466266, 5976.372480889531, 6071.483923866344, 6254.437100661054, 6256.843578910563, 6260.342664020212, 5882.705864706833, 5995.430434108753, 5996.820095397145, 6055.6063855849225, 6091.0, 5875.559333049953, 5890.0575907856255, 5933.22868027171, 5942.554308426799, 5962.612430192024, 6169.56813023102, 6188.1027251049245, 6266.530010249341, 6280.497560195265, 6284.151639528605, 3737.2151848112203, 3862.227554489057, 3873.5158105236846, 3874.5544262409057, 3898.4152377142523, 5945.910811337747, 5954.37479064692, 5973.5519836013345, 5992.370801065826, 6015.4586087252355, 5747.626404283708, 5767.625104368202, 5788.855278618068, 5798.710064496842, 5835.44563266489, 5561.860953476195, 5704.828855134353, 5730.598858079894, 5805.390434004369, 5842.444967728059, 5589.385167631476, 5603.93525230205, 5667.971660141673, 5672.886542269214, 5676.801311954062, 5731.598788084794, 5750.741216645345, 5755.510781583613, 5815.738291776965, 5823.708814559171, 5444.128939369682, 5671.262735844314, 5680.233168522197, 5725.8568535786935, 5727.5417966561745], "unit": "ms", "name": "prototype.html", "value": 4289.048940940574}, {"lowerIsBetter": false, "replicates": [601.8375038739543, 616.291265045198, 620.7548018532677, 632.8576070384164, 650.1937597379249, 11581.478833452495, 11907.7618447631, 12062.758744825098, 13620.046596738232, 13655.0, 12342.753144937118, 12428.316442595653, 12502.374881255924, 12520.874791252085, 12529.310887901185, 513.3608657221746, 583.3146053387275, 711.3029231353252, 720.794573546538, 734.7097896330946, 717.5085066729281, 720.8486217894249, 725.4994054102652, 739.0023468317781, 739.8150462384403, 752.8419032003259, 757.5606148433923, 757.746155038063, 759.0853022108374, 770.5800338815332, 753.8040109571551, 754.0611938137027, 757.2578872704726, 760.2397602397602, 765.5368502056232, 550.7631718361104, 552.3344370034099, 552.505507570722, 556.1768582497886, 557.6486813307631, 11462.942685286604, 11571.884281157165, 11577.305361678325, 11609.535618575246, 11723.648290551297, 7379.9262007379775, 7669.769906902746, 7971.40214483916, 8006.519608823431, 8136.796580085545, 7504.699812007513, 7517.17311095779, 7741.4193935454505, 7780.844383112362, 7785.649645765954, 2421.6367544868235, 2480.4543000540034, 2491.676082109332, 2515.1071369663687, 2554.3103362092315, 39711.40432893509, 39814.0837516946, 40185.0, 40206.59793402028, 40617.18765624671, 5488.615796894179, 5579.107342825209, 5696.088625819932, 5803.274590676166, 5846.181534585162, 9716.75708107303, 9727.951360243154, 9850.605975761033, 9851.408915465096, 9869.851952220723, 4677.789499472532, 4697.060587882437, 4736.0, 4942.703437793743, 5005.5745261653165, 2985.223841801104, 3157.589513363248, 3198.392305461955, 3294.472884338494, 3344.782589131699, 2194.034624765098, 2201.2845825106906, 2207.7461091974305, 2215.4239897626735, 2222.688823564702, 334.0396360463667, 340.3193612774451, 340.40089442581234, 341.60715177545524, 342.1855982761013, 411.50824764406246, 470.70110479845545, 485.9684120532154, 491.89178380756175, 525.5060243371219, 6486.318936511599, 6593.8351541210895, 6623.30455302196, 6781.728730850809, 6790.5925644461495, 378.96968242541084, 440.58144762475774, 490.7350030983229, 514.2132537218063, 524.9081410753103, 3000.234940090263, 3067.417190733798, 3153.716165545112, 3163.9683603164135, 3214.8071115732664, 45991.31013034807, 46704.5329546707, 46752.532474674816, 47313.0, 47338.289925651145, 40667.389989150186, 40779.0, 42799.0, 45362.77318613386, 45433.77283113563, 40465.59534404677, 40955.97610059713, 40992.59007409888, 41053.589464104974, 41395.0, 6836.38472537474, 7143.785686429415, 7225.060742103493, 7230.710771569078, 7287.429159711809, 29401.0, 30081.849590752783, 30220.395592087596, 30801.537976929914, 31148.68851311458, 39550.0, 39737.80131099326, 41004.79497602493, 41193.0, 41578.37632435576, 6584.308647591934, 6599.67001649906, 6648.800535983928, 6718.093057437183, 6747.325267473213, 9231.0, 9538.95230523843, 9544.665936692183, 9607.13535781783, 10073.294869359075, 8793.692220772242, 8875.0, 8890.822183556422, 9260.56723336965, 9668.226541876493, 9168.724938251864, 9228.907710922806, 9248.953755231181, 9323.254139668674, 9447.716568502956, 8696.347773917108, 8715.0, 8901.0, 9044.954775226344, 9064.954675226581, 7348.889766653398, 7354.227806080498, 7624.390048796194, 7714.80420534818, 7718.459707820399, 7126.608036557832, 7568.172507169559, 7574.848503030019, 7990.520568765893, 8068.1528439513], "unit": "ms", "name": "yui.html", "value": 4885.143391293167}], "name": "dromaeo_css", "value": 5507.2356048818465}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [136.0, 128.0, 138.0, 136.0, 137.0, 149.0, 136.0, 137.0, 136.0, 129.0], "unit": "ms", "name": "ai-astar", "value": 136.2}, {"lowerIsBetter": true, "replicates": [184.0, 162.0, 191.0, 201.0, 155.0, 180.0, 183.0, 158.0, 196.0, 159.0], "unit": "ms", "name": "audio-beat-detection", "value": 176.9}, {"lowerIsBetter": true, "replicates": [201.0, 209.0, 200.0, 201.0, 200.0, 201.0, 203.0, 198.0, 198.0, 205.0], "unit": "ms", "name": "audio-dft", "value": 201.6}, {"lowerIsBetter": true, "replicates": [82.0, 91.0, 102.0, 146.0, 80.0, 82.0, 85.0, 86.0, 114.0, 81.0], "unit": "ms", "name": "audio-fft", "value": 94.9}, {"lowerIsBetter": true, "replicates": [104.0, 109.0, 156.0, 107.0, 109.0, 110.0, 150.0, 109.0, 111.0, 157.0], "unit": "ms", "name": "audio-oscillator", "value": 122.2}, {"lowerIsBetter": true, "replicates": [149.0, 142.0, 142.0, 142.0, 142.0, 142.0, 142.0, 142.0, 142.0, 150.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 143.5}, {"lowerIsBetter": true, "replicates": [156.0, 157.0, 156.0, 157.0, 157.0, 165.0, 161.0, 157.0, 157.0, 157.0], "unit": "ms", "name": "imaging-darkroom", "value": 158.0}, {"lowerIsBetter": true, "replicates": [118.0, 137.0, 122.0, 128.0, 117.0, 118.0, 126.0, 125.0, 122.0, 118.0], "unit": "ms", "name": "imaging-desaturate", "value": 123.1}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 82.0, 82.0, 83.0, 82.0, 84.0, 93.0, 81.0, 83.0], "unit": "ms", "name": "json-parse-financial", "value": 82.6}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 85.0, 87.0, 87.0, 86.0, 87.0, 87.0, 88.0, 88.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 86.2}, {"lowerIsBetter": true, "replicates": [103.0, 106.0, 108.0, 108.0, 106.0, 106.0, 107.0, 109.0, 110.0, 105.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 106.8}, {"lowerIsBetter": true, "replicates": [157.0, 163.0, 176.0, 158.0, 153.0, 164.0, 168.0, 169.0, 157.0, 156.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 162.1}, {"lowerIsBetter": true, "replicates": [187.0, 189.0, 188.0, 187.0, 188.0, 188.0, 180.0, 190.0, 181.0, 175.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 185.3}, {"lowerIsBetter": true, "replicates": [82.0, 94.0, 87.0, 87.0, 88.0, 86.0, 87.0, 89.0, 87.0, 88.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 87.5}], "name": "kraken", "value": 1866.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [860.5851979345955], "unit": "score", "name": "Richards", "value": 41.02092400000001}, {"lowerIsBetter": false, "replicates": [237.30422401518746], "unit": "score", "name": "DeltaBlue", "value": 278.62125200000014}, {"lowerIsBetter": false, "replicates": [376.6478342749529], "unit": "score", "name": "Encrypt", "value": 706.7105550000002}, {"lowerIsBetter": false, "replicates": [6731.543624161074], "unit": "score", "name": "Decrypt", "value": 39.542341974077786}, {"lowerIsBetter": false, "replicates": [1343.6241610738255], "unit": "score", "name": "RayTrace", "value": 550.7410639360639}, {"lowerIsBetter": false, "replicates": [1054.7945205479452], "unit": "score", "name": "Earley", "value": 631.8415454545456}, {"lowerIsBetter": false, "replicates": [15630.76923076923], "unit": "score", "name": "Boyer", "value": 42.63788877952759}, {"lowerIsBetter": false, "replicates": [34637.93103448276], "unit": "score", "name": "RegExp", "value": 26.300214036834227}, {"lowerIsBetter": false, "replicates": [702.2471910112359], "unit": "score", "name": "Splay", "value": 116.04318400000004}, {"lowerIsBetter": false, "replicates": [6783.783783783784], "unit": "score", "name": "NavierStokes", "value": 218.75697211155367}], "name": "v8_7", "value": 14212.480708297315}]} 16:17:38 INFO - RETURN: dromaeo_css: 5507.23 16:17:38 INFO - RETURN: kraken: 1866.90 16:17:38 INFO - RETURN: v8_7: 14212.48 16:17:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,57]]", "result": "14212.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,57]]", "result": "1866.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,57]]", "result": "5507.23"}}} 16:17:38 INFO - Return code: 0 16:17:38 INFO - # TBPL SUCCESS # 16:17:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:17:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:17:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:17:38 INFO - 2015-11-17 16:17:38.294 screenresolution[1994:17102] starting screenresolution argv=screenresolution get 16:17:38 INFO - 2015-11-17 16:17:38.297 screenresolution[1994:17102] Display 0: 1600x1200x32@60 16:17:38 INFO - 2015-11-17 16:17:38.304 screenresolution[1995:17105] starting screenresolution argv=screenresolution list 16:17:38 INFO - Available Modes on Display 0 16:17:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:17:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:17:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:17:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:17:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:17:38 INFO - Intel HD Graphics 3000: 16:17:38 INFO - Chipset Model: Intel HD Graphics 3000 16:17:38 INFO - Type: GPU 16:17:38 INFO - Bus: Built-In 16:17:38 INFO - VRAM (Total): 512 MB 16:17:38 INFO - VRAM (Dynamic, Max): 10 16:17:38 INFO - Vendor: Intel (0x8086) 16:17:38 INFO - Device ID: 0x0116 16:17:38 INFO - Revision ID: 0x0009 16:17:38 INFO - Displays: 16:17:38 INFO - Display: 16:17:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:17:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:17:38 INFO - Display Serial Number: 1600x1200 60 16:17:38 INFO - Main Display: Yes 16:17:38 INFO - Mirror: Off 16:17:38 INFO - Online: Yes 16:17:38 INFO - Rotation: Supported 16:17:38 INFO - Return code: 0 16:17:38 INFO - Running post-action listener: _resource_record_post_action 16:17:38 INFO - Running post-run listener: _resource_record_post_run 16:17:39 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 1359872; Write bytes: 693465088; Read time: 884; Write time: 50369 16:17:39 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 341273088; Write bytes: 337563648; Read time: 37107; Write time: 5919 16:17:39 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 1359872; Write bytes: 345526272; Read time: 884; Write time: 43528 16:17:39 INFO - Running post-run listener: _upload_blobber_files 16:17:39 INFO - Blob upload gear active. 16:17:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:17:39 INFO - Copying logs to upload dir... 16:17:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1312.430405 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 52 secs) (at 2015-11-17 16:17:39.749794) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 16:17:39.753784) ========= 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.gUNOrodT82/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.jIILIRHUG7/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011169 build_url: 'https://queue.taskcluster.net/v1/task/zRw74V_jQyShPCgsQftNyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 16:17:39.783900) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 16:17:39.784528) ========= 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.gUNOrodT82/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.jIILIRHUG7/Listeners TMPDIR=/var/folders/m7/mg2d87zj5yq6t_lsnd_mrrfr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005825 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 16:17:39.837068) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 16:17:39.837894) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 16:17:39.838698) ========= ========= Total master_lag: 0.24 =========