builder: mozilla-inbound_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0041 starttime: 1447391372.19 results: success (0) buildid: 20151112201936 builduid: c43d1ad39af1463da49aae3ef404f75a revision: aa323766c0f998f1c36eb0e8ca821b828a81701d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:32.188827) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:32.189409) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:32.189788) ========= 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.gIllW8vMdt/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.tDd8hL5KFC/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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.006073 basedir: '/builds/slave/test' ========= master_lag: 0.33 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:32.521703) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:32.522106) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:32.585351) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:32.585788) ========= 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.gIllW8vMdt/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.tDd8hL5KFC/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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.028620 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:32.636605) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:32.637009) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:32.637503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:32.637863) ========= 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.gIllW8vMdt/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.tDd8hL5KFC/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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-12 21:09:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102, :: Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.26M=0.001s 2015-11-12 21:09:32 (9.26 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.234289 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:32.888836) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:32.889294) ========= 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.gIllW8vMdt/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.tDd8hL5KFC/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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.137898 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:33.043149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:33.043623) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev aa323766c0f998f1c36eb0e8ca821b828a81701d --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 aa323766c0f998f1c36eb0e8ca821b828a81701d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gIllW8vMdt/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.tDd8hL5KFC/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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-12 21:09:33,137 truncating revision to first 12 chars 2015-11-12 21:09:33,137 Setting DEBUG logging. 2015-11-12 21:09:33,137 attempt 1/10 2015-11-12 21:09:33,137 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/aa323766c0f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 21:09:33,411 unpacking tar archive at: mozilla-inbound-aa323766c0f9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645517 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:33.706111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:33.706520) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:33.720167) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:33.720781) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 21:09:33.721391) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2015-11-12 21:09:33.721854) ========= /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.gIllW8vMdt/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.tDd8hL5KFC/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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 21:09:34 INFO - MultiFileLogger online at 20151112 21:09:34 in /builds/slave/test 21:09:34 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 21:09:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:09:34 INFO - {'append_to_log': False, 21:09:34 INFO - 'base_work_dir': '/builds/slave/test', 21:09:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:09:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:09:34 INFO - 'branch': 'Mozilla-Inbound', 21:09:34 INFO - 'buildbot_json_path': 'buildprops.json', 21:09:34 INFO - 'config_files': ('talos/mac_config.py',), 21:09:34 INFO - 'default_actions': ('clobber', 21:09:34 INFO - 'read-buildbot-config', 21:09:34 INFO - 'download-and-extract', 21:09:34 INFO - 'populate-webroot', 21:09:34 INFO - 'create-virtualenv', 21:09:34 INFO - 'install', 21:09:34 INFO - 'run-tests'), 21:09:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:09:34 INFO - 'download_minidump_stackwalk': True, 21:09:34 INFO - 'download_symbols': 'ondemand', 21:09:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:09:34 INFO - 'tooltool.py': '/tools/tooltool.py', 21:09:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:09:34 INFO - '/tools/misc-python/virtualenv.py')}, 21:09:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:09:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:09:34 INFO - 'installer_path': 'installer.exe', 21:09:34 INFO - 'log_level': 'info', 21:09:34 INFO - 'log_name': 'talos', 21:09:34 INFO - 'log_to_console': True, 21:09:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:09:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:09:34 INFO - 'opt_config_files': (), 21:09:34 INFO - 'pip_index': False, 21:09:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:09:34 INFO - 'cmd': ('bash', 21:09:34 INFO - '-c', 21:09:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:09:34 INFO - 'enabled': True, 21:09:34 INFO - 'halt_on_failure': False, 21:09:34 INFO - 'name': 'check_screen_resolution'},), 21:09:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:09:34 INFO - 'cmd': ('bash', 21:09:34 INFO - '-c', 21:09:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:09:34 INFO - 'enabled': True, 21:09:34 INFO - 'halt_on_failure': False, 21:09:34 INFO - 'name': 'check_screen_resolution'},), 21:09:34 INFO - 'run_cmd_checks_enabled': True, 21:09:34 INFO - 'sps_profile': False, 21:09:34 INFO - 'sps_profile_interval': 0, 21:09:34 INFO - 'suite': 'dromaeojs-e10s', 21:09:34 INFO - 'system_bits': '64', 21:09:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:09:34 INFO - 'title': 't-yosemite-r5-0041', 21:09:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:09:34 INFO - 'use_talos_json': True, 21:09:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:09:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:09:34 INFO - 'work_dir': 'build'} 21:09:34 INFO - ##### 21:09:34 INFO - ##### Running clobber step. 21:09:34 INFO - ##### 21:09:34 INFO - Running pre-action listener: _resource_record_pre_action 21:09:34 INFO - Running main action method: clobber 21:09:34 INFO - rmtree: /builds/slave/test/build 21:09:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:09:38 INFO - Running post-action listener: _resource_record_post_action 21:09:38 INFO - ##### 21:09:38 INFO - ##### Running read-buildbot-config step. 21:09:38 INFO - ##### 21:09:38 INFO - Running pre-action listener: _resource_record_pre_action 21:09:38 INFO - Running main action method: read_buildbot_config 21:09:38 INFO - Using buildbot properties: 21:09:38 INFO - { 21:09:38 INFO - "properties": { 21:09:38 INFO - "buildnumber": 63, 21:09:38 INFO - "product": "firefox", 21:09:38 INFO - "script_repo_revision": "production", 21:09:38 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs-e10s", 21:09:38 INFO - "repository": "", 21:09:38 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs-e10s", 21:09:38 INFO - "buildid": "20151112201936", 21:09:38 INFO - "slavename": "t-yosemite-r5-0041", 21:09:38 INFO - "pgo_build": "False", 21:09:38 INFO - "basedir": "/builds/slave/test", 21:09:38 INFO - "project": "", 21:09:38 INFO - "platform": "yosemite", 21:09:38 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 21:09:38 INFO - "slavebuilddir": "test", 21:09:38 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 21:09:38 INFO - "branch": "mozilla-inbound", 21:09:38 INFO - "repo_path": "integration/mozilla-inbound", 21:09:38 INFO - "stage_platform": "macosx64", 21:09:38 INFO - "builduid": "c43d1ad39af1463da49aae3ef404f75a", 21:09:38 INFO - "revision": "aa323766c0f998f1c36eb0e8ca821b828a81701d" 21:09:38 INFO - }, 21:09:38 INFO - "sourcestamp": { 21:09:38 INFO - "repository": "", 21:09:38 INFO - "hasPatch": false, 21:09:38 INFO - "project": "", 21:09:38 INFO - "branch": "mozilla-inbound-macosx64-talos", 21:09:38 INFO - "changes": [ 21:09:38 INFO - { 21:09:38 INFO - "category": null, 21:09:38 INFO - "files": [ 21:09:38 INFO - { 21:09:38 INFO - "url": null, 21:09:38 INFO - "name": "https://queue.taskcluster.net/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 21:09:38 INFO - } 21:09:38 INFO - ], 21:09:38 INFO - "repository": "", 21:09:38 INFO - "rev": "aa323766c0f998f1c36eb0e8ca821b828a81701d", 21:09:38 INFO - "who": "philringnalda@gmail.com", 21:09:38 INFO - "when": 1447391316, 21:09:38 INFO - "number": 6656289, 21:09:38 INFO - "comments": "Back out changeset cd0be67d2344 (bug 1224307) for test_page_scroll_with_fixed_pos.html bustage\nCLOSED TREE", 21:09:38 INFO - "project": "", 21:09:38 INFO - "at": "Thu 12 Nov 2015 21:08:36", 21:09:38 INFO - "branch": "mozilla-inbound-macosx64-talos", 21:09:38 INFO - "revlink": "", 21:09:38 INFO - "properties": [ 21:09:38 INFO - [ 21:09:38 INFO - "buildid", 21:09:38 INFO - "20151112201936", 21:09:38 INFO - "Change" 21:09:38 INFO - ], 21:09:38 INFO - [ 21:09:38 INFO - "builduid", 21:09:38 INFO - "c43d1ad39af1463da49aae3ef404f75a", 21:09:38 INFO - "Change" 21:09:38 INFO - ], 21:09:38 INFO - [ 21:09:38 INFO - "pgo_build", 21:09:38 INFO - "False", 21:09:38 INFO - "Change" 21:09:38 INFO - ] 21:09:38 INFO - ], 21:09:38 INFO - "revision": "aa323766c0f998f1c36eb0e8ca821b828a81701d" 21:09:38 INFO - } 21:09:38 INFO - ], 21:09:38 INFO - "revision": "aa323766c0f998f1c36eb0e8ca821b828a81701d" 21:09:38 INFO - } 21:09:38 INFO - } 21:09:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 21:09:38 INFO - Running post-action listener: _resource_record_post_action 21:09:38 INFO - ##### 21:09:38 INFO - ##### Running download-and-extract step. 21:09:38 INFO - ##### 21:09:38 INFO - Running pre-action listener: _resource_record_pre_action 21:09:38 INFO - Running main action method: download_and_extract 21:09:38 INFO - mkdir: /builds/slave/test/build/tests 21:09:38 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')]} 21:09:38 INFO - https://queue.taskcluster.net/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:09:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/test_packages.json 21:09:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/test_packages.json 21:09:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 21:09:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 21:09:47 INFO - Downloaded 1149 bytes. 21:09:47 INFO - Reading from file /builds/slave/test/build/test_packages.json 21:09:47 INFO - Using the following test package requirements: 21:09:47 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:09:47 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:09:47 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 21:09:47 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:09:47 INFO - u'jsshell-mac.zip'], 21:09:47 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:09:47 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 21:09:47 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:09:47 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:09:47 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 21:09:47 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:09:47 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 21:09:47 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:09:47 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 21:09:47 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:09:47 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:09:47 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 21:09:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:09:47 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')]} 21:09:47 INFO - https://queue.taskcluster.net/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:09:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:09:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:09:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/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 21:09:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/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 21:09:52 INFO - Downloaded 17459865 bytes. 21:09:52 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 21:09:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:09:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 21:09:58 INFO - Return code: 0 21:09:58 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 21:09:58 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')]} 21:09:58 INFO - https://queue.taskcluster.net/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:09:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:09:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:09:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/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 21:09:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/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 21:10:00 INFO - Downloaded 17459865 bytes. 21:10:00 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 21:10:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:10:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 21:10:06 INFO - Return code: 0 21:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:06 INFO - https://queue.taskcluster.net/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:10:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:10:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:10:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/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 21:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/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 21:10:08 INFO - Downloaded 11131693 bytes. 21:10:08 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 21:10:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:10:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 21:10:08 INFO - Return code: 0 21:10:08 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')]} 21:10:08 INFO - https://queue.taskcluster.net/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:10:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:10:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:10:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 21:10:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cCE78LXVSxi0MmPGhVzEGg/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 21:10:11 INFO - Downloaded 108689894 bytes. 21:10:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:10:11 INFO - mkdir: /builds/slave/test/properties 21:10:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:10:11 INFO - Writing to file /builds/slave/test/properties/build_url 21:10:11 INFO - Contents: 21:10:11 INFO - build_url:https://queue.taskcluster.net/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:10:11 INFO - Running post-action listener: _resource_record_post_action 21:10:11 INFO - Running post-action listener: set_extra_try_arguments 21:10:11 INFO - ##### 21:10:11 INFO - ##### Running populate-webroot step. 21:10:11 INFO - ##### 21:10:11 INFO - Running pre-action listener: _resource_record_pre_action 21:10:11 INFO - Running main action method: populate_webroot 21:10:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:10:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:10:11 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:10:11 INFO - '../fennec_ids.txt'], 21:10:11 INFO - 'tests': ['tcheck2']}, 21:10:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:10:11 INFO - '--tppagecycles', 21:10:11 INFO - '7'], 21:10:11 INFO - 'tests': ['tsvgm']}}, 21:10:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:10:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:10:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:10:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:10:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:10:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:10:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:10:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:11 INFO - 'talos_options': ['--e10s'], 21:10:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:10:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:11 INFO - 'tests': ['damp', 'tps']}, 21:10:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:11 INFO - 'talos_options': ['--e10s'], 21:10:11 INFO - 'tests': ['damp', 'tps']}, 21:10:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:10:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:10:11 INFO - 'other': {'tests': ['a11yr', 21:10:11 INFO - 'ts_paint', 21:10:11 INFO - 'tpaint', 21:10:11 INFO - 'sessionrestore', 21:10:11 INFO - 'sessionrestore_no_auto_restore']}, 21:10:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:10:11 INFO - 'tests': ['a11yr', 21:10:11 INFO - 'ts_paint', 21:10:11 INFO - 'tpaint', 21:10:11 INFO - 'sessionrestore', 21:10:11 INFO - 'sessionrestore_no_auto_restore']}, 21:10:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:10:11 INFO - 'tests': ['a11yr', 21:10:11 INFO - 'ts_paint', 21:10:11 INFO - 'tpaint', 21:10:11 INFO - 'sessionrestore', 21:10:11 INFO - 'sessionrestore_no_auto_restore']}, 21:10:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:10:11 INFO - 'tests': ['a11yr', 21:10:11 INFO - 'ts_paint', 21:10:11 INFO - 'tpaint', 21:10:11 INFO - 'sessionrestore', 21:10:11 INFO - 'sessionrestore_no_auto_restore']}, 21:10:11 INFO - 'other_l64': {'tests': ['a11yr', 21:10:11 INFO - 'ts_paint', 21:10:11 INFO - 'tpaint', 21:10:11 INFO - 'sessionrestore', 21:10:11 INFO - 'sessionrestore_no_auto_restore']}, 21:10:11 INFO - 'other_nol64': {'tests': ['a11yr', 21:10:11 INFO - 'ts_paint', 21:10:11 INFO - 'tpaint', 21:10:11 INFO - 'sessionrestore', 21:10:11 INFO - 'sessionrestore_no_auto_restore']}, 21:10:11 INFO - 'svgr': {'tests': ['tsvgx', 21:10:11 INFO - 'tsvgr_opacity', 21:10:11 INFO - 'tart', 21:10:11 INFO - 'tscrollx', 21:10:11 INFO - 'cart']}, 21:10:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:10:11 INFO - 'tests': ['tsvgx', 21:10:11 INFO - 'tsvgr_opacity', 21:10:11 INFO - 'tart', 21:10:11 INFO - 'tscrollx', 21:10:11 INFO - 'cart']}, 21:10:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:11 INFO - 'tests': ['tp5o']}, 21:10:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:11 INFO - 'talos_options': ['--e10s'], 21:10:11 INFO - 'tests': ['tp5o']}, 21:10:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:11 INFO - 'talos_options': ['--xperf_path', 21:10:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:10:11 INFO - 'tests': ['tp5n']}, 21:10:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:11 INFO - 'talos_options': ['--e10s', 21:10:11 INFO - '--xperf_path', 21:10:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:10:11 INFO - 'tests': ['tp5n']}}, 21:10:11 INFO - 'talos.zip': {'path': '', 21:10:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:10:11 INFO - Running post-action listener: _resource_record_post_action 21:10:11 INFO - ##### 21:10:11 INFO - ##### Running create-virtualenv step. 21:10:11 INFO - ##### 21:10:11 INFO - Running pre-action listener: _resource_record_pre_action 21:10:11 INFO - Running main action method: create_virtualenv 21:10:11 INFO - Creating virtualenv /builds/slave/test/build/venv 21:10:11 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 21:10:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:10:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:10:12 INFO - Using real prefix '/tools/python27' 21:10:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:10:12 INFO - Installing distribute.............................................................................................................................................................................................done. 21:10:16 INFO - Installing pip.................done. 21:10:16 INFO - Return code: 0 21:10:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a7be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a79b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f925b55d340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6e19f0>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d58c8>, '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.gIllW8vMdt/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.tDd8hL5KFC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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 21:10:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:10:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIllW8vMdt/Render', 21:10:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:16 INFO - 'HOME': '/Users/cltbld', 21:10:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:16 INFO - 'LOGNAME': 'cltbld', 21:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:16 INFO - 'MOZ_NO_REMOTE': '1', 21:10:16 INFO - 'NO_EM_RESTART': '1', 21:10:16 INFO - 'PAGER': '/bin/cat', 21:10:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:16 INFO - 'PWD': '/builds/slave/test', 21:10:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:16 INFO - 'SHELL': '/bin/bash', 21:10:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDd8hL5KFC/Listeners', 21:10:16 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 21:10:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:16 INFO - 'USER': 'cltbld', 21:10:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:16 INFO - 'XPC_FLAGS': '0x0', 21:10:16 INFO - 'XPC_SERVICE_NAME': '0', 21:10:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:17 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 21:10:17 INFO - Cleaning up... 21:10:17 INFO - Return code: 0 21:10:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:10:17 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')]} 21:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:17 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')]} 21:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:17 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 0x10a7be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a79b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f925b55d340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6e19f0>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d58c8>, '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.gIllW8vMdt/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.tDd8hL5KFC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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 21:10:17 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 21:10:17 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 21:10:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIllW8vMdt/Render', 21:10:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:17 INFO - 'HOME': '/Users/cltbld', 21:10:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:17 INFO - 'LOGNAME': 'cltbld', 21:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:17 INFO - 'MOZ_NO_REMOTE': '1', 21:10:17 INFO - 'NO_EM_RESTART': '1', 21:10:17 INFO - 'PAGER': '/bin/cat', 21:10:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:17 INFO - 'PWD': '/builds/slave/test', 21:10:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:17 INFO - 'SHELL': '/bin/bash', 21:10:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDd8hL5KFC/Listeners', 21:10:17 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 21:10:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:17 INFO - 'USER': 'cltbld', 21:10:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:17 INFO - 'XPC_FLAGS': '0x0', 21:10:17 INFO - 'XPC_SERVICE_NAME': '0', 21:10:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:17 INFO - Downloading/unpacking psutil>=0.7.1 21:10:17 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 21:10:17 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 21:10:17 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 21:10:17 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 21:10:17 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 21:10:17 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 21:10:20 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 21:10:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:10:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:10:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:10:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:10:20 INFO - Installing collected packages: psutil 21:10:20 INFO - Running setup.py install for psutil 21:10:20 INFO - building 'psutil._psutil_osx' extension 21:10:20 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 21:10:22 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 21:10:22 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 21:10:22 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 21:10:22 INFO - building 'psutil._psutil_posix' extension 21:10:22 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 21:10:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:10:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:10:22 INFO - ^ 21:10:22 INFO - 1 warning generated. 21:10:22 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 21:10:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:10:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:10:23 INFO - Successfully installed psutil 21:10:23 INFO - Cleaning up... 21:10:23 INFO - Return code: 0 21:10:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:10:23 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')]} 21:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:23 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')]} 21:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:23 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 0x10a7be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a79b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f925b55d340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6e19f0>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d58c8>, '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.gIllW8vMdt/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.tDd8hL5KFC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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 21:10:23 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 21:10:23 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 21:10:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIllW8vMdt/Render', 21:10:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:23 INFO - 'HOME': '/Users/cltbld', 21:10:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:23 INFO - 'LOGNAME': 'cltbld', 21:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:23 INFO - 'MOZ_NO_REMOTE': '1', 21:10:23 INFO - 'NO_EM_RESTART': '1', 21:10:23 INFO - 'PAGER': '/bin/cat', 21:10:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:23 INFO - 'PWD': '/builds/slave/test', 21:10:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:23 INFO - 'SHELL': '/bin/bash', 21:10:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDd8hL5KFC/Listeners', 21:10:23 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 21:10:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:23 INFO - 'USER': 'cltbld', 21:10:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:23 INFO - 'XPC_FLAGS': '0x0', 21:10:23 INFO - 'XPC_SERVICE_NAME': '0', 21:10:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:10:23 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 21:10:23 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 21:10:23 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 21:10:23 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 21:10:23 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 21:10:23 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 21:10:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:10:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:10:25 INFO - Installing collected packages: mozsystemmonitor 21:10:25 INFO - Running setup.py install for mozsystemmonitor 21:10:25 INFO - Successfully installed mozsystemmonitor 21:10:25 INFO - Cleaning up... 21:10:26 INFO - Return code: 0 21:10:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:10:26 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')]} 21:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:26 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')]} 21:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:26 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 0x10a7be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a79b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f925b55d340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6e19f0>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d58c8>, '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.gIllW8vMdt/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.tDd8hL5KFC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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 21:10:26 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 21:10:26 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 21:10:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIllW8vMdt/Render', 21:10:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:26 INFO - 'HOME': '/Users/cltbld', 21:10:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:26 INFO - 'LOGNAME': 'cltbld', 21:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:26 INFO - 'MOZ_NO_REMOTE': '1', 21:10:26 INFO - 'NO_EM_RESTART': '1', 21:10:26 INFO - 'PAGER': '/bin/cat', 21:10:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:26 INFO - 'PWD': '/builds/slave/test', 21:10:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:26 INFO - 'SHELL': '/bin/bash', 21:10:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDd8hL5KFC/Listeners', 21:10:26 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 21:10:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:26 INFO - 'USER': 'cltbld', 21:10:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:26 INFO - 'XPC_FLAGS': '0x0', 21:10:26 INFO - 'XPC_SERVICE_NAME': '0', 21:10:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:26 INFO - Downloading/unpacking blobuploader==1.2.4 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:28 INFO - Downloading blobuploader-1.2.4.tar.gz 21:10:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:10:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:10:28 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 21:10:28 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 21:10:28 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 21:10:28 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 21:10:28 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 21:10:28 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 21:10:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:10:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:10:29 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 21:10:29 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 21:10:29 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 21:10:29 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 21:10:29 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 21:10:29 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 21:10:29 INFO - Downloading docopt-0.6.1.tar.gz 21:10:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:10:30 INFO - Installing collected packages: blobuploader, requests, docopt 21:10:30 INFO - Running setup.py install for blobuploader 21:10:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:10:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:10:30 INFO - Running setup.py install for requests 21:10:30 INFO - Running setup.py install for docopt 21:10:30 INFO - Successfully installed blobuploader requests docopt 21:10:30 INFO - Cleaning up... 21:10:30 INFO - Return code: 0 21:10:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:10:30 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')]} 21:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:30 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')]} 21:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:31 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 0x10a7be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a79b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f925b55d340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6e19f0>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d58c8>, '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.gIllW8vMdt/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.tDd8hL5KFC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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 21:10:31 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 21:10:31 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 21:10:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIllW8vMdt/Render', 21:10:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:31 INFO - 'HOME': '/Users/cltbld', 21:10:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:31 INFO - 'LOGNAME': 'cltbld', 21:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:31 INFO - 'MOZ_NO_REMOTE': '1', 21:10:31 INFO - 'NO_EM_RESTART': '1', 21:10:31 INFO - 'PAGER': '/bin/cat', 21:10:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:31 INFO - 'PWD': '/builds/slave/test', 21:10:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:31 INFO - 'SHELL': '/bin/bash', 21:10:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDd8hL5KFC/Listeners', 21:10:31 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 21:10:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:31 INFO - 'USER': 'cltbld', 21:10:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:31 INFO - 'XPC_FLAGS': '0x0', 21:10:31 INFO - 'XPC_SERVICE_NAME': '0', 21:10:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:10:31 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-o2fjI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:10:31 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-SMqf9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:10:31 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-n9Z4DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:10:31 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-5vU2Ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:10:31 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-M__1s_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:10:31 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-rhqxvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:10:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-k6JSD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:10:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-IIUWcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:10:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-GcHQmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:10:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-xHPC_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:10:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-15SCNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:10:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-ZbhfQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:10:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-lgJNOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:10:32 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-kwl2oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:10:33 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-XuHwQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:10:33 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-WiTg9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:10:33 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-DxVmRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:10:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:10:33 INFO - Running setup.py install for manifestparser 21:10:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:10:33 INFO - Running setup.py install for mozcrash 21:10:33 INFO - Running setup.py install for mozdebug 21:10:33 INFO - Running setup.py install for mozdevice 21:10:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:10:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:10:34 INFO - Running setup.py install for mozfile 21:10:34 INFO - Running setup.py install for mozhttpd 21:10:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:10:34 INFO - Running setup.py install for mozinfo 21:10:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:10:34 INFO - Running setup.py install for mozInstall 21:10:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:10:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:10:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:10:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:10:34 INFO - Running setup.py install for mozleak 21:10:34 INFO - Running setup.py install for mozlog 21:10:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:10:35 INFO - Running setup.py install for moznetwork 21:10:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:10:35 INFO - Running setup.py install for mozprocess 21:10:35 INFO - Running setup.py install for mozprofile 21:10:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:10:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:10:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:10:35 INFO - Running setup.py install for mozrunner 21:10:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:10:35 INFO - Running setup.py install for mozscreenshot 21:10:36 INFO - Running setup.py install for moztest 21:10:36 INFO - Running setup.py install for mozversion 21:10:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:10:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:10:36 INFO - Cleaning up... 21:10:36 INFO - Return code: 0 21:10:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:36 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 0x10a7be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a79b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f925b55d340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6e19f0>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d58c8>, '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.gIllW8vMdt/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.tDd8hL5KFC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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 21:10:36 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 21:10:36 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 21:10:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIllW8vMdt/Render', 21:10:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:36 INFO - 'HOME': '/Users/cltbld', 21:10:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:36 INFO - 'LOGNAME': 'cltbld', 21:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:36 INFO - 'MOZ_NO_REMOTE': '1', 21:10:36 INFO - 'NO_EM_RESTART': '1', 21:10:36 INFO - 'PAGER': '/bin/cat', 21:10:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:36 INFO - 'PWD': '/builds/slave/test', 21:10:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:36 INFO - 'SHELL': '/bin/bash', 21:10:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDd8hL5KFC/Listeners', 21:10:36 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 21:10:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:36 INFO - 'USER': 'cltbld', 21:10:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:36 INFO - 'XPC_FLAGS': '0x0', 21:10:36 INFO - 'XPC_SERVICE_NAME': '0', 21:10:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:10:36 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-IpMx_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:10:36 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)) 21:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:10:36 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-5Ootnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:10:36 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)) 21:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:10:36 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-gekfE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:10:37 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)) 21:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:10:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-Blaq2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:10:37 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)) 21:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:10:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-tzPE5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:10:37 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)) 21:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:10:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-wvbBM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:10:37 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)) 21:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:10:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-gspMDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:10:37 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)) 21:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:10:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-7ycqle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:10:37 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)) 21:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:10:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-ws6fVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:10:37 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)) 21:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:10:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-SRLI6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:10:37 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)) 21:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:10:37 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-6AjvKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:10:38 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)) 21:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:10:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-l5AJ1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:10:38 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)) 21:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:10:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-HpDPvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:10:38 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)) 21:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:10:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-PJt0mI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:10:38 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)) 21:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:10:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-4dAPqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:10:38 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)) 21:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:10:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-1UIq9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:10:38 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)) 21:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:10:38 INFO - Running setup.py (path:/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/pip-J1CQV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:10:38 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)) 21:10:38 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)) 21:10:38 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)) 21:10:38 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)) 21:10:38 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)) 21:10:38 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)) 21:10:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:10:38 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 21:10:38 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 21:10:38 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 21:10:38 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 21:10:38 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 21:10:38 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 21:10:41 INFO - Downloading blessings-1.5.1.tar.gz 21:10:41 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 21:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:10:41 INFO - Installing collected packages: blessings 21:10:41 INFO - Running setup.py install for blessings 21:10:41 INFO - Successfully installed blessings 21:10:41 INFO - Cleaning up... 21:10:41 INFO - Return code: 0 21:10:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:10:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:10:42 INFO - Reading from file tmpfile_stdout 21:10:42 INFO - Current package versions: 21:10:42 INFO - blessings == 1.5.1 21:10:42 INFO - blobuploader == 1.2.4 21:10:42 INFO - docopt == 0.6.1 21:10:42 INFO - manifestparser == 1.1 21:10:42 INFO - mozInstall == 1.12 21:10:42 INFO - mozcrash == 0.16 21:10:42 INFO - mozdebug == 0.1 21:10:42 INFO - mozdevice == 0.47 21:10:42 INFO - mozfile == 1.2 21:10:42 INFO - mozhttpd == 0.7 21:10:42 INFO - mozinfo == 0.9 21:10:42 INFO - mozleak == 0.1 21:10:42 INFO - mozlog == 3.0 21:10:42 INFO - moznetwork == 0.27 21:10:42 INFO - mozprocess == 0.22 21:10:42 INFO - mozprofile == 0.27 21:10:42 INFO - mozrunner == 6.11 21:10:42 INFO - mozscreenshot == 0.1 21:10:42 INFO - mozsystemmonitor == 0.0 21:10:42 INFO - moztest == 0.7 21:10:42 INFO - mozversion == 1.4 21:10:42 INFO - psutil == 3.1.1 21:10:42 INFO - requests == 1.2.3 21:10:42 INFO - wsgiref == 0.1.2 21:10:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:42 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 0x10a7be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a79b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f925b55d340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a6e19f0>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d58c8>, '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.gIllW8vMdt/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.tDd8hL5KFC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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 21:10:42 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 21:10:42 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 21:10:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIllW8vMdt/Render', 21:10:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:42 INFO - 'HOME': '/Users/cltbld', 21:10:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:42 INFO - 'LOGNAME': 'cltbld', 21:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:42 INFO - 'MOZ_NO_REMOTE': '1', 21:10:42 INFO - 'NO_EM_RESTART': '1', 21:10:42 INFO - 'PAGER': '/bin/cat', 21:10:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:42 INFO - 'PWD': '/builds/slave/test', 21:10:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:42 INFO - 'SHELL': '/bin/bash', 21:10:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDd8hL5KFC/Listeners', 21:10:42 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 21:10:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:42 INFO - 'USER': 'cltbld', 21:10:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:42 INFO - 'XPC_FLAGS': '0x0', 21:10:42 INFO - 'XPC_SERVICE_NAME': '0', 21:10:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:42 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)) 21:10:42 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)) 21:10:42 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)) 21:10:42 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)) 21:10:42 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)) 21:10:42 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)) 21:10:42 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)) 21:10:42 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)) 21:10:42 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)) 21:10:42 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)) 21:10:42 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)) 21:10:42 INFO - Cleaning up... 21:10:42 INFO - Return code: 0 21:10:42 INFO - Running post-action listener: _resource_record_post_action 21:10:42 INFO - Running post-action listener: _start_resource_monitoring 21:10:42 INFO - Starting resource monitoring. 21:10:42 INFO - ##### 21:10:42 INFO - ##### Running install step. 21:10:42 INFO - ##### 21:10:42 INFO - Running pre-action listener: _resource_record_pre_action 21:10:42 INFO - Running main action method: install 21:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:10:42 INFO - Reading from file tmpfile_stdout 21:10:42 INFO - Detecting whether we're running mozinstall >=1.0... 21:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:10:42 INFO - Reading from file tmpfile_stdout 21:10:42 INFO - Output received: 21:10:42 INFO - Usage: mozinstall [options] installer 21:10:42 INFO - Options: 21:10:42 INFO - -h, --help show this help message and exit 21:10:42 INFO - -d DEST, --destination=DEST 21:10:42 INFO - Directory to install application into. [default: 21:10:42 INFO - "/builds/slave/test"] 21:10:42 INFO - --app=APP Application being installed. [default: firefox] 21:10:42 INFO - mkdir: /builds/slave/test/build/application 21:10:42 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'] 21:10:42 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 21:11:20 INFO - Reading from file tmpfile_stdout 21:11:20 INFO - Output received: 21:11:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:11:20 INFO - Running post-action listener: _resource_record_post_action 21:11:20 INFO - ##### 21:11:20 INFO - ##### Running run-tests step. 21:11:20 INFO - ##### 21:11:20 INFO - Running pre-action listener: _resource_record_pre_action 21:11:20 INFO - Running main action method: run_tests 21:11:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:11:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:11:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:11:20 INFO - 2015-11-12 21:11:20.505 screenresolution[1637:8232] starting screenresolution argv=screenresolution get 21:11:20 INFO - 2015-11-12 21:11:20.508 screenresolution[1637:8232] Display 0: 1600x1200x32@60 21:11:20 INFO - 2015-11-12 21:11:20.514 screenresolution[1638:8234] starting screenresolution argv=screenresolution list 21:11:20 INFO - Available Modes on Display 0 21:11:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:11:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:11:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:11:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:11:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:11:20 INFO - Intel HD Graphics 3000: 21:11:20 INFO - Chipset Model: Intel HD Graphics 3000 21:11:20 INFO - Type: GPU 21:11:20 INFO - Bus: Built-In 21:11:20 INFO - VRAM (Total): 512 MB 21:11:20 INFO - VRAM (Dynamic, Max): 10 21:11:20 INFO - Vendor: Intel (0x8086) 21:11:20 INFO - Device ID: 0x0116 21:11:20 INFO - Revision ID: 0x0009 21:11:20 INFO - Displays: 21:11:20 INFO - Display: 21:11:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:11:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:11:20 INFO - Display Serial Number: 1600x1200 60 21:11:20 INFO - Main Display: Yes 21:11:20 INFO - Mirror: Off 21:11:20 INFO - Online: Yes 21:11:20 INFO - Rotation: Supported 21:11:20 INFO - Return code: 0 21:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:11:20 INFO - Python 2.7.3 21:11:20 INFO - Return code: 0 21:11:20 INFO - grabbing minidump binary from tooltool 21:11:20 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')]} 21:11:20 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 0x10a6e19f0>, '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 0x10a441db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6d58c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:11:20 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 21:11:20 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 21:11:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:11:20 INFO - Return code: 0 21:11:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:11:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:11:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:11:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:11:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:11:20 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/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0041', '--webServer', 'localhost'] in /builds/slave/test/build 21:11:20 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/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0041 --webServer localhost 21:11:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIllW8vMdt/Render', 21:11:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:11:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:11:20 INFO - 'HOME': '/Users/cltbld', 21:11:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:11:20 INFO - 'LOGNAME': 'cltbld', 21:11:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:11:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:20 INFO - 'MOZ_NO_REMOTE': '1', 21:11:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:11:20 INFO - 'NO_EM_RESTART': '1', 21:11:20 INFO - 'PAGER': '/bin/cat', 21:11:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:20 INFO - 'PWD': '/builds/slave/test', 21:11:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:11:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:11:20 INFO - 'SHELL': '/bin/bash', 21:11:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDd8hL5KFC/Listeners', 21:11:20 INFO - 'TMPDIR': '/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/', 21:11:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:11:20 INFO - 'USER': 'cltbld', 21:11:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:11:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:20 INFO - 'XPC_FLAGS': '0x0', 21:11:20 INFO - 'XPC_SERVICE_NAME': '0', 21:11:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:11:20 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/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0041', '--webServer', 'localhost'] with output_timeout 3600 21:11:21 INFO - mozversion INFO | application_buildid: 20151112201936 21:11:21 INFO - mozversion INFO | application_changeset: aa323766c0f998f1c36eb0e8ca821b828a81701d 21:11:21 INFO - mozversion INFO | application_display_name: Nightly 21:11:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:11:21 INFO - mozversion INFO | application_name: Firefox 21:11:21 INFO - mozversion INFO | application_remotingname: firefox 21:11:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:11:21 INFO - mozversion INFO | application_vendor: Mozilla 21:11:21 INFO - mozversion INFO | application_version: 45.0a1 21:11:21 INFO - mozversion INFO | platform_buildid: 20151112201936 21:11:21 INFO - mozversion INFO | platform_changeset: aa323766c0f998f1c36eb0e8ca821b828a81701d 21:11:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:11:21 INFO - mozversion INFO | platform_version: 45.0a1 21:11:21 INFO - 2015-11-12 21:11:21,206 DEBUG : using testdate: 1447391481 21:11:21 INFO - 2015-11-12 21:11:21,206 DEBUG : actual date: 1447391481 21:11:21 INFO - 2015-11-12 21:11:21,307 INFO : starting webserver on 'localhost:49265' 21:11:21 INFO - 2015-11-12 21:11:21,308 INFO : Starting test suite t-yosemite-r5-0041.e 21:11:21 INFO - 2015-11-12 21:11:21,308 INFO : Starting test dromaeo_css 21:11:21 INFO - 2015-11-12 21:11:21,308 DEBUG : operating with platform_type : mac_ 21:11:21 INFO - 2015-11-12 21:11:21,309 INFO : Initialising browser for dromaeo_css test... 21:11:21 INFO - 2015-11-12 21:11:21,339 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmpnha2Z8/profile http://localhost:49265/getInfo.html 21:11:25 INFO - 2015-11-12 21:11:25,676 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:11:25 INFO - 2015-11-12 21:11:25,676 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:11:25 INFO - 2015-11-12 21:11:25,676 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 21:11:25 INFO - 2015-11-12 21:11:25,676 DEBUG : BROWSER_OUTPUT: __metrics 21:11:26 INFO - 2015-11-12 21:11:26,321 INFO : Browser initialized. 21:11:26 INFO - 2015-11-12 21:11:26,322 INFO : Running cycle 1/1 for dromaeo_css test... 21:11:26 INFO - 2015-11-12 21:11:26,322 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmpnha2Z8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:11:38 INFO - 2015-11-12 21:11:38,344 DEBUG : BROWSER_OUTPUT: RSS: Main: 241311744 21:11:38 INFO - 2015-11-12 21:11:38,344 DEBUG : BROWSER_OUTPUT: 21:12:28 INFO - 2015-11-12 21:12:28,199 DEBUG : BROWSER_OUTPUT: 1447391548198 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] 21:14:38 INFO - 2015-11-12 21:14:38,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49265/tests/dromaeo/cssquery-ext.html) 21:14:39 INFO - 2015-11-12 21:14:39,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 265961472 21:14:39 INFO - 2015-11-12 21:14:39,511 DEBUG : BROWSER_OUTPUT: 21:17:41 INFO - 2015-11-12 21:17:41,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-ext.html (next: http://localhost:49265/tests/dromaeo/cssquery-jquery.html) 21:17:42 INFO - 2015-11-12 21:17:42,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 270303232 21:17:42 INFO - 2015-11-12 21:17:42,087 DEBUG : BROWSER_OUTPUT: 21:20:43 INFO - 2015-11-12 21:20:43,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49265/tests/dromaeo/cssquery-mootools.html) 21:20:44 INFO - 2015-11-12 21:20:44,404 DEBUG : BROWSER_OUTPUT: RSS: Main: 274669568 21:20:44 INFO - 2015-11-12 21:20:44,404 DEBUG : BROWSER_OUTPUT: 21:23:46 INFO - 2015-11-12 21:23:46,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49265/tests/dromaeo/cssquery-prototype.html) 21:23:46 INFO - 2015-11-12 21:23:46,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 277757952 21:23:46 INFO - 2015-11-12 21:23:46,656 DEBUG : BROWSER_OUTPUT: 21:26:49 INFO - 2015-11-12 21:26:49,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49265/tests/dromaeo/cssquery-yui.html) 21:26:49 INFO - 2015-11-12 21:26:49,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 284463104 21:26:49 INFO - 2015-11-12 21:26:49,786 DEBUG : BROWSER_OUTPUT: 21:29:51 INFO - 2015-11-12 21:29:51,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-yui.html (next: http://localhost:49265/tests/dromaeo/cssquery-dojo.html) 21:29:52 INFO - 2015-11-12 21:29:52,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 287461376 21:29:52 INFO - 2015-11-12 21:29:52,194 DEBUG : BROWSER_OUTPUT: 21:29:52 INFO - 2015-11-12 21:29:52,195 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:29:52 INFO - 2015-11-12 21:29:52,195 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:29:52 INFO - 2015-11-12 21:29:52,195 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:29:52 INFO - 2015-11-12 21:29:52,195 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:29:52 INFO - 2015-11-12 21:29:52,195 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3245.691659292367;3300.785448945817;3311.619163796163;3332.800031998079;3358.126887009378;5115.618782928607;5344.545713614342;5357.892842143155;5387.353517577886;5468.343798744151;4083.5508094109623;5058.418281897583;5131.179011358184;5159.974200128994;5254.894902101955;4734.692245004081;4746.620270378378;4813.49458306878;4842.588379987706;4900.044491324194;194.44590424853044;4748.97625511872;4849.975750121244;4888.120138375091;4919.631027672921;4659.976700116495;4687.390639216914;4738.763061846911;4744.478107408182;4745.406824146981;4838.685485443435;4873.512648735134;4908.0429316283335;4913.041956818422;4945.752712364403;4617.746023968681;4835.5889749371345;4840.806367745321;4872.171730805736;4960.553550180501;4995.475475075101;5094.133997220481;5123.769430375642;5135.435102138762;5156.071907056728;5478.397376288605;5574.470425309589;5621.409751976024;5621.915671264935;5670.5747068969995;5413.864653383657;5521.834344969658;5594.888102237973;5623.325200975909;5680.602357834953;5294.047071527124;5297.337832770903;5311.760970756287;5372.274742909735;5403.459654034565;5699.116636921284;5775.537956963432;5817.563682723728;5835.212246346774;5846.766129354864;5341.679499230058;5368.570514358842;5455.699936503451;5553.611247212737;5618.747156377891;5656.575756818255;5688.544916406678;5699.031164701928;5707.286589176353;5726.656400615976;5540.445955404427;5640.266765320564;5645.23789288449;5647.519960803295;5672.602917795714;5241.764120614582;5424;5512.531434828004;5538.418466061086;5559.583031272671;4441.333799930037;4445.066536027406;4460.264056430653;4465.754383508874;4505;3944.980275098606;4034.374671925856;4045.696572757055;4047.959520404758;4076.144009757984;5208.244804503326;5213.582913366998;5255.264263003182;5276.709780962084;5282.577393808486;5494.697791621419;5532.419095994943;5551.028570000234;5566.526845218121;5582.358028826656;5212.50481204285;5217.713025783618;5249.238860365225;5267.051930652519;5321.627486076015;4992.051510213048;5005.399352077701;5005.474425185376;5014.623903207274;5030.0945829751;5815.273090863642;5852.531797456193;5859.619124756877;5871;5940.316863560746;5048.343715317133;5543.584231182596;5566.777328906798;5663.263775709132;5678.744456499385;5726.455986681259;5843.620164689281;5850.853728656818;5879.559033072451;5879.647221166743;5354.919676204782;5598.3282006159525;5634;5656.886862262814;5689.288838895138;5469.671819690831;5560.19377190297;5608.831735047955;5653.462921022497;5661.801836935688;5593.384727680033;5603.831885043455;5606.159076138611;5617.157426386075;5620.831375058755;5345.1714984177515;5356.839294821161;5464.453554644504;5595.524380427709;5643.463870932255;5256.132738098171;5302.893942121059;5318.8936221276135;5324.361076670824;5372.597055220952;5425.864353391197;5568.248286481273;5593.690594956358;5597.944020559742;5619.719014049363;5226.085435048775;5350.411454739898;5375.731213439391;5514.365847927379;5519.144532597294 21:29:52 INFO - 2015-11-12 21:29:52,195 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.2268535393125;557.3618207152807;558.9021921163798;573.3549756523911;578.5545130249708;39329.21341573167;39860;40360;40441.3933790993;40451.190976180456;42744.786276068575;43160.352594711105;43167.35248971268;43193;43392.78303608485;9306.39508431953;9334.439933604006;9427.811443771156;9505.14453699167;9539.666111686092;9160.633574657006;9310.115539023816;9313.487758173298;9324.580393882257;9325.95337023314;8981.23659488941;9247.6300947962;9273.397229180115;9278.675246366378;9306.348555601111;9140.908590914105;9239.676611318571;9289.396189247745;9313.813723725556;9339.112784285482;9009.549522523848;9177.541122943827;9183.540822958892;9187.540622968892;9221.262299016129;39872.40191397131;40367;40408.79795601033;40561.79719101386;40622.187556249;2391.6173412253956;2671.4539333330026;2741.616173735679;2902.274431392152;2919.1972207642857;26738.331541711417;27384.178474645792;27455.313617159733;27558;28579;2324.302709187254;2345.413646588353;2350.4828937633692;2388.5700573896693;2438.7073551173794;238860;239371;239552;241264;242640;54564.727176363864;55369.16946245809;58015.70992145012;58574.70712646495;59017.40982590119;53335.46664533383;53873;54199;54294.7285263579;54324;14974.700505989818;15213.391464341303;15231.086134831945;15237.923810380877;15246.542603721906;11259.831102533468;11311.038561722182;11469.88530114705;11625.825612615818;11658.941705291589;19201.231950722093;19349.032548372525;19358;19405.32081377145;19455.3190638327;8226.218509241613;8481.7277408388;8515;8553.101924297984;8574.099719529484;935.8034812689275;962.4946902876046;1045.879723831769;1061.7239517725448;1142.6743378137191;29045.85477072601;29157.125286241448;29316.413671726445;29712.851435743116;29827.552586711216;984.9409035457752;1019.454591793387;1025.3232866308201;1130.174972270231;1207.945642446092;13934.790978135336;14096.436142554388;14211.218382989035;14214;14876.404943802343;319262;322959;324499;325358;325717;54964;55059.72470137624;55191.72404138034;55256;55807.44192558023;1352.377906163176;1355.627202519315;1367.3505085084705;1370.7327071221216;1371.8422381426064;28091.297717557223;28224.729887154717;28636.570451443662;28661.570076449287;29113.563296550146;47381.76309118432;47497.52502475069;47606.04787904153;47843.52156478391;48275.75862120807;300495;302401;304838;305275;306519;28118;28785;29398;32305.676943230268;33283.66716332806;39368.212635747695;39732;40259.17537833901;40681;41136.58863411328;33095.66904330926;34339;34347.22180560186;34366.82816585901;34377.31245375029;33202.33595328128;33910;33972;34199.31601367909;34422.31155376929;33851;34462.31075378428;34759.47860782141;34806;35180.12049698778;25373.746262537137;27524.58713119265;27551.862240688668;27552.724472755017;27589.58615620727;20835.68746468774;20890.895545522177;21058;21128.683069753657;21139.154433822474 21:29:52 INFO - 2015-11-12 21:29:52,196 DEBUG : BROWSER_OUTPUT: |2;jquery.html;329.3544652481137;333.394888277776;334.1329250594706;340.11569918212643;340.92329225924163;11519.36643484608;11901.226420282675;17385;17460.214290356933;18001.189946452407;11512.13658975576;11551.075913926887;11753.588624398148;11758.17692761505;11819.822702659467;4393.846215382454;4447.177272204636;4504.572065653758;4512.796924138422;4550.294704320836;4395.494518130424;6698.933010669904;6969.268226836185;6973.581585104885;7045.929540704578;6088.786892458765;6580.638064906429;6853.623050732208;6955.965220173892;6961;6521.804345869631;6590.439812615909;6610.933890661104;6612.768553100643;6973.79078627642;6534.987077003072;6576.342365763386;6620.040094186316;6642.7342906284175;6645.534812563123;17770.822291777047;17791.644167116585;22792.658110128363;23687.34188606798;24064.879675601685;2029.401326608654;2042.1831267493121;2092;2215.368619943308;2233.8101261392803;13982.930085349508;14055.50805721805;14222.857771422361;14261.78607320891;14748.336324865406;1648.208859747316;1709.3931654262683;1717.6650553142017;1735.6962531557053;1746.9650606987789;65285.67357163232;66207.66896165536;66634.00048999318;66702.33297667059;66857;16701.24844382006;17016.57458563546;17156.485305440856;17353.2191051403;17409;24801.875990620294;24871.87564062168;25143;25170.24489265325;25216.369590760012;9330.58012389444;9395.201407880406;9421.24630029596;9421.340506164639;9466.90533094674;7863.095743989515;7930.920690793134;7965.761027169194;7998.520088794691;8065.677372905136;7773.883391749128;7837.451378403457;7857.2928436441;7877.448578599558;7893.723719669899;1062.85651437055;3168.7623428242514;3282.0810173151553;3284.080457471912;3295.126791400281;403.3908797715471;428.8241820853498;433.18344919826353;434.66096444773126;458.0701176611484;10228.693139205836;11048.723781905517;11312.15158863072;11417.086633069335;11498.54005839757;410.72070991725315;433.73108672623175;448.4752839178169;456.2836346935346;471.78062201076665;5876.529877609781;6203.2245969253845;6250.1874756282305;6259.906101408483;6322.589031712924;504665;508552;509316;526527;539249;69088;70971.2902870975;71123.64438177776;71846.64076679583;72138.63930680418;478.32317271061754;496.36713190682167;501.4809671989546;506.5542322755951;512.5207930584914;10503.737406564896;10648.467576621293;10675.466226688479;10697.839532406864;10735.194860385345;33711.32577348488;33788.155296117795;34227.82886085554;34245.315093697485;34434;46375.53624463712;46819;47603.5239647613;47753.522464774906;47824;6075.817725468243;6126.693665316628;6184.041473571604;6198.008318669172;6207.720652570735;10889.727756805827;11595.768084638092;11612.941935290608;11637.53449861996;11733.882661173278;9672.85490717654;9721.416714997124;10106.797864042825;10209.183265338903;10305.587776488857;9679.419234845931;9751;9945.701628951143;9949.751256218653;10043.246756493147;10105.848412273968;10254.743631409274;10333.84499232497;10513.632022879163;10560.630377936735;6049.455549000611;6111.602745821508;6167.784127555514;6204.224471941007;6215.409536094064;9568.856467152858;10046.497675116361;10193.388396696222;10208.183345332503;10397.68806935763 21:29:52 INFO - 2015-11-12 21:29:52,199 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1445.6024593236853;1709.9658006839863;1711.803142638597;1717.9226934787932;1762.4184019273641;6835.14560679915;6854.07469991551;7298.598577078258;7648.732294369698;7657.23427657234;7485.438592105586;7664.233576642333;7742.14836367999;7761.3402860756905;7794.649240784164;2087.5929193807174;2139.12295958657;2144.0137536733046;2144.0887622760342;2144.549644574641;2175;2194.5391467791783;2219.4562332228625;2250.9212177573786;2254.582902163097;2158.7625361210335;2170.435686721448;2188.660757582569;2191.200211922645;2193.122750899645;2161.686555449459;2180.9345719628436;2185.8907054647284;2198.988465305961;2209.2157284164214;2166.0794162480884;2185.0058223508267;2186.212963333199;2186.8191176764526;2199.8560748410896;7760.262775036419;7795.61021948906;7815.413843961725;7816.41376896735;7918.406119541058;4582.473015603215;4644.187267228255;4663.626909847204;4668.5798278155125;4670.322803193518;2966.792324537283;2985.596944412498;3010.3527741535677;3051;3064.034829028871;921.2675922641449;926.9212116970066;944.211583327922;956.7990721948399;962.7689354554857;9702.51487425626;10224.386536807815;10271.7432064199;10290.176785857113;10312.587496500131;3996.680265578747;4020.7386519876113;4049.230646177217;4052.797360131982;4088.264112459726;8471;8493.957530212308;8502.78743031429;8590.87113693295;8599.14008599135;4659.370984916993;4666.230072038144;4671.672982891233;4671.672982891233;4695.647826412965;4219.282721937217;4309.116631090619;4309.655227581786;4310.245707001262;4311.547287534827;3438.157651375429;3477.043812951408;3485.5991560970815;3520.0847779577493;3555.466679997969;1025.323286630835;1041.9010194031555;1042.4579218806177;1042.7497400623795;1049.0663309654415;1232.7904256276454;1235.8393408856791;1246.837911071573;1267.9429425675867;1279.1621487925424;7281.089863767029;7388.482806203621;7401.444891633149;7402.518836275625;7430.145533263636;387.19270321380236;388.67351424802735;389.4839337877324;389.77003567895076;390.2273498473039;5691.630044047124;5727.4845263926445;5730.426957304319;5779.971100144557;5785.247917770663;9049;9079.863802042975;9171.358004939724;9171.58727857248;9217.86173207389;9107.08929107084;9120.224780893566;9132.954335228414;9148.542572871329;9192.586333615003;7060.71757129709;7277.59973201479;7323.523970941872;7340.779776606711;7430.554166750012;6895.793126206222;6903.930960690329;6922.550034247758;6953.513254072166;7003.4747393944635;7926.48477848961;8141.552214628252;8194.22154895284;8206.917930820615;8216.383771217303;8092.676292948451;8198.098209196864;8215.219554142346;8276.668933242603;8363.330933525425;5615.5507559395965;5950.137230101697;5976.970115149396;6443.452306553808;6502.60984340941;7380.557166570023;7425.7029718810645;7439.590822504598;7447.590382529013;7481.064866891638;6859.211190712932;6962.060121883481;6988.196357418962;7037.507374483737;7041.753538626123;6878.312168783082;6916.654167291716;6944.895826562504;6974;6975.8604827902145;6971.3028697129885;7008.439324854102;7012.298770122947;7097.041899343729;7119.359257666835;6354.618722876642;6374.426301632875;6376.52176086786;6404.039394090923;6414.390632889868;6323.841903952438;6340;6362.141110950148;6396.392342727433;6431.260405053479 21:29:52 INFO - 2015-11-12 21:29:52,200 DEBUG : BROWSER_OUTPUT: |4;prototype.html;306.1382209081436;314.73404972797994;315.49205778696296;321.1954055091994;322.82406088681665;6391.968040159804;6450.483961283092;6478.060681201223;6519.837004074894;6578.2106147262275;6477.967610161954;6485.546011779165;6503.414692677658;6511.804645860631;6566.080748695186;4827.8551643450755;4838.709677419357;4857.028594281141;4862.100511405383;4911.8772030699165;4828.130936431441;4829.734364609945;4829.951700482985;4839.104765618355;4849.830255941025;4336.804843782037;4727.621790256789;4731.834385796497;4738.312944623028;4740.739259340752;4753.263244197155;4761.0953918755495;4765.642576806753;4822.71063736177;4823.975880120612;4045.8786236412957;4049.5343035550995;4055.1889622075705;4064.715469917107;4071.653909417703;6084.209052823149;6262.342454042351;6315.147455093549;6335.778247761306;6357.745690172387;5384.1923711443205;5390.460953904578;5406.972965135188;5407.621466497347;5448.346198456171;6630.104935833649;6642.236142843586;6676.966615166942;6707.329267073303;6750.662466876685;4397.648188144941;4418.64650827933;4427.911441771179;4461.08547747711;4493.370928070073;6820.965895170542;6948.235694073648;7065;7093.538919970186;7146.749863754796;4482.103579284091;4497.955020449819;4500.729956202638;4508.278675411984;4516.774161291923;4554.567316104964;4555.931661025087;4560.771961401917;4609.446866375989;4637;5352.304200453994;5360.705161216092;5362.463753624685;5364.490373414519;5399.919001214985;6520.152380190545;6730.427913627396;6754.324567543206;6775.932240677629;6820.35206655367;1578.3607638906262;1599.1124925666368;1605.3177399605122;1606.7991501062368;1607.6463178100798;1008.1984822066474;1038.0449986012886;1039.5841663334575;1042.9478526073817;1049.6431213387332;6401.935980640227;6405.775797847053;6418.26189988148;6424.453921416639;6483.610983341015;6923.307669233036;6957.756478523227;6962.965185174042;6992.825179370557;6997.930020699728;6304.306526282106;6411;6411.487081033506;6454.2577603575255;6464.676766161767;3752.3433399155583;3801.5248093988253;3801.790901500444;3822.1591249924973;3839.7696138231236;7153.606551639606;7297.635118244173;7297.781066568012;7305.598192099379;7306.452016098814;7004;7209.639518024078;7214.350708436266;7282.271772822675;7287.562746235243;7217.783466496014;7290.890636640454;7307.707691692379;7317.451191160684;7317.52436091663;7041.3662770348865;7057.611831349325;7072.40870804065;7083.574985500681;7146.892796607951;6889.552179108342;6927.861442771217;6966.407855332151;6998.75504357345;7064.222935477196;7328.157261914735;7330.230325815713;7349.081364829396;7358.043454351115;7414.073240844895;4619.237825758846;4648.930266045944;4650.883727906829;4652.976735116303;4705.247160454448;6836.931630683828;6980.7905762827195;7003.6498175092065;7071.575705457689;7091.219965803654;6816.556923799937;6889.173299204128;6910.619915904674;6970;6976.860462790817;6880.967854821817;6888.070110535014;6893.172819261721;6946.235914049349;6982.79051628452;6490.9675451624325;6689.364510371507;6717.798466046026;6742.08981787472;6743.763968261087;6847.21257055445;6890.276520965427;6891.3797758202;6951.826204344729;6956.513044086865;6733.494987875831;6748.595084294958;6762.898556521558;6775.322467753185;6799.252082271045 21:29:52 INFO - 2015-11-12 21:29:52,201 DEBUG : BROWSER_OUTPUT: |5;yui.html;655.2955572759283;688.7589343729694;691.9625129060439;723.3995783499696;736.9263073692634;13790.517331893385;13959.232242226699;14095.78856317156;14148.929255353722;14249.430022799075;13074.411651475682;13185.604431867036;13194.53819116331;13222.603321900358;13325.400356983935;870.3907264914569;879.9032106468284;890.1499068389672;893.1336603494632;901.2879824938291;873.5064688451005;886.8492356299412;889.4752096263203;892.5135800988477;894.6421431427416;934.9392289501195;935.8409070458005;936.5036530638772;944.8866136063682;947.303731757158;932.7994481186544;937.1518775508142;938.3666025432806;938.5635679409107;957.1433566957569;682.757621044527;683.719674933275;688.3151264491862;689.3726708695064;689.6792991259039;12566;12615.93692031534;12638.431270592846;12687.048471364684;12747.426365813468;9940.25448091396;10194.439305838176;10368.481575921174;10403.375797452101;10699.83950240747;8835.204831565126;9040.77398065047;9077.36458447909;9231.769205769842;9280.257579393632;3217.790843595182;3224.596925384327;3233.644299127094;3249.366373557157;3343.648916863743;42340;43378;43442.78278608618;43506.564934350565;48302.516974830156;6827.180738311435;6855.314468553105;6887.690053947585;6891.241963384024;7067.611281379471;11913.702157446132;11920.821187682192;11930.642080737593;11937.343446110373;12044.638660840188;6055;6242.65665388408;6246.406591373812;6252.343503932113;6492.707828147744;3796.6962642988497;3827.13889374894;3828.8277027533827;3905.5899130591447;3968.960310396859;2595.5587550116147;2621.554335762925;2626.487834872182;2629.4609605030923;2644.008496813695;403.1332634835128;405.19366460742907;405.55794184339214;407.6860817170762;413.7331421233288;535.7776522743018;574.9223854779635;594.5956749410442;595.6217801695867;603.6317846113867;8043.638036288381;8055;8062.879056814152;8120.878186827203;8340.874886876702;560.1038338658115;574.9593236242415;593.4777395891588;594.0702800117801;609.9481544068715;3535.3106144301614;3816.542014958223;3841.750286231442;3937.1535119948776;3986.541547722049;57007.71496142493;57721.711391442775;57911.42088579144;58100.70949645225;60716.69641651763;48895.755521222876;49619.25571116436;50552.24171637429;50827.237591436155;51000;45581.08837823225;46487.30269046035;46704;47237;47347.76326118347;8308.127646597262;8450.450720703135;8500.70247541333;8509.36179786531;8698.347623928357;34634.307313853074;35135.12162195965;35231.647683523865;35314;35445.82277088598;43012.35481467843;45213;45792.77103614461;45815.54184458113;45850.312245317014;7584.924150758642;7586.355159811478;7712.228777122243;7761.456698031309;7984.960075199587;10770.30672394851;11205.495752690986;11500.769984600429;11804.409779511161;11926.344051077274;10265.897341026493;10550.630727924487;10590.205734569783;10690.41202733857;10840.891591084304;10326.741831454274;10336.741581460523;10351.223658225512;10685.732856678645;10859.945700271448;9651.276154288596;9655.710328690151;9657.372270802376;9713.125818676353;10161.745956350855;8732.912670873464;8745;8817.294616430541;8933.776655583662;9655.227581793299;8598.957005214934;8704.825903482022;8957.910420895969;9267.212286955684;9295.83802024747 21:29:52 INFO - 2015-11-12 21:29:52,202 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:29:52 INFO - 2015-11-12 21:29:52,202 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:29:52 INFO - 2015-11-12 21:29:52,202 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,283 21:29:52 INFO - 2015-11-12 21:29:52,202 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:29:52 INFO - 2015-11-12 21:29:52,202 DEBUG : BROWSER_OUTPUT: __startTimestamp1447392592188__endTimestamp 21:29:52 INFO - 2015-11-12 21:29:52,202 DEBUG : BROWSER_OUTPUT: 21:29:52 INFO - 2015-11-12 21:29:52,202 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:29:52 INFO - 2015-11-12 21:29:52,203 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:29:52 INFO - 2015-11-12 21:29:52,203 DEBUG : BROWSER_OUTPUT: 21:29:52 INFO - 2015-11-12 21:29:52,203 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5202.39 Median:5357.89 stddev:670.83 (12.5%) stddev-sans-first:655.09 21:29:52 INFO - 2015-11-12 21:29:52,204 DEBUG : BROWSER_OUTPUT: Values: 3245.7 3300.8 3311.6 3332.8 3358.1 5115.6 5344.5 5357.9 5387.4 5468.3 4083.6 5058.4 5131.2 5160.0 5254.9 4734.7 4746.6 4813.5 4842.6 4900.0 194.4 4749.0 4850.0 4888.1 4919.6 4660.0 4687.4 4738.8 4744.5 4745.4 4838.7 4873.5 4908.0 4913.0 4945.8 4617.7 4835.6 4840.8 4872.2 4960.6 4995.5 5094.1 5123.8 5135.4 5156.1 5478.4 5574.5 5621.4 5621.9 5670.6 5413.9 5521.8 5594.9 5623.3 5680.6 5294.0 5297.3 5311.8 5372.3 5403.5 5699.1 5775.5 5817.6 5835.2 5846.8 5341.7 5368.6 5455.7 5553.6 5618.7 5656.6 5688.5 5699.0 5707.3 5726.7 5540.4 5640.3 5645.2 5647.5 5672.6 5241.8 5424.0 5512.5 5538.4 5559.6 4441.3 4445.1 4460.3 4465.8 4505.0 3945.0 4034.4 4045.7 4048.0 4076.1 5208.2 5213.6 5255.3 5276.7 5282.6 5494.7 5532.4 5551.0 5566.5 5582.4 5212.5 5217.7 5249.2 5267.1 5321.6 4992.1 5005.4 5005.5 5014.6 5030.1 5815.3 5852.5 5859.6 5871.0 5940.3 5048.3 5543.6 5566.8 5663.3 5678.7 5726.5 5843.6 5850.9 5879.6 5879.6 5354.9 5598.3 5634.0 5656.9 5689.3 5469.7 5560.2 5608.8 5653.5 5661.8 5593.4 5603.8 5606.2 5617.2 5620.8 5345.2 5356.8 5464.5 5595.5 5643.5 5256.1 5302.9 5318.9 5324.4 5372.6 5425.9 5568.2 5593.7 5597.9 5619.7 5226.1 5350.4 5375.7 5514.4 5519.1 21:29:52 INFO - 2015-11-12 21:29:52,204 DEBUG : BROWSER_OUTPUT: 21:29:52 INFO - 2015-11-12 21:29:52,205 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45460.82 Median:33941.00 stddev:76254.42 (224.7%) stddev-sans-first:76393.79 21:29:52 INFO - 2015-11-12 21:29:52,206 DEBUG : BROWSER_OUTPUT: Values: 554.2 557.4 558.9 573.4 578.6 39329.2 39860.0 40360.0 40441.4 40451.2 42744.8 43160.4 43167.4 43193.0 43392.8 9306.4 9334.4 9427.8 9505.1 9539.7 9160.6 9310.1 9313.5 9324.6 9326.0 8981.2 9247.6 9273.4 9278.7 9306.3 9140.9 9239.7 9289.4 9313.8 9339.1 9009.5 9177.5 9183.5 9187.5 9221.3 39872.4 40367.0 40408.8 40561.8 40622.2 2391.6 2671.5 2741.6 2902.3 2919.2 26738.3 27384.2 27455.3 27558.0 28579.0 2324.3 2345.4 2350.5 2388.6 2438.7 238860.0 239371.0 239552.0 241264.0 242640.0 54564.7 55369.2 58015.7 58574.7 59017.4 53335.5 53873.0 54199.0 54294.7 54324.0 14974.7 15213.4 15231.1 15237.9 15246.5 11259.8 11311.0 11469.9 11625.8 11658.9 19201.2 19349.0 19358.0 19405.3 19455.3 8226.2 8481.7 8515.0 8553.1 8574.1 935.8 962.5 1045.9 1061.7 1142.7 29045.9 29157.1 29316.4 29712.9 29827.6 984.9 1019.5 1025.3 1130.2 1207.9 13934.8 14096.4 14211.2 14214.0 14876.4 319262.0 322959.0 324499.0 325358.0 325717.0 54964.0 55059.7 55191.7 55256.0 55807.4 1352.4 1355.6 1367.4 1370.7 1371.8 28091.3 28224.7 28636.6 28661.6 29113.6 47381.8 47497.5 47606.0 47843.5 48275.8 300495.0 302401.0 304838.0 305275.0 306519.0 28118.0 28785.0 29398.0 32305.7 33283.7 39368.2 39732.0 40259.2 40681.0 41136.6 33095.7 34339.0 34347.2 34366.8 34377.3 33202.3 33910.0 33972.0 34199.3 34422.3 33851.0 34462.3 34759.5 34806.0 35180.1 25373.7 27524.6 27551.9 27552.7 27589.6 20835.7 20890.9 21058.0 21128.7 21139.2 21:29:52 INFO - 2015-11-12 21:29:52,206 DEBUG : BROWSER_OUTPUT: 21:29:52 INFO - 2015-11-12 21:29:52,206 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27707.00 Median:4421.34 stddev:84666.67 (1915.0%) stddev-sans-first:84879.22 21:29:52 INFO - 2015-11-12 21:29:52,208 DEBUG : BROWSER_OUTPUT: Values: 329.4 333.4 334.1 340.1 340.9 11519.4 11901.2 17385.0 17460.2 18001.2 11512.1 11551.1 11753.6 11758.2 11819.8 4393.8 4447.2 4504.6 4512.8 4550.3 4395.5 6698.9 6969.3 6973.6 7045.9 6088.8 6580.6 6853.6 6956.0 6961.0 6521.8 6590.4 6610.9 6612.8 6973.8 6535.0 6576.3 6620.0 6642.7 6645.5 17770.8 17791.6 22792.7 23687.3 24064.9 2029.4 2042.2 2092.0 2215.4 2233.8 13982.9 14055.5 14222.9 14261.8 14748.3 1648.2 1709.4 1717.7 1735.7 1747.0 65285.7 66207.7 66634.0 66702.3 66857.0 16701.2 17016.6 17156.5 17353.2 17409.0 24801.9 24871.9 25143.0 25170.2 25216.4 9330.6 9395.2 9421.2 9421.3 9466.9 7863.1 7930.9 7965.8 7998.5 8065.7 7773.9 7837.5 7857.3 7877.4 7893.7 1062.9 3168.8 3282.1 3284.1 3295.1 403.4 428.8 433.2 434.7 458.1 10228.7 11048.7 11312.2 11417.1 11498.5 410.7 433.7 448.5 456.3 471.8 5876.5 6203.2 6250.2 6259.9 6322.6 504665.0 508552.0 509316.0 526527.0 539249.0 69088.0 70971.3 71123.6 71846.6 72138.6 478.3 496.4 501.5 506.6 512.5 10503.7 10648.5 10675.5 10697.8 10735.2 33711.3 33788.2 34227.8 34245.3 34434.0 46375.5 46819.0 47603.5 47753.5 47824.0 6075.8 6126.7 6184.0 6198.0 6207.7 10889.7 11595.8 11612.9 11637.5 11733.9 9672.9 9721.4 10106.8 10209.2 10305.6 9679.4 9751.0 9945.7 9949.8 10043.2 10105.8 10254.7 10333.8 10513.6 10560.6 6049.5 6111.6 6167.8 6204.2 6215.4 9568.9 10046.5 10193.4 10208.2 10397.7 21:29:52 INFO - 2015-11-12 21:29:52,208 DEBUG : BROWSER_OUTPUT: 21:29:52 INFO - 2015-11-12 21:29:52,208 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5307.16 Median:6368.28 stddev:2771.70 (43.5%) stddev-sans-first:2764.28 21:29:52 INFO - 2015-11-12 21:29:52,208 DEBUG : BROWSER_OUTPUT: Values: 1445.6 1710.0 1711.8 1717.9 1762.4 6835.1 6854.1 7298.6 7648.7 7657.2 7485.4 7664.2 7742.1 7761.3 7794.6 2087.6 2139.1 2144.0 2144.1 2144.5 2175.0 2194.5 2219.5 2250.9 2254.6 2158.8 2170.4 2188.7 2191.2 2193.1 2161.7 2180.9 2185.9 2199.0 2209.2 2166.1 2185.0 2186.2 2186.8 2199.9 7760.3 7795.6 7815.4 7816.4 7918.4 4582.5 4644.2 4663.6 4668.6 4670.3 2966.8 2985.6 3010.4 3051.0 3064.0 921.3 926.9 944.2 956.8 962.8 9702.5 10224.4 10271.7 10290.2 10312.6 3996.7 4020.7 4049.2 4052.8 4088.3 8471.0 8494.0 8502.8 8590.9 8599.1 4659.4 4666.2 4671.7 4671.7 4695.6 4219.3 4309.1 4309.7 4310.2 4311.5 3438.2 3477.0 3485.6 3520.1 3555.5 1025.3 1041.9 1042.5 1042.7 1049.1 1232.8 1235.8 1246.8 1267.9 1279.2 7281.1 7388.5 7401.4 7402.5 7430.1 387.2 388.7 389.5 389.8 390.2 5691.6 5727.5 5730.4 5780.0 5785.2 9049.0 9079.9 9171.4 9171.6 9217.9 9107.1 9120.2 9133.0 9148.5 9192.6 7060.7 7277.6 7323.5 7340.8 7430.6 6895.8 6903.9 6922.6 6953.5 7003.5 7926.5 8141.6 8194.2 8206.9 8216.4 8092.7 8198.1 8215.2 8276.7 8363.3 5615.6 5950.1 5977.0 6443.5 6502.6 7380.6 7425.7 7439.6 7447.6 7481.1 6859.2 6962.1 6988.2 7037.5 7041.8 6878.3 6916.7 6944.9 6974.0 6975.9 6971.3 7008.4 7012.3 7097.0 7119.4 6354.6 6374.4 6376.5 6404.0 6414.4 6323.8 6340.0 6362.1 6396.4 6431.3 21:29:52 INFO - 2015-11-12 21:29:52,209 DEBUG : BROWSER_OUTPUT: 21:29:52 INFO - 2015-11-12 21:29:52,209 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5631.38 Median:6471.32 stddev:1771.91 (27.4%) stddev-sans-first:1731.22 21:29:52 INFO - 2015-11-12 21:29:52,210 DEBUG : BROWSER_OUTPUT: Values: 306.1 314.7 315.5 321.2 322.8 6392.0 6450.5 6478.1 6519.8 6578.2 6478.0 6485.5 6503.4 6511.8 6566.1 4827.9 4838.7 4857.0 4862.1 4911.9 4828.1 4829.7 4830.0 4839.1 4849.8 4336.8 4727.6 4731.8 4738.3 4740.7 4753.3 4761.1 4765.6 4822.7 4824.0 4045.9 4049.5 4055.2 4064.7 4071.7 6084.2 6262.3 6315.1 6335.8 6357.7 5384.2 5390.5 5407.0 5407.6 5448.3 6630.1 6642.2 6677.0 6707.3 6750.7 4397.6 4418.6 4427.9 4461.1 4493.4 6821.0 6948.2 7065.0 7093.5 7146.7 4482.1 4498.0 4500.7 4508.3 4516.8 4554.6 4555.9 4560.8 4609.4 4637.0 5352.3 5360.7 5362.5 5364.5 5399.9 6520.2 6730.4 6754.3 6775.9 6820.4 1578.4 1599.1 1605.3 1606.8 1607.6 1008.2 1038.0 1039.6 1042.9 1049.6 6401.9 6405.8 6418.3 6424.5 6483.6 6923.3 6957.8 6963.0 6992.8 6997.9 6304.3 6411.0 6411.5 6454.3 6464.7 3752.3 3801.5 3801.8 3822.2 3839.8 7153.6 7297.6 7297.8 7305.6 7306.5 7004.0 7209.6 7214.4 7282.3 7287.6 7217.8 7290.9 7307.7 7317.5 7317.5 7041.4 7057.6 7072.4 7083.6 7146.9 6889.6 6927.9 6966.4 6998.8 7064.2 7328.2 7330.2 7349.1 7358.0 7414.1 4619.2 4648.9 4650.9 4653.0 4705.2 6836.9 6980.8 7003.6 7071.6 7091.2 6816.6 6889.2 6910.6 6970.0 6976.9 6881.0 6888.1 6893.2 6946.2 6982.8 6491.0 6689.4 6717.8 6742.1 6743.8 6847.2 6890.3 6891.4 6951.8 6956.5 6733.5 6748.6 6762.9 6775.3 6799.3 21:29:52 INFO - 2015-11-12 21:29:52,210 DEBUG : BROWSER_OUTPUT: 21:29:52 INFO - 2015-11-12 21:29:52,211 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13023.03 Median:547.94 stddev:15885.46 (2899.1%) stddev-sans-first:15902.88 21:29:52 INFO - 2015-11-12 21:29:52,211 DEBUG : BROWSER_OUTPUT: Values: 655.3 688.8 692.0 723.4 736.9 13790.5 13959.2 14095.8 14148.9 14249.4 13074.4 13185.6 13194.5 13222.6 13325.4 870.4 879.9 890.1 893.1 901.3 873.5 886.8 889.5 892.5 894.6 934.9 935.8 936.5 944.9 947.3 932.8 937.2 938.4 938.6 957.1 682.8 683.7 688.3 689.4 689.7 12566.0 12615.9 12638.4 12687.0 12747.4 9940.3 10194.4 10368.5 10403.4 10699.8 8835.2 9040.8 9077.4 9231.8 9280.3 3217.8 3224.6 3233.6 3249.4 3343.6 42340.0 43378.0 43442.8 43506.6 48302.5 6827.2 6855.3 6887.7 6891.2 7067.6 11913.7 11920.8 11930.6 11937.3 12044.6 6055.0 6242.7 6246.4 6252.3 6492.7 3796.7 3827.1 3828.8 3905.6 3969.0 2595.6 2621.6 2626.5 2629.5 2644.0 403.1 405.2 405.6 407.7 413.7 535.8 574.9 594.6 595.6 603.6 8043.6 8055.0 8062.9 8120.9 8340.9 560.1 575.0 593.5 594.1 609.9 3535.3 3816.5 3841.8 3937.2 3986.5 57007.7 57721.7 57911.4 58100.7 60716.7 48895.8 49619.3 50552.2 50827.2 51000.0 45581.1 46487.3 46704.0 47237.0 47347.8 8308.1 8450.5 8500.7 8509.4 8698.3 34634.3 35135.1 35231.6 35314.0 35445.8 43012.4 45213.0 45792.8 45815.5 45850.3 7584.9 7586.4 7712.2 7761.5 7985.0 10770.3 11205.5 11500.8 11804.4 11926.3 10265.9 10550.6 10590.2 10690.4 10840.9 10326.7 10336.7 10351.2 10685.7 10859.9 9651.3 9655.7 9657.4 9713.1 10161.7 8732.9 8745.0 8817.3 8933.8 9655.2 8599.0 8704.8 8957.9 9267.2 9295.8 21:29:52 INFO - 2015-11-12 21:29:52,212 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:29:52 INFO - 2015-11-12 21:29:52,212 DEBUG : BROWSER_OUTPUT: 21:29:52 INFO - 2015-11-12 21:29:52,827 INFO : Browser exited with error code: 0 21:29:52 INFO - 2015-11-12 21:29:52,853 INFO : Completed test dromaeo_css (00:18:31) 21:29:52 INFO - 2015-11-12 21:29:52,854 INFO : Starting test kraken 21:29:52 INFO - 2015-11-12 21:29:52,854 DEBUG : operating with platform_type : mac_ 21:29:52 INFO - 2015-11-12 21:29:52,854 INFO : Initialising browser for kraken test... 21:29:52 INFO - 2015-11-12 21:29:52,866 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmpdV7mBg/profile http://localhost:49265/getInfo.html 21:29:55 INFO - 2015-11-12 21:29:55,712 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:29:55 INFO - 2015-11-12 21:29:55,713 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:29:55 INFO - 2015-11-12 21:29:55,713 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 21:29:55 INFO - 2015-11-12 21:29:55,713 DEBUG : BROWSER_OUTPUT: __metrics 21:29:56 INFO - 2015-11-12 21:29:56,341 INFO : Browser initialized. 21:29:56 INFO - 2015-11-12 21:29:56,341 INFO : Running cycle 1/1 for kraken test... 21:29:56 INFO - 2015-11-12 21:29:56,341 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmpdV7mBg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:30:08 INFO - 2015-11-12 21:30:08,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 241315840 21:30:08 INFO - 2015-11-12 21:30:08,295 DEBUG : BROWSER_OUTPUT: 21:30:10 INFO - 2015-11-12 21:30:10,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection) 21:30:11 INFO - 2015-11-12 21:30:11,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 258711552 21:30:11 INFO - 2015-11-12 21:30:11,460 DEBUG : BROWSER_OUTPUT: 21:30:14 INFO - 2015-11-12 21:30:14,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-dft) 21:30:14 INFO - 2015-11-12 21:30:14,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 267563008 21:30:14 INFO - 2015-11-12 21:30:14,691 DEBUG : BROWSER_OUTPUT: 21:30:17 INFO - 2015-11-12 21:30:17,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-fft) 21:30:18 INFO - 2015-11-12 21:30:18,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 267857920 21:30:18 INFO - 2015-11-12 21:30:18,121 DEBUG : BROWSER_OUTPUT: 21:30:20 INFO - 2015-11-12 21:30:20,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator) 21:30:20 INFO - 2015-11-12 21:30:20,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 268201984 21:30:20 INFO - 2015-11-12 21:30:20,679 DEBUG : BROWSER_OUTPUT: 21:30:22 INFO - 2015-11-12 21:30:22,803 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:30:23 INFO - 2015-11-12 21:30:23,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 268591104 21:30:23 INFO - 2015-11-12 21:30:23,384 DEBUG : BROWSER_OUTPUT: 21:30:26 INFO - 2015-11-12 21:30:26,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom) 21:30:26 INFO - 2015-11-12 21:30:26,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 268546048 21:30:26 INFO - 2015-11-12 21:30:26,976 DEBUG : BROWSER_OUTPUT: 21:30:30 INFO - 2015-11-12 21:30:30,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate) 21:30:30 INFO - 2015-11-12 21:30:30,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 268816384 21:30:30 INFO - 2015-11-12 21:30:30,659 DEBUG : BROWSER_OUTPUT: 21:30:33 INFO - 2015-11-12 21:30:33,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial) 21:30:34 INFO - 2015-11-12 21:30:34,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 270241792 21:30:34 INFO - 2015-11-12 21:30:34,093 DEBUG : BROWSER_OUTPUT: 21:30:35 INFO - 2015-11-12 21:30:35,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:30:36 INFO - 2015-11-12 21:30:36,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 270880768 21:30:36 INFO - 2015-11-12 21:30:36,250 DEBUG : BROWSER_OUTPUT: 21:30:38 INFO - 2015-11-12 21:30:38,031 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:30:38 INFO - 2015-11-12 21:30:38,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 271159296 21:30:38 INFO - 2015-11-12 21:30:38,656 DEBUG : BROWSER_OUTPUT: 21:30:40 INFO - 2015-11-12 21:30:40,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:30:41 INFO - 2015-11-12 21:30:41,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 271204352 21:30:41 INFO - 2015-11-12 21:30:41,309 DEBUG : BROWSER_OUTPUT: 21:30:43 INFO - 2015-11-12 21:30:43,862 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:30:44 INFO - 2015-11-12 21:30:44,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 271368192 21:30:44 INFO - 2015-11-12 21:30:44,455 DEBUG : BROWSER_OUTPUT: 21:30:47 INFO - 2015-11-12 21:30:47,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:30:47 INFO - 2015-11-12 21:30:47,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 272392192 21:30:47 INFO - 2015-11-12 21:30:47,677 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49265/tests/kraken/driver.html?testName=ai-astar) 21:30:49 INFO - 2015-11-12 21:30:49,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 271708160 21:30:49 INFO - 2015-11-12 21:30:49,645 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,645 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:30:49 INFO - 2015-11-12 21:30:49,645 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:30:49 INFO - 2015-11-12 21:30:49,645 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:30:49 INFO - 2015-11-12 21:30:49,645 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:30:49 INFO - 2015-11-12 21:30:49,645 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;102;110;108;109;118;109;108;111;109 21:30:49 INFO - 2015-11-12 21:30:49,646 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;135;151;164;128;149;147;128;161;128 21:30:49 INFO - 2015-11-12 21:30:49,646 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;164;165;166;169;171;168;168;167 21:30:49 INFO - 2015-11-12 21:30:49,646 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;72;78;65;72;72;71;124;65;69 21:30:49 INFO - 2015-11-12 21:30:49,646 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;129;86;88;89;122;88;89;137 21:30:49 INFO - 2015-11-12 21:30:49,646 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;115;115;115;120;115;115;120;115;122 21:30:49 INFO - 2015-11-12 21:30:49,646 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;126;127;127;126;127;127;127;127;127;127 21:30:49 INFO - 2015-11-12 21:30:49,646 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;106;96;104;96;99;96;107;117;104 21:30:49 INFO - 2015-11-12 21:30:49,646 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;63;63;63;63;62;63;68;61;63 21:30:49 INFO - 2015-11-12 21:30:49,646 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;66;66;66;65;66;66;67;66;67 21:30:49 INFO - 2015-11-12 21:30:49,646 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;86;86;87;87;87;89;88;87 21:30:49 INFO - 2015-11-12 21:30:49,647 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;127;127;123;134;130;129;135;130;132 21:30:49 INFO - 2015-11-12 21:30:49,647 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;160;160;159;161;150;161;151;161;150 21:30:49 INFO - 2015-11-12 21:30:49,647 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;73;72;73;73;71;72;73;72;73 21:30:49 INFO - 2015-11-12 21:30:49,647 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:30:49 INFO - 2015-11-12 21:30:49,647 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:30:49 INFO - 2015-11-12 21:30:49,647 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,710 21:30:49 INFO - 2015-11-12 21:30:49,647 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:30:49 INFO - 2015-11-12 21:30:49,647 DEBUG : BROWSER_OUTPUT: __startTimestamp1447392649638__endTimestamp 21:30:49 INFO - 2015-11-12 21:30:49,647 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,647 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:30:49 INFO - 2015-11-12 21:30:49,647 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:30:49 INFO - 2015-11-12 21:30:49,647 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,648 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.40 Median:109.50 stddev:3.89 (3.6%) stddev-sans-first:4.12 21:30:49 INFO - 2015-11-12 21:30:49,648 DEBUG : BROWSER_OUTPUT: Values: 110.0 102.0 110.0 108.0 109.0 118.0 109.0 108.0 111.0 109.0 21:30:49 INFO - 2015-11-12 21:30:49,648 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,648 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.40 Median:150.00 stddev:13.75 (9.2%) stddev-sans-first:14.22 21:30:49 INFO - 2015-11-12 21:30:49,648 DEBUG : BROWSER_OUTPUT: Values: 153.0 135.0 151.0 164.0 128.0 149.0 147.0 128.0 161.0 128.0 21:30:49 INFO - 2015-11-12 21:30:49,648 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,648 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:166.50 Median:167.50 stddev:2.55 (1.5%) stddev-sans-first:2.54 21:30:49 INFO - 2015-11-12 21:30:49,648 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 164.0 165.0 166.0 169.0 171.0 168.0 168.0 167.0 21:30:49 INFO - 2015-11-12 21:30:49,648 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,648 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.30 Median:72.00 stddev:17.23 (23.9%) stddev-sans-first:18.27 21:30:49 INFO - 2015-11-12 21:30:49,648 DEBUG : BROWSER_OUTPUT: Values: 75.0 72.0 78.0 65.0 72.0 72.0 71.0 124.0 65.0 69.0 21:30:49 INFO - 2015-11-12 21:30:49,648 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,648 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:100.80 Median:88.50 stddev:20.04 (22.6%) stddev-sans-first:20.87 21:30:49 INFO - 2015-11-12 21:30:49,648 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 129.0 86.0 88.0 89.0 122.0 88.0 89.0 137.0 21:30:49 INFO - 2015-11-12 21:30:49,649 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,649 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.50 stddev:2.90 (2.5%) stddev-sans-first:2.89 21:30:49 INFO - 2015-11-12 21:30:49,649 DEBUG : BROWSER_OUTPUT: Values: 120.0 115.0 115.0 115.0 120.0 115.0 115.0 120.0 115.0 122.0 21:30:49 INFO - 2015-11-12 21:30:49,649 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,649 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:126.80 Median:127.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 21:30:49 INFO - 2015-11-12 21:30:49,649 DEBUG : BROWSER_OUTPUT: Values: 126.0 127.0 127.0 126.0 127.0 127.0 127.0 127.0 127.0 127.0 21:30:49 INFO - 2015-11-12 21:30:49,649 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,649 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:102.20 Median:96.00 stddev:6.80 (7.1%) stddev-sans-first:6.94 21:30:49 INFO - 2015-11-12 21:30:49,649 DEBUG : BROWSER_OUTPUT: Values: 97.0 106.0 96.0 104.0 96.0 99.0 96.0 107.0 117.0 104.0 21:30:49 INFO - 2015-11-12 21:30:49,649 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,649 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.00 stddev:1.81 (2.9%) stddev-sans-first:1.92 21:30:49 INFO - 2015-11-12 21:30:49,649 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 63.0 63.0 63.0 62.0 63.0 68.0 61.0 63.0 21:30:49 INFO - 2015-11-12 21:30:49,650 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,650 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 21:30:49 INFO - 2015-11-12 21:30:49,650 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 66.0 66.0 65.0 66.0 66.0 67.0 66.0 67.0 21:30:49 INFO - 2015-11-12 21:30:49,650 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,650 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:87.00 stddev:1.14 (1.3%) stddev-sans-first:1.00 21:30:49 INFO - 2015-11-12 21:30:49,650 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 86.0 86.0 87.0 87.0 87.0 89.0 88.0 87.0 21:30:49 INFO - 2015-11-12 21:30:49,650 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,650 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:130.00 stddev:3.82 (2.9%) stddev-sans-first:3.74 21:30:49 INFO - 2015-11-12 21:30:49,651 DEBUG : BROWSER_OUTPUT: Values: 125.0 127.0 127.0 123.0 134.0 130.0 129.0 135.0 130.0 132.0 21:30:49 INFO - 2015-11-12 21:30:49,651 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,651 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:160.00 stddev:5.55 (3.5%) stddev-sans-first:5.05 21:30:49 INFO - 2015-11-12 21:30:49,651 DEBUG : BROWSER_OUTPUT: Values: 148.0 160.0 160.0 159.0 161.0 150.0 161.0 151.0 161.0 150.0 21:30:49 INFO - 2015-11-12 21:30:49,651 DEBUG : BROWSER_OUTPUT: 21:30:49 INFO - 2015-11-12 21:30:49,651 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 21:30:49 INFO - 2015-11-12 21:30:49,651 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 73.0 73.0 71.0 72.0 73.0 72.0 73.0 21:30:49 INFO - 2015-11-12 21:30:49,652 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:30:49 INFO - 2015-11-12 21:30:49,652 DEBUG : BROWSER_OUTPUT: 21:30:50 INFO - 2015-11-12 21:30:50,305 INFO : Browser exited with error code: 0 21:30:50 INFO - 2015-11-12 21:30:50,352 INFO : Completed test kraken (00:00:57) 21:30:50 INFO - 2015-11-12 21:30:50,352 INFO : Starting test v8_7 21:30:50 INFO - 2015-11-12 21:30:50,352 DEBUG : operating with platform_type : mac_ 21:30:50 INFO - 2015-11-12 21:30:50,353 INFO : Initialising browser for v8_7 test... 21:30:50 INFO - 2015-11-12 21:30:50,365 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmpnE6YKd/profile http://localhost:49265/getInfo.html 21:30:53 INFO - 2015-11-12 21:30:53,089 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:30:53 INFO - 2015-11-12 21:30:53,089 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:30:53 INFO - 2015-11-12 21:30:53,090 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 21:30:53 INFO - 2015-11-12 21:30:53,090 DEBUG : BROWSER_OUTPUT: __metrics 21:30:53 INFO - 2015-11-12 21:30:53,707 INFO : Browser initialized. 21:30:53 INFO - 2015-11-12 21:30:53,707 INFO : Running cycle 1/1 for v8_7 test... 21:30:53 INFO - 2015-11-12 21:30:53,707 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/T/tmpnE6YKd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:31:05 INFO - 2015-11-12 21:31:05,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 240377856 21:31:05 INFO - 2015-11-12 21:31:05,688 DEBUG : BROWSER_OUTPUT: 21:31:27 INFO - 2015-11-12 21:31:27,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/v8_7/run.html (next: http://localhost:49265/tests/v8_7/run.html) 21:31:27 INFO - 2015-11-12 21:31:27,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 256643072 21:31:27 INFO - 2015-11-12 21:31:27,571 DEBUG : BROWSER_OUTPUT: 21:31:27 INFO - 2015-11-12 21:31:27,571 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:31:27 INFO - 2015-11-12 21:31:27,571 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:31:27 INFO - 2015-11-12 21:31:27,571 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:31:27 INFO - 2015-11-12 21:31:27,571 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:31:27 INFO - 2015-11-12 21:31:27,571 DEBUG : BROWSER_OUTPUT: |0;Richards;166.38935108153078 21:31:27 INFO - 2015-11-12 21:31:27,571 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;196.88915140775742 21:31:27 INFO - 2015-11-12 21:31:27,571 DEBUG : BROWSER_OUTPUT: |2;Encrypt;326.6906239790918 21:31:27 INFO - 2015-11-12 21:31:27,571 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5775.862068965517 21:31:27 INFO - 2015-11-12 21:31:27,571 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1124.859392575928 21:31:27 INFO - 2015-11-12 21:31:27,572 DEBUG : BROWSER_OUTPUT: |5;Earley;797.4481658692185 21:31:27 INFO - 2015-11-12 21:31:27,572 DEBUG : BROWSER_OUTPUT: |6;Boyer;12683.54430379747 21:31:27 INFO - 2015-11-12 21:31:27,572 DEBUG : BROWSER_OUTPUT: |7;RegExp;29171.428571428572 21:31:27 INFO - 2015-11-12 21:31:27,572 DEBUG : BROWSER_OUTPUT: |8;Splay;642.6735218508998 21:31:27 INFO - 2015-11-12 21:31:27,572 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5813.953488372093 21:31:27 INFO - 2015-11-12 21:31:27,572 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:31:27 INFO - 2015-11-12 21:31:27,572 DEBUG : BROWSER_OUTPUT: __startTimestamp1447392687568__endTimestamp 21:31:27 INFO - 2015-11-12 21:31:27,572 DEBUG : BROWSER_OUTPUT: 21:31:27 INFO - 2015-11-12 21:31:27,572 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:31:27 INFO - 2015-11-12 21:31:27,572 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:31:27 INFO - 2015-11-12 21:31:27,573 DEBUG : BROWSER_OUTPUT: 21:31:27 INFO - 2015-11-12 21:31:27,573 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.39 Median:166.39 stddev:0.00 (0.0%) 21:31:27 INFO - 2015-11-12 21:31:27,573 DEBUG : BROWSER_OUTPUT: Values: 166.4 21:31:27 INFO - 2015-11-12 21:31:27,573 DEBUG : BROWSER_OUTPUT: 21:31:27 INFO - 2015-11-12 21:31:27,573 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:196.89 Median:196.89 stddev:0.00 (0.0%) 21:31:27 INFO - 2015-11-12 21:31:27,573 DEBUG : BROWSER_OUTPUT: Values: 196.9 21:31:27 INFO - 2015-11-12 21:31:27,573 DEBUG : BROWSER_OUTPUT: 21:31:27 INFO - 2015-11-12 21:31:27,573 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:326.69 Median:326.69 stddev:0.00 (0.0%) 21:31:27 INFO - 2015-11-12 21:31:27,573 DEBUG : BROWSER_OUTPUT: Values: 326.7 21:31:27 INFO - 2015-11-12 21:31:27,574 DEBUG : BROWSER_OUTPUT: 21:31:27 INFO - 2015-11-12 21:31:27,574 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5775.86 Median:5775.86 stddev:0.00 (0.0%) 21:31:27 INFO - 2015-11-12 21:31:27,574 DEBUG : BROWSER_OUTPUT: Values: 5775.9 21:31:27 INFO - 2015-11-12 21:31:27,574 DEBUG : BROWSER_OUTPUT: 21:31:27 INFO - 2015-11-12 21:31:27,574 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1124.86 Median:1124.86 stddev:0.00 (0.0%) 21:31:27 INFO - 2015-11-12 21:31:27,574 DEBUG : BROWSER_OUTPUT: Values: 1124.9 21:31:27 INFO - 2015-11-12 21:31:27,574 DEBUG : BROWSER_OUTPUT: 21:31:27 INFO - 2015-11-12 21:31:27,574 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:797.45 Median:797.45 stddev:0.00 (0.0%) 21:31:27 INFO - 2015-11-12 21:31:27,574 DEBUG : BROWSER_OUTPUT: Values: 797.4 21:31:27 INFO - 2015-11-12 21:31:27,574 DEBUG : BROWSER_OUTPUT: 21:31:27 INFO - 2015-11-12 21:31:27,575 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12683.54 Median:12683.54 stddev:0.00 (0.0%) 21:31:27 INFO - 2015-11-12 21:31:27,575 DEBUG : BROWSER_OUTPUT: Values: 12683.5 21:31:27 INFO - 2015-11-12 21:31:27,575 DEBUG : BROWSER_OUTPUT: 21:31:27 INFO - 2015-11-12 21:31:27,575 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29171.43 Median:29171.43 stddev:0.00 (0.0%) 21:31:27 INFO - 2015-11-12 21:31:27,575 DEBUG : BROWSER_OUTPUT: Values: 29171.4 21:31:27 INFO - 2015-11-12 21:31:27,575 DEBUG : BROWSER_OUTPUT: 21:31:27 INFO - 2015-11-12 21:31:27,575 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:642.67 Median:642.67 stddev:0.00 (0.0%) 21:31:27 INFO - 2015-11-12 21:31:27,575 DEBUG : BROWSER_OUTPUT: Values: 642.7 21:31:27 INFO - 2015-11-12 21:31:27,575 DEBUG : BROWSER_OUTPUT: 21:31:27 INFO - 2015-11-12 21:31:27,576 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5813.95 Median:5813.95 stddev:0.00 (0.0%) 21:31:27 INFO - 2015-11-12 21:31:27,576 DEBUG : BROWSER_OUTPUT: Values: 5814.0 21:31:27 INFO - 2015-11-12 21:31:27,576 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:31:27 INFO - 2015-11-12 21:31:27,576 DEBUG : BROWSER_OUTPUT: 21:31:28 INFO - 2015-11-12 21:31:28,477 INFO : Browser exited with error code: 0 21:31:28 INFO - 2015-11-12 21:31:28,496 INFO : Completed test v8_7 (00:00:38) 21:31:28 INFO - 2015-11-12 21:31:28,642 INFO : Completed test suite (00:20:07) 21:31:28 INFO - 2015-11-12 21:31:28,642 DEBUG : Working with test: dromaeo_css 21:31:28 INFO - 2015-11-12 21:31:28,642 DEBUG : Generating results file: dromaeo_css 21:31:28 INFO - 2015-11-12 21:31:28,643 DEBUG : Working with test: kraken 21:31:28 INFO - 2015-11-12 21:31:28,643 DEBUG : Generating results file: kraken 21:31:28 INFO - 2015-11-12 21:31:28,643 INFO : javascript benchmark 21:31:28 INFO - 2015-11-12 21:31:28,643 DEBUG : Working with test: v8_7 21:31:28 INFO - 2015-11-12 21:31:28,643 DEBUG : Generating results file: v8_7 21:31:28 INFO - 2015-11-12 21:31:28,643 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:31:28 INFO - 2015-11-12 21:31:28,766 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,57]] 21:31:28 INFO - 2015-11-12 21:31:28,767 DEBUG : process_Request line: dromaeo_css 6736.02 graph.html#tests=[[72,63,57]] 21:31:28 INFO - 2015-11-12 21:31:28,767 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:31:28 INFO - 2015-11-12 21:31:28,865 DEBUG : process_Request line: kraken 1517.50 graph.html#tests=[[232,63,57]] 21:31:28 INFO - 2015-11-12 21:31:28,865 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:31:28 INFO - 2015-11-12 21:31:28,971 DEBUG : process_Request line: v8_7 19552.14 graph.html#tests=[[230,63,57]] 21:31:28 INFO - 2015-11-12 21:31:28,972 INFO : javascript benchmark 21:31:29 INFO - 2015-11-12 21:31:28,974 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [329.3544652481137, 333.394888277776, 334.1329250594706, 340.11569918212643, 340.92329225924163, 11519.36643484608, 11901.226420282675, 17385.0, 17460.214290356933, 18001.189946452407, 11512.13658975576, 11551.075913926887, 11753.588624398148, 11758.17692761505, 11819.822702659467, 4393.846215382454, 4447.177272204636, 4504.572065653758, 4512.796924138422, 4550.294704320836, 4395.494518130424, 6698.933010669904, 6969.268226836185, 6973.581585104885, 7045.929540704578, 6088.786892458765, 6580.638064906429, 6853.623050732208, 6955.965220173892, 6961.0, 6521.804345869631, 6590.439812615909, 6610.933890661104, 6612.768553100643, 6973.79078627642, 6534.987077003072, 6576.342365763386, 6620.040094186316, 6642.7342906284175, 6645.534812563123, 17770.822291777047, 17791.644167116585, 22792.658110128363, 23687.34188606798, 24064.879675601685, 2029.401326608654, 2042.1831267493121, 2092.0, 2215.368619943308, 2233.8101261392803, 13982.930085349508, 14055.50805721805, 14222.857771422361, 14261.78607320891, 14748.336324865406, 1648.208859747316, 1709.3931654262683, 1717.6650553142017, 1735.6962531557053, 1746.9650606987789, 65285.67357163232, 66207.66896165536, 66634.00048999318, 66702.33297667059, 66857.0, 16701.24844382006, 17016.57458563546, 17156.485305440856, 17353.2191051403, 17409.0, 24801.875990620294, 24871.87564062168, 25143.0, 25170.24489265325, 25216.369590760012, 9330.58012389444, 9395.201407880406, 9421.24630029596, 9421.340506164639, 9466.90533094674, 7863.095743989515, 7930.920690793134, 7965.761027169194, 7998.520088794691, 8065.677372905136, 7773.883391749128, 7837.451378403457, 7857.2928436441, 7877.448578599558, 7893.723719669899, 1062.85651437055, 3168.7623428242514, 3282.0810173151553, 3284.080457471912, 3295.126791400281, 403.3908797715471, 428.8241820853498, 433.18344919826353, 434.66096444773126, 458.0701176611484, 10228.693139205836, 11048.723781905517, 11312.15158863072, 11417.086633069335, 11498.54005839757, 410.72070991725315, 433.73108672623175, 448.4752839178169, 456.2836346935346, 471.78062201076665, 5876.529877609781, 6203.2245969253845, 6250.1874756282305, 6259.906101408483, 6322.589031712924, 504665.0, 508552.0, 509316.0, 526527.0, 539249.0, 69088.0, 70971.2902870975, 71123.64438177776, 71846.64076679583, 72138.63930680418, 478.32317271061754, 496.36713190682167, 501.4809671989546, 506.5542322755951, 512.5207930584914, 10503.737406564896, 10648.467576621293, 10675.466226688479, 10697.839532406864, 10735.194860385345, 33711.32577348488, 33788.155296117795, 34227.82886085554, 34245.315093697485, 34434.0, 46375.53624463712, 46819.0, 47603.5239647613, 47753.522464774906, 47824.0, 6075.817725468243, 6126.693665316628, 6184.041473571604, 6198.008318669172, 6207.720652570735, 10889.727756805827, 11595.768084638092, 11612.941935290608, 11637.53449861996, 11733.882661173278, 9672.85490717654, 9721.416714997124, 10106.797864042825, 10209.183265338903, 10305.587776488857, 9679.419234845931, 9751.0, 9945.701628951143, 9949.751256218653, 10043.246756493147, 10105.848412273968, 10254.743631409274, 10333.84499232497, 10513.632022879163, 10560.630377936735, 6049.455549000611, 6111.602745821508, 6167.784127555514, 6204.224471941007, 6215.409536094064, 9568.856467152858, 10046.497675116361, 10193.388396696222, 10208.183345332503, 10397.68806935763], "dojo.html": [3245.691659292367, 3300.785448945817, 3311.619163796163, 3332.800031998079, 3358.126887009378, 5115.618782928607, 5344.545713614342, 5357.892842143155, 5387.353517577886, 5468.343798744151, 4083.5508094109623, 5058.418281897583, 5131.179011358184, 5159.974200128994, 5254.894902101955, 4734.692245004081, 4746.620270378378, 4813.49458306878, 4842.588379987706, 4900.044491324194, 194.44590424853044, 4748.97625511872, 4849.975750121244, 4888.120138375091, 4919.631027672921, 4659.976700116495, 4687.390639216914, 4738.763061846911, 4744.478107408182, 4745.406824146981, 4838.685485443435, 4873.512648735134, 4908.0429316283335, 4913.041956818422, 4945.752712364403, 4617.746023968681, 4835.5889749371345, 4840.806367745321, 4872.171730805736, 4960.553550180501, 4995.475475075101, 5094.133997220481, 5123.769430375642, 5135.435102138762, 5156.071907056728, 5478.397376288605, 5574.470425309589, 5621.409751976024, 5621.915671264935, 5670.5747068969995, 5413.864653383657, 5521.834344969658, 5594.888102237973, 5623.325200975909, 5680.602357834953, 5294.047071527124, 5297.337832770903, 5311.760970756287, 5372.274742909735, 5403.459654034565, 5699.116636921284, 5775.537956963432, 5817.563682723728, 5835.212246346774, 5846.766129354864, 5341.679499230058, 5368.570514358842, 5455.699936503451, 5553.611247212737, 5618.747156377891, 5656.575756818255, 5688.544916406678, 5699.031164701928, 5707.286589176353, 5726.656400615976, 5540.445955404427, 5640.266765320564, 5645.23789288449, 5647.519960803295, 5672.602917795714, 5241.764120614582, 5424.0, 5512.531434828004, 5538.418466061086, 5559.583031272671, 4441.333799930037, 4445.066536027406, 4460.264056430653, 4465.754383508874, 4505.0, 3944.980275098606, 4034.374671925856, 4045.696572757055, 4047.959520404758, 4076.144009757984, 5208.244804503326, 5213.582913366998, 5255.264263003182, 5276.709780962084, 5282.577393808486, 5494.697791621419, 5532.419095994943, 5551.028570000234, 5566.526845218121, 5582.358028826656, 5212.50481204285, 5217.713025783618, 5249.238860365225, 5267.051930652519, 5321.627486076015, 4992.051510213048, 5005.399352077701, 5005.474425185376, 5014.623903207274, 5030.0945829751, 5815.273090863642, 5852.531797456193, 5859.619124756877, 5871.0, 5940.316863560746, 5048.343715317133, 5543.584231182596, 5566.777328906798, 5663.263775709132, 5678.744456499385, 5726.455986681259, 5843.620164689281, 5850.853728656818, 5879.559033072451, 5879.647221166743, 5354.919676204782, 5598.3282006159525, 5634.0, 5656.886862262814, 5689.288838895138, 5469.671819690831, 5560.19377190297, 5608.831735047955, 5653.462921022497, 5661.801836935688, 5593.384727680033, 5603.831885043455, 5606.159076138611, 5617.157426386075, 5620.831375058755, 5345.1714984177515, 5356.839294821161, 5464.453554644504, 5595.524380427709, 5643.463870932255, 5256.132738098171, 5302.893942121059, 5318.8936221276135, 5324.361076670824, 5372.597055220952, 5425.864353391197, 5568.248286481273, 5593.690594956358, 5597.944020559742, 5619.719014049363, 5226.085435048775, 5350.411454739898, 5375.731213439391, 5514.365847927379, 5519.144532597294], "mootools.html": [1445.6024593236853, 1709.9658006839863, 1711.803142638597, 1717.9226934787932, 1762.4184019273641, 6835.14560679915, 6854.07469991551, 7298.598577078258, 7648.732294369698, 7657.23427657234, 7485.438592105586, 7664.233576642333, 7742.14836367999, 7761.3402860756905, 7794.649240784164, 2087.5929193807174, 2139.12295958657, 2144.0137536733046, 2144.0887622760342, 2144.549644574641, 2175.0, 2194.5391467791783, 2219.4562332228625, 2250.9212177573786, 2254.582902163097, 2158.7625361210335, 2170.435686721448, 2188.660757582569, 2191.200211922645, 2193.122750899645, 2161.686555449459, 2180.9345719628436, 2185.8907054647284, 2198.988465305961, 2209.2157284164214, 2166.0794162480884, 2185.0058223508267, 2186.212963333199, 2186.8191176764526, 2199.8560748410896, 7760.262775036419, 7795.61021948906, 7815.413843961725, 7816.41376896735, 7918.406119541058, 4582.473015603215, 4644.187267228255, 4663.626909847204, 4668.5798278155125, 4670.322803193518, 2966.792324537283, 2985.596944412498, 3010.3527741535677, 3051.0, 3064.034829028871, 921.2675922641449, 926.9212116970066, 944.211583327922, 956.7990721948399, 962.7689354554857, 9702.51487425626, 10224.386536807815, 10271.7432064199, 10290.176785857113, 10312.587496500131, 3996.680265578747, 4020.7386519876113, 4049.230646177217, 4052.797360131982, 4088.264112459726, 8471.0, 8493.957530212308, 8502.78743031429, 8590.87113693295, 8599.14008599135, 4659.370984916993, 4666.230072038144, 4671.672982891233, 4671.672982891233, 4695.647826412965, 4219.282721937217, 4309.116631090619, 4309.655227581786, 4310.245707001262, 4311.547287534827, 3438.157651375429, 3477.043812951408, 3485.5991560970815, 3520.0847779577493, 3555.466679997969, 1025.323286630835, 1041.9010194031555, 1042.4579218806177, 1042.7497400623795, 1049.0663309654415, 1232.7904256276454, 1235.8393408856791, 1246.837911071573, 1267.9429425675867, 1279.1621487925424, 7281.089863767029, 7388.482806203621, 7401.444891633149, 7402.518836275625, 7430.145533263636, 387.19270321380236, 388.67351424802735, 389.4839337877324, 389.77003567895076, 390.2273498473039, 5691.630044047124, 5727.4845263926445, 5730.426957304319, 5779.971100144557, 5785.247917770663, 9049.0, 9079.863802042975, 9171.358004939724, 9171.58727857248, 9217.86173207389, 9107.08929107084, 9120.224780893566, 9132.954335228414, 9148.542572871329, 9192.586333615003, 7060.71757129709, 7277.59973201479, 7323.523970941872, 7340.779776606711, 7430.554166750012, 6895.793126206222, 6903.930960690329, 6922.550034247758, 6953.513254072166, 7003.4747393944635, 7926.48477848961, 8141.552214628252, 8194.22154895284, 8206.917930820615, 8216.383771217303, 8092.676292948451, 8198.098209196864, 8215.219554142346, 8276.668933242603, 8363.330933525425, 5615.5507559395965, 5950.137230101697, 5976.970115149396, 6443.452306553808, 6502.60984340941, 7380.557166570023, 7425.7029718810645, 7439.590822504598, 7447.590382529013, 7481.064866891638, 6859.211190712932, 6962.060121883481, 6988.196357418962, 7037.507374483737, 7041.753538626123, 6878.312168783082, 6916.654167291716, 6944.895826562504, 6974.0, 6975.8604827902145, 6971.3028697129885, 7008.439324854102, 7012.298770122947, 7097.041899343729, 7119.359257666835, 6354.618722876642, 6374.426301632875, 6376.52176086786, 6404.039394090923, 6414.390632889868, 6323.841903952438, 6340.0, 6362.141110950148, 6396.392342727433, 6431.260405053479], "ext.html": [554.2268535393125, 557.3618207152807, 558.9021921163798, 573.3549756523911, 578.5545130249708, 39329.21341573167, 39860.0, 40360.0, 40441.3933790993, 40451.190976180456, 42744.786276068575, 43160.352594711105, 43167.35248971268, 43193.0, 43392.78303608485, 9306.39508431953, 9334.439933604006, 9427.811443771156, 9505.14453699167, 9539.666111686092, 9160.633574657006, 9310.115539023816, 9313.487758173298, 9324.580393882257, 9325.95337023314, 8981.23659488941, 9247.6300947962, 9273.397229180115, 9278.675246366378, 9306.348555601111, 9140.908590914105, 9239.676611318571, 9289.396189247745, 9313.813723725556, 9339.112784285482, 9009.549522523848, 9177.541122943827, 9183.540822958892, 9187.540622968892, 9221.262299016129, 39872.40191397131, 40367.0, 40408.79795601033, 40561.79719101386, 40622.187556249, 2391.6173412253956, 2671.4539333330026, 2741.616173735679, 2902.274431392152, 2919.1972207642857, 26738.331541711417, 27384.178474645792, 27455.313617159733, 27558.0, 28579.0, 2324.302709187254, 2345.413646588353, 2350.4828937633692, 2388.5700573896693, 2438.7073551173794, 238860.0, 239371.0, 239552.0, 241264.0, 242640.0, 54564.727176363864, 55369.16946245809, 58015.70992145012, 58574.70712646495, 59017.40982590119, 53335.46664533383, 53873.0, 54199.0, 54294.7285263579, 54324.0, 14974.700505989818, 15213.391464341303, 15231.086134831945, 15237.923810380877, 15246.542603721906, 11259.831102533468, 11311.038561722182, 11469.88530114705, 11625.825612615818, 11658.941705291589, 19201.231950722093, 19349.032548372525, 19358.0, 19405.32081377145, 19455.3190638327, 8226.218509241613, 8481.7277408388, 8515.0, 8553.101924297984, 8574.099719529484, 935.8034812689275, 962.4946902876046, 1045.879723831769, 1061.7239517725448, 1142.6743378137191, 29045.85477072601, 29157.125286241448, 29316.413671726445, 29712.851435743116, 29827.552586711216, 984.9409035457752, 1019.454591793387, 1025.3232866308201, 1130.174972270231, 1207.945642446092, 13934.790978135336, 14096.436142554388, 14211.218382989035, 14214.0, 14876.404943802343, 319262.0, 322959.0, 324499.0, 325358.0, 325717.0, 54964.0, 55059.72470137624, 55191.72404138034, 55256.0, 55807.44192558023, 1352.377906163176, 1355.627202519315, 1367.3505085084705, 1370.7327071221216, 1371.8422381426064, 28091.297717557223, 28224.729887154717, 28636.570451443662, 28661.570076449287, 29113.563296550146, 47381.76309118432, 47497.52502475069, 47606.04787904153, 47843.52156478391, 48275.75862120807, 300495.0, 302401.0, 304838.0, 305275.0, 306519.0, 28118.0, 28785.0, 29398.0, 32305.676943230268, 33283.66716332806, 39368.212635747695, 39732.0, 40259.17537833901, 40681.0, 41136.58863411328, 33095.66904330926, 34339.0, 34347.22180560186, 34366.82816585901, 34377.31245375029, 33202.33595328128, 33910.0, 33972.0, 34199.31601367909, 34422.31155376929, 33851.0, 34462.31075378428, 34759.47860782141, 34806.0, 35180.12049698778, 25373.746262537137, 27524.58713119265, 27551.862240688668, 27552.724472755017, 27589.58615620727, 20835.68746468774, 20890.895545522177, 21058.0, 21128.683069753657, 21139.154433822474], "prototype.html": [306.1382209081436, 314.73404972797994, 315.49205778696296, 321.1954055091994, 322.82406088681665, 6391.968040159804, 6450.483961283092, 6478.060681201223, 6519.837004074894, 6578.2106147262275, 6477.967610161954, 6485.546011779165, 6503.414692677658, 6511.804645860631, 6566.080748695186, 4827.8551643450755, 4838.709677419357, 4857.028594281141, 4862.100511405383, 4911.8772030699165, 4828.130936431441, 4829.734364609945, 4829.951700482985, 4839.104765618355, 4849.830255941025, 4336.804843782037, 4727.621790256789, 4731.834385796497, 4738.312944623028, 4740.739259340752, 4753.263244197155, 4761.0953918755495, 4765.642576806753, 4822.71063736177, 4823.975880120612, 4045.8786236412957, 4049.5343035550995, 4055.1889622075705, 4064.715469917107, 4071.653909417703, 6084.209052823149, 6262.342454042351, 6315.147455093549, 6335.778247761306, 6357.745690172387, 5384.1923711443205, 5390.460953904578, 5406.972965135188, 5407.621466497347, 5448.346198456171, 6630.104935833649, 6642.236142843586, 6676.966615166942, 6707.329267073303, 6750.662466876685, 4397.648188144941, 4418.64650827933, 4427.911441771179, 4461.08547747711, 4493.370928070073, 6820.965895170542, 6948.235694073648, 7065.0, 7093.538919970186, 7146.749863754796, 4482.103579284091, 4497.955020449819, 4500.729956202638, 4508.278675411984, 4516.774161291923, 4554.567316104964, 4555.931661025087, 4560.771961401917, 4609.446866375989, 4637.0, 5352.304200453994, 5360.705161216092, 5362.463753624685, 5364.490373414519, 5399.919001214985, 6520.152380190545, 6730.427913627396, 6754.324567543206, 6775.932240677629, 6820.35206655367, 1578.3607638906262, 1599.1124925666368, 1605.3177399605122, 1606.7991501062368, 1607.6463178100798, 1008.1984822066474, 1038.0449986012886, 1039.5841663334575, 1042.9478526073817, 1049.6431213387332, 6401.935980640227, 6405.775797847053, 6418.26189988148, 6424.453921416639, 6483.610983341015, 6923.307669233036, 6957.756478523227, 6962.965185174042, 6992.825179370557, 6997.930020699728, 6304.306526282106, 6411.0, 6411.487081033506, 6454.2577603575255, 6464.676766161767, 3752.3433399155583, 3801.5248093988253, 3801.790901500444, 3822.1591249924973, 3839.7696138231236, 7153.606551639606, 7297.635118244173, 7297.781066568012, 7305.598192099379, 7306.452016098814, 7004.0, 7209.639518024078, 7214.350708436266, 7282.271772822675, 7287.562746235243, 7217.783466496014, 7290.890636640454, 7307.707691692379, 7317.451191160684, 7317.52436091663, 7041.3662770348865, 7057.611831349325, 7072.40870804065, 7083.574985500681, 7146.892796607951, 6889.552179108342, 6927.861442771217, 6966.407855332151, 6998.75504357345, 7064.222935477196, 7328.157261914735, 7330.230325815713, 7349.081364829396, 7358.043454351115, 7414.073240844895, 4619.237825758846, 4648.930266045944, 4650.883727906829, 4652.976735116303, 4705.247160454448, 6836.931630683828, 6980.7905762827195, 7003.6498175092065, 7071.575705457689, 7091.219965803654, 6816.556923799937, 6889.173299204128, 6910.619915904674, 6970.0, 6976.860462790817, 6880.967854821817, 6888.070110535014, 6893.172819261721, 6946.235914049349, 6982.79051628452, 6490.9675451624325, 6689.364510371507, 6717.798466046026, 6742.08981787472, 6743.763968261087, 6847.21257055445, 6890.276520965427, 6891.3797758202, 6951.826204344729, 6956.513044086865, 6733.494987875831, 6748.595084294958, 6762.898556521558, 6775.322467753185, 6799.252082271045], "yui.html": [655.2955572759283, 688.7589343729694, 691.9625129060439, 723.3995783499696, 736.9263073692634, 13790.517331893385, 13959.232242226699, 14095.78856317156, 14148.929255353722, 14249.430022799075, 13074.411651475682, 13185.604431867036, 13194.53819116331, 13222.603321900358, 13325.400356983935, 870.3907264914569, 879.9032106468284, 890.1499068389672, 893.1336603494632, 901.2879824938291, 873.5064688451005, 886.8492356299412, 889.4752096263203, 892.5135800988477, 894.6421431427416, 934.9392289501195, 935.8409070458005, 936.5036530638772, 944.8866136063682, 947.303731757158, 932.7994481186544, 937.1518775508142, 938.3666025432806, 938.5635679409107, 957.1433566957569, 682.757621044527, 683.719674933275, 688.3151264491862, 689.3726708695064, 689.6792991259039, 12566.0, 12615.93692031534, 12638.431270592846, 12687.048471364684, 12747.426365813468, 9940.25448091396, 10194.439305838176, 10368.481575921174, 10403.375797452101, 10699.83950240747, 8835.204831565126, 9040.77398065047, 9077.36458447909, 9231.769205769842, 9280.257579393632, 3217.790843595182, 3224.596925384327, 3233.644299127094, 3249.366373557157, 3343.648916863743, 42340.0, 43378.0, 43442.78278608618, 43506.564934350565, 48302.516974830156, 6827.180738311435, 6855.314468553105, 6887.690053947585, 6891.241963384024, 7067.611281379471, 11913.702157446132, 11920.821187682192, 11930.642080737593, 11937.343446110373, 12044.638660840188, 6055.0, 6242.65665388408, 6246.406591373812, 6252.343503932113, 6492.707828147744, 3796.6962642988497, 3827.13889374894, 3828.8277027533827, 3905.5899130591447, 3968.960310396859, 2595.5587550116147, 2621.554335762925, 2626.487834872182, 2629.4609605030923, 2644.008496813695, 403.1332634835128, 405.19366460742907, 405.55794184339214, 407.6860817170762, 413.7331421233288, 535.7776522743018, 574.9223854779635, 594.5956749410442, 595.6217801695867, 603.6317846113867, 8043.638036288381, 8055.0, 8062.879056814152, 8120.878186827203, 8340.874886876702, 560.1038338658115, 574.9593236242415, 593.4777395891588, 594.0702800117801, 609.9481544068715, 3535.3106144301614, 3816.542014958223, 3841.750286231442, 3937.1535119948776, 3986.541547722049, 57007.71496142493, 57721.711391442775, 57911.42088579144, 58100.70949645225, 60716.69641651763, 48895.755521222876, 49619.25571116436, 50552.24171637429, 50827.237591436155, 51000.0, 45581.08837823225, 46487.30269046035, 46704.0, 47237.0, 47347.76326118347, 8308.127646597262, 8450.450720703135, 8500.70247541333, 8509.36179786531, 8698.347623928357, 34634.307313853074, 35135.12162195965, 35231.647683523865, 35314.0, 35445.82277088598, 43012.35481467843, 45213.0, 45792.77103614461, 45815.54184458113, 45850.312245317014, 7584.924150758642, 7586.355159811478, 7712.228777122243, 7761.456698031309, 7984.960075199587, 10770.30672394851, 11205.495752690986, 11500.769984600429, 11804.409779511161, 11926.344051077274, 10265.897341026493, 10550.630727924487, 10590.205734569783, 10690.41202733857, 10840.891591084304, 10326.741831454274, 10336.741581460523, 10351.223658225512, 10685.732856678645, 10859.945700271448, 9651.276154288596, 9655.710328690151, 9657.372270802376, 9713.125818676353, 10161.745956350855, 8732.912670873464, 8745.0, 8817.294616430541, 8933.776655583662, 9655.227581793299, 8598.957005214934, 8704.825903482022, 8957.910420895969, 9267.212286955684, 9295.83802024747]}, "summary": {"lowerIsBetter": false, "suite": 6736.026953668322, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8093.08240110924, "unit": "ms", "value": 8093.08240110924}, "dojo.html": {"lowerIsBetter": false, "filtered": 5165.79317080324, "unit": "ms", "value": 5165.79317080324}, "mootools.html": {"lowerIsBetter": false, "filtered": 4257.59253600346, "unit": "ms", "value": 4257.59253600346}, "ext.html": {"lowerIsBetter": false, "filtered": 17924.45174487965, "unit": "ms", "value": 17924.45174487965}, "prototype.html": {"lowerIsBetter": false, "filtered": 5030.940752826739, "unit": "ms", "value": 5030.940752826739}, "yui.html": {"lowerIsBetter": false, "filtered": 5819.352587074823, "unit": "ms", "value": 5819.352587074823}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0041.e"}, "testrun": {"date": 1447391481, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112201936", "branch": "Mozilla-Inbound", "revision": "aa323766c0f998f1c36eb0e8ca821b828a81701d"}}, {"talos_counters": {}, "results": {"audio-dft": [164.0, 163.0, 164.0, 165.0, 166.0, 169.0, 171.0, 168.0, 168.0, 167.0], "ai-astar": [110.0, 102.0, 110.0, 108.0, 109.0, 118.0, 109.0, 108.0, 111.0, 109.0], "imaging-gaussian-blur": [120.0, 115.0, 115.0, 115.0, 120.0, 115.0, 115.0, 120.0, 115.0, 122.0], "audio-beat-detection": [153.0, 135.0, 151.0, 164.0, 128.0, 149.0, 147.0, 128.0, 161.0, 128.0], "json-stringify-tinderbox": [67.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 67.0, 66.0, 67.0], "stanford-crypto-pbkdf2": [148.0, 160.0, 160.0, 159.0, 161.0, 150.0, 161.0, 151.0, 161.0, 150.0], "json-parse-financial": [63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 68.0, 61.0, 63.0], "stanford-crypto-sha256-iterative": [72.0, 73.0, 72.0, 73.0, 73.0, 71.0, 72.0, 73.0, 72.0, 73.0], "audio-fft": [75.0, 72.0, 78.0, 65.0, 72.0, 72.0, 71.0, 124.0, 65.0, 69.0], "imaging-darkroom": [126.0, 127.0, 127.0, 126.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0], "stanford-crypto-ccm": [125.0, 127.0, 127.0, 123.0, 134.0, 130.0, 129.0, 135.0, 130.0, 132.0], "audio-oscillator": [90.0, 90.0, 129.0, 86.0, 88.0, 89.0, 122.0, 88.0, 89.0, 137.0], "stanford-crypto-aes": [85.0, 86.0, 86.0, 86.0, 87.0, 87.0, 87.0, 89.0, 88.0, 87.0], "imaging-desaturate": [97.0, 106.0, 96.0, 104.0, 96.0, 99.0, 96.0, 107.0, 117.0, 104.0]}, "summary": {"lowerIsBetter": true, "suite": 1517.5, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 76.3, "unit": "ms", "value": 76.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 156.1, "unit": "ms", "value": 156.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.4, "unit": "ms", "value": 144.4}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 129.2, "unit": "ms", "value": 129.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 126.8, "unit": "ms", "value": 126.8}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 63.2, "unit": "ms", "value": 63.2}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 100.8, "unit": "ms", "value": 100.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.4, "unit": "ms", "value": 109.4}, "audio-dft": {"lowerIsBetter": true, "filtered": 166.5, "unit": "ms", "value": 166.5}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 72.4, "unit": "ms", "value": 72.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.2, "unit": "ms", "value": 66.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 117.2, "unit": "ms", "value": 117.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.8, "unit": "ms", "value": 86.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 102.2, "unit": "ms", "value": 102.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0041.e"}, "testrun": {"date": 1447391481, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112201936", "branch": "Mozilla-Inbound", "revision": "aa323766c0f998f1c36eb0e8ca821b828a81701d"}}, {"talos_counters": {}, "results": {"DeltaBlue": [196.88915140775742], "Encrypt": [326.6906239790918], "NavierStokes": [5813.953488372093], "Decrypt": [5775.862068965517], "Splay": [642.6735218508998], "Richards": [166.38935108153078], "RegExp": [29171.428571428572], "Earley": [797.4481658692185], "Boyer": [12683.54430379747], "RayTrace": [1124.859392575928]}, "summary": {"lowerIsBetter": false, "suite": 19552.13645874434, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 335.813322, "unit": "score", "value": 335.813322}, "Encrypt": {"lowerIsBetter": false, "filtered": 814.7800409999996, "unit": "score", "value": 814.7800409999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 255.24799999999982, "unit": "score", "value": 255.24799999999982}, "Decrypt": {"lowerIsBetter": false, "filtered": 46.08506865671644, "unit": "score", "value": 46.08506865671644}, "Splay": {"lowerIsBetter": false, "filtered": 126.799996, "unit": "score", "value": 126.799996}, "RegExp": {"lowerIsBetter": false, "filtered": 31.228672869735533, "unit": "score", "value": 31.228672869735533}, "Richards": {"lowerIsBetter": false, "filtered": 212.16501999999997, "unit": "score", "value": 212.16501999999997}, "Earley": {"lowerIsBetter": false, "filtered": 835.7446020000003, "unit": "score", "value": 835.7446020000003}, "Boyer": {"lowerIsBetter": false, "filtered": 52.545486027944136, "unit": "score", "value": 52.545486027944136}, "RayTrace": {"lowerIsBetter": false, "filtered": 657.850221, "unit": "score", "value": 657.850221}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0041.e"}, "testrun": {"date": 1447391481, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112201936", "branch": "Mozilla-Inbound", "revision": "aa323766c0f998f1c36eb0e8ca821b828a81701d"}}] 21:31:29 INFO - RETURN: dromaeo_css: 6736.02 21:31:29 INFO - RETURN: kraken: 1517.50 21:31:29 INFO - RETURN: v8_7: 19552.14 21:31:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,57]]", "result": "19552.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,57]]", "result": "1517.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,57]]", "result": "6736.02"}}} 21:31:29 INFO - Return code: 0 21:31:29 INFO - # TBPL SUCCESS # 21:31:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:31:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:31:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:31:29 INFO - 2015-11-12 21:31:29.075 screenresolution[1674:11301] starting screenresolution argv=screenresolution get 21:31:29 INFO - 2015-11-12 21:31:29.078 screenresolution[1674:11301] Display 0: 1600x1200x32@60 21:31:29 INFO - 2015-11-12 21:31:29.085 screenresolution[1675:11304] starting screenresolution argv=screenresolution list 21:31:29 INFO - Available Modes on Display 0 21:31:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:31:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:31:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:31:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:31:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:31:29 INFO - Intel HD Graphics 3000: 21:31:29 INFO - Chipset Model: Intel HD Graphics 3000 21:31:29 INFO - Type: GPU 21:31:29 INFO - Bus: Built-In 21:31:29 INFO - VRAM (Total): 512 MB 21:31:29 INFO - VRAM (Dynamic, Max): 10 21:31:29 INFO - Vendor: Intel (0x8086) 21:31:29 INFO - Device ID: 0x0116 21:31:29 INFO - Revision ID: 0x0009 21:31:29 INFO - Displays: 21:31:29 INFO - Display: 21:31:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:31:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:31:29 INFO - Display Serial Number: 1600x1200 60 21:31:29 INFO - Main Display: Yes 21:31:29 INFO - Mirror: Off 21:31:29 INFO - Online: Yes 21:31:29 INFO - Rotation: Supported 21:31:29 INFO - Return code: 0 21:31:29 INFO - Running post-action listener: _resource_record_post_action 21:31:29 INFO - Running post-run listener: _resource_record_post_run 21:31:30 INFO - Total resource usage - Wall time: 1247s; CPU: 30.0%; Read bytes: 41669632; Write bytes: 692688896; Read time: 6826; Write time: 107838 21:31:30 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 343622144; Write bytes: 345655296; Read time: 33713; Write time: 8499 21:31:30 INFO - run-tests - Wall time: 1209s; CPU: 30.0%; Read bytes: 39420928; Write bytes: 345829376; Read time: 6200; Write time: 99286 21:31:30 INFO - Running post-run listener: _upload_blobber_files 21:31:30 INFO - Blob upload gear active. 21:31:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:31:30 INFO - Copying logs to upload dir... 21:31:30 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1316.724284 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2015-11-12 21:31:30.483412) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 21:31:30.484221) ========= 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.gIllW8vMdt/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.tDd8hL5KFC/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010105 build_url: 'https://queue.taskcluster.net/v1/task/cCE78LXVSxi0MmPGhVzEGg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 21:31:30.529871) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:31:30.530396) ========= 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.gIllW8vMdt/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.tDd8hL5KFC/Listeners TMPDIR=/var/folders/5c/0lxxktl96kngt1wtsc3fpdfm00000w/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.005225 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 21:31:30.581770) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 21:31:30.582522) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 21:31:30.583657) ========= ========= Total master_lag: 0.52 =========