builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0062 starttime: 1447959211.61 results: success (0) buildid: 20151119072803 builduid: b181926fed7a47508c9ea336b3e2ed65 revision: d052d9447bf90d0fedaae937afb76e672ca6d49b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:31.609629) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:31.610535) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:31.611031) ========= 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.v7Kkvyhh2w/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.OVpJaWbjm2/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005402 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:31.631906) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:31.632193) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:31.646653) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:31.646928) ========= 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.v7Kkvyhh2w/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.OVpJaWbjm2/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005154 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:31.695379) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:31.695683) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:31.696059) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:31.696354) ========= 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.v7Kkvyhh2w/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.OVpJaWbjm2/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-19 10:53:31-- 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% 10.3M=0.001s 2015-11-19 10:53:31 (10.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.203166 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:31.912913) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:31.913253) ========= 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.v7Kkvyhh2w/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.OVpJaWbjm2/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019382 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:31.962328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 10:53:31.962736) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d052d9447bf90d0fedaae937afb76e672ca6d49b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d052d9447bf90d0fedaae937afb76e672ca6d49b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v7Kkvyhh2w/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.OVpJaWbjm2/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-19 10:53:32,032 truncating revision to first 12 chars 2015-11-19 10:53:32,032 Setting DEBUG logging. 2015-11-19 10:53:32,032 attempt 1/10 2015-11-19 10:53:32,033 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d052d9447bf9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 10:53:33,438 unpacking tar archive at: fx-team-d052d9447bf9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.644462 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 10:53:33.621365) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:33.621693) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:33.633657) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:33.634008) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 10:53:33.634446) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-19 10:53:33.634739) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v7Kkvyhh2w/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.OVpJaWbjm2/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:53:33 INFO - MultiFileLogger online at 20151119 10:53:33 in /builds/slave/test 10:53:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:53:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:53:33 INFO - {'append_to_log': False, 10:53:33 INFO - 'base_work_dir': '/builds/slave/test', 10:53:33 INFO - 'blob_upload_branch': 'Fx-Team', 10:53:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:53:33 INFO - 'branch': 'Fx-Team', 10:53:33 INFO - 'buildbot_json_path': 'buildprops.json', 10:53:33 INFO - 'config_files': ('talos/mac_config.py',), 10:53:33 INFO - 'default_actions': ('clobber', 10:53:33 INFO - 'read-buildbot-config', 10:53:33 INFO - 'download-and-extract', 10:53:33 INFO - 'populate-webroot', 10:53:33 INFO - 'create-virtualenv', 10:53:33 INFO - 'install', 10:53:33 INFO - 'run-tests'), 10:53:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:53:33 INFO - 'download_minidump_stackwalk': True, 10:53:33 INFO - 'download_symbols': 'ondemand', 10:53:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:53:33 INFO - 'tooltool.py': '/tools/tooltool.py', 10:53:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:53:33 INFO - '/tools/misc-python/virtualenv.py')}, 10:53:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:53:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:53:33 INFO - 'installer_path': 'installer.exe', 10:53:33 INFO - 'log_level': 'info', 10:53:33 INFO - 'log_name': 'talos', 10:53:33 INFO - 'log_to_console': True, 10:53:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:53:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:53:33 INFO - 'opt_config_files': (), 10:53:33 INFO - 'pip_index': False, 10:53:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:53:33 INFO - 'cmd': ('bash', 10:53:33 INFO - '-c', 10:53:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:53:33 INFO - 'enabled': True, 10:53:33 INFO - 'halt_on_failure': False, 10:53:33 INFO - 'name': 'check_screen_resolution'},), 10:53:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:53:33 INFO - 'cmd': ('bash', 10:53:33 INFO - '-c', 10:53:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:53:33 INFO - 'enabled': True, 10:53:33 INFO - 'halt_on_failure': False, 10:53:33 INFO - 'name': 'check_screen_resolution'},), 10:53:33 INFO - 'run_cmd_checks_enabled': True, 10:53:33 INFO - 'sps_profile': False, 10:53:33 INFO - 'sps_profile_interval': 0, 10:53:33 INFO - 'suite': 'dromaeojs-e10s', 10:53:33 INFO - 'system_bits': '64', 10:53:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:53:33 INFO - 'title': 't-yosemite-r7-0062', 10:53:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:53:33 INFO - 'use_talos_json': True, 10:53:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:53:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:53:33 INFO - 'work_dir': 'build'} 10:53:33 INFO - ##### 10:53:33 INFO - ##### Running clobber step. 10:53:33 INFO - ##### 10:53:33 INFO - Running pre-action listener: _resource_record_pre_action 10:53:33 INFO - Running main action method: clobber 10:53:33 INFO - rmtree: /builds/slave/test/build 10:53:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:53:34 INFO - Running post-action listener: _resource_record_post_action 10:53:34 INFO - ##### 10:53:34 INFO - ##### Running read-buildbot-config step. 10:53:34 INFO - ##### 10:53:34 INFO - Running pre-action listener: _resource_record_pre_action 10:53:34 INFO - Running main action method: read_buildbot_config 10:53:34 INFO - Using buildbot properties: 10:53:34 INFO - { 10:53:34 INFO - "properties": { 10:53:34 INFO - "buildnumber": 12, 10:53:34 INFO - "product": "firefox", 10:53:34 INFO - "script_repo_revision": "production", 10:53:34 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 10:53:34 INFO - "repository": "", 10:53:34 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 10:53:34 INFO - "buildid": "20151119072803", 10:53:34 INFO - "slavename": "t-yosemite-r7-0062", 10:53:34 INFO - "pgo_build": "False", 10:53:34 INFO - "basedir": "/builds/slave/test", 10:53:34 INFO - "project": "", 10:53:34 INFO - "platform": "yosemite_r7", 10:53:34 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:53:34 INFO - "slavebuilddir": "test", 10:53:34 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:53:34 INFO - "branch": "fx-team", 10:53:34 INFO - "repo_path": "integration/fx-team", 10:53:34 INFO - "stage_platform": "macosx64", 10:53:34 INFO - "builduid": "b181926fed7a47508c9ea336b3e2ed65", 10:53:34 INFO - "revision": "d052d9447bf90d0fedaae937afb76e672ca6d49b" 10:53:34 INFO - }, 10:53:34 INFO - "sourcestamp": { 10:53:34 INFO - "repository": "", 10:53:34 INFO - "hasPatch": false, 10:53:34 INFO - "project": "", 10:53:34 INFO - "branch": "fx-team-macosx64-talos", 10:53:34 INFO - "changes": [ 10:53:34 INFO - { 10:53:34 INFO - "category": null, 10:53:34 INFO - "files": [ 10:53:34 INFO - { 10:53:34 INFO - "url": null, 10:53:34 INFO - "name": "https://queue.taskcluster.net/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 10:53:34 INFO - } 10:53:34 INFO - ], 10:53:34 INFO - "repository": "", 10:53:34 INFO - "rev": "d052d9447bf90d0fedaae937afb76e672ca6d49b", 10:53:34 INFO - "who": "cbook@mozilla.com", 10:53:34 INFO - "when": 1447952919, 10:53:34 INFO - "number": 6683757, 10:53:34 INFO - "comments": "Backed out changeset ddb0ac65cba2 (bug 1168113) for possibly causing crashes on fx-team on a CLOSED TREE", 10:53:34 INFO - "project": "", 10:53:34 INFO - "at": "Thu 19 Nov 2015 09:08:39", 10:53:34 INFO - "branch": "fx-team-macosx64-talos", 10:53:34 INFO - "revlink": "", 10:53:34 INFO - "properties": [ 10:53:34 INFO - [ 10:53:34 INFO - "buildid", 10:53:34 INFO - "20151119072803", 10:53:34 INFO - "Change" 10:53:34 INFO - ], 10:53:34 INFO - [ 10:53:34 INFO - "builduid", 10:53:34 INFO - "b181926fed7a47508c9ea336b3e2ed65", 10:53:34 INFO - "Change" 10:53:34 INFO - ], 10:53:34 INFO - [ 10:53:34 INFO - "pgo_build", 10:53:34 INFO - "False", 10:53:34 INFO - "Change" 10:53:34 INFO - ] 10:53:34 INFO - ], 10:53:34 INFO - "revision": "d052d9447bf90d0fedaae937afb76e672ca6d49b" 10:53:34 INFO - } 10:53:34 INFO - ], 10:53:34 INFO - "revision": "d052d9447bf90d0fedaae937afb76e672ca6d49b" 10:53:34 INFO - } 10:53:34 INFO - } 10:53:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 10:53:34 INFO - Running post-action listener: _resource_record_post_action 10:53:34 INFO - ##### 10:53:34 INFO - ##### Running download-and-extract step. 10:53:34 INFO - ##### 10:53:34 INFO - Running pre-action listener: _resource_record_pre_action 10:53:34 INFO - Running main action method: download_and_extract 10:53:34 INFO - mkdir: /builds/slave/test/build/tests 10:53:34 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')]} 10:53:34 INFO - https://queue.taskcluster.net/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:53:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/test_packages.json 10:53:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/test_packages.json 10:53:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:53:35 INFO - Downloaded 1149 bytes. 10:53:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:53:35 INFO - Using the following test package requirements: 10:53:35 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:53:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:53:35 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 10:53:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:53:35 INFO - u'jsshell-mac.zip'], 10:53:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:53:35 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 10:53:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:53:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:53:35 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 10:53:35 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:53:35 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 10:53:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:53:35 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 10:53:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:53:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:53:35 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 10:53:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:35 INFO - https://queue.taskcluster.net/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:53:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:53:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:53:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/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 10:53:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/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 10:53:37 INFO - Downloaded 17522226 bytes. 10:53:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 10:53:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:53:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 10:53:39 INFO - Return code: 0 10:53:39 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 10:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:39 INFO - https://queue.taskcluster.net/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:53:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:53:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:53:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/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 10:53:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/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 10:53:40 INFO - Downloaded 17522226 bytes. 10:53:40 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 10:53:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:53:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 10:53:44 INFO - Return code: 0 10:53:44 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')]} 10:53:44 INFO - https://queue.taskcluster.net/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:53:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:53:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:53:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/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 10:53:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/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 10:53:45 INFO - Downloaded 11130997 bytes. 10:53:45 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 10:53:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:53:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 10:53:45 INFO - Return code: 0 10:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:45 INFO - https://queue.taskcluster.net/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:53:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:53:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:53:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 10:53:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAvYD5BgTs2jpty7qt7xLw/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 10:53:48 INFO - Downloaded 109367604 bytes. 10:53:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:53:48 INFO - mkdir: /builds/slave/test/properties 10:53:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:53:48 INFO - Writing to file /builds/slave/test/properties/build_url 10:53:48 INFO - Contents: 10:53:48 INFO - build_url:https://queue.taskcluster.net/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:53:48 INFO - Running post-action listener: _resource_record_post_action 10:53:48 INFO - Running post-action listener: set_extra_try_arguments 10:53:48 INFO - ##### 10:53:48 INFO - ##### Running populate-webroot step. 10:53:48 INFO - ##### 10:53:48 INFO - Running pre-action listener: _resource_record_pre_action 10:53:48 INFO - Running main action method: populate_webroot 10:53:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:53:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:53:48 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:53:48 INFO - '../fennec_ids.txt'], 10:53:48 INFO - 'tests': ['tcheck2']}, 10:53:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:53:48 INFO - '--tppagecycles', 10:53:48 INFO - '7'], 10:53:48 INFO - 'tests': ['tsvgm']}}, 10:53:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:53:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:53:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:53:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:53:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:53:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:53:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:48 INFO - 'talos_options': ['--e10s'], 10:53:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:48 INFO - 'tests': ['damp', 'tps']}, 10:53:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:48 INFO - 'talos_options': ['--e10s'], 10:53:48 INFO - 'tests': ['damp', 'tps']}, 10:53:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:53:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:53:48 INFO - 'other': {'tests': ['a11yr', 10:53:48 INFO - 'ts_paint', 10:53:48 INFO - 'tpaint', 10:53:48 INFO - 'sessionrestore', 10:53:48 INFO - 'sessionrestore_no_auto_restore']}, 10:53:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:53:48 INFO - 'tests': ['a11yr', 10:53:48 INFO - 'ts_paint', 10:53:48 INFO - 'tpaint', 10:53:48 INFO - 'sessionrestore', 10:53:48 INFO - 'sessionrestore_no_auto_restore']}, 10:53:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:53:48 INFO - 'tests': ['a11yr', 10:53:48 INFO - 'ts_paint', 10:53:48 INFO - 'tpaint', 10:53:48 INFO - 'sessionrestore', 10:53:48 INFO - 'sessionrestore_no_auto_restore']}, 10:53:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:53:48 INFO - 'tests': ['a11yr', 10:53:48 INFO - 'ts_paint', 10:53:48 INFO - 'tpaint', 10:53:48 INFO - 'sessionrestore', 10:53:48 INFO - 'sessionrestore_no_auto_restore']}, 10:53:48 INFO - 'other_l64': {'tests': ['a11yr', 10:53:48 INFO - 'ts_paint', 10:53:48 INFO - 'tpaint', 10:53:48 INFO - 'sessionrestore', 10:53:48 INFO - 'sessionrestore_no_auto_restore']}, 10:53:48 INFO - 'other_nol64': {'tests': ['a11yr', 10:53:48 INFO - 'ts_paint', 10:53:48 INFO - 'tpaint', 10:53:48 INFO - 'sessionrestore', 10:53:48 INFO - 'sessionrestore_no_auto_restore']}, 10:53:48 INFO - 'svgr': {'tests': ['tsvgx', 10:53:48 INFO - 'tsvgr_opacity', 10:53:48 INFO - 'tart', 10:53:48 INFO - 'tscrollx', 10:53:48 INFO - 'cart']}, 10:53:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:53:48 INFO - 'tests': ['tsvgx', 10:53:48 INFO - 'tsvgr_opacity', 10:53:48 INFO - 'tart', 10:53:48 INFO - 'tscrollx', 10:53:48 INFO - 'cart']}, 10:53:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:48 INFO - 'tests': ['tp5o']}, 10:53:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:48 INFO - 'talos_options': ['--e10s'], 10:53:48 INFO - 'tests': ['tp5o']}, 10:53:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:48 INFO - 'talos_options': ['--xperf_path', 10:53:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:48 INFO - 'tests': ['tp5n']}, 10:53:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:48 INFO - 'talos_options': ['--e10s', 10:53:48 INFO - '--xperf_path', 10:53:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:48 INFO - 'tests': ['tp5n']}}, 10:53:48 INFO - 'talos.zip': {'path': '', 10:53:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:53:48 INFO - Running post-action listener: _resource_record_post_action 10:53:48 INFO - ##### 10:53:48 INFO - ##### Running create-virtualenv step. 10:53:48 INFO - ##### 10:53:48 INFO - Running pre-action listener: _resource_record_pre_action 10:53:48 INFO - Running main action method: create_virtualenv 10:53:48 INFO - Creating virtualenv /builds/slave/test/build/venv 10:53:48 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 10:53:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:53:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:53:48 INFO - Using real prefix '/tools/python27' 10:53:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:53:48 INFO - Installing distribute.............................................................................................................................................................................................done. 10:53:51 INFO - Installing pip.................done. 10:53:51 INFO - Return code: 0 10:53:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:53:51 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')]} 10:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:51 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')]} 10:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:51 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 0x10367b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103658228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe839c77fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10359f9f0>, '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 0x1032fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035928c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v7Kkvyhh2w/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.OVpJaWbjm2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:51 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 10:53:51 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 10:53:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v7Kkvyhh2w/Render', 10:53:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:51 INFO - 'HOME': '/Users/cltbld', 10:53:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:51 INFO - 'LOGNAME': 'cltbld', 10:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:51 INFO - 'MOZ_NO_REMOTE': '1', 10:53:51 INFO - 'NO_EM_RESTART': '1', 10:53:51 INFO - 'PAGER': '/bin/cat', 10:53:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:51 INFO - 'PWD': '/builds/slave/test', 10:53:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:51 INFO - 'SHELL': '/bin/bash', 10:53:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OVpJaWbjm2/Listeners', 10:53:51 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:53:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:51 INFO - 'USER': 'cltbld', 10:53:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:51 INFO - 'XPC_FLAGS': '0x0', 10:53:51 INFO - 'XPC_SERVICE_NAME': '0', 10:53:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:52 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 10:53:52 INFO - Cleaning up... 10:53:52 INFO - Return code: 0 10:53:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10367b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103658228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe839c77fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10359f9f0>, '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 0x1032fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035928c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v7Kkvyhh2w/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.OVpJaWbjm2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:53:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v7Kkvyhh2w/Render', 10:53:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:52 INFO - 'HOME': '/Users/cltbld', 10:53:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:52 INFO - 'LOGNAME': 'cltbld', 10:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:52 INFO - 'MOZ_NO_REMOTE': '1', 10:53:52 INFO - 'NO_EM_RESTART': '1', 10:53:52 INFO - 'PAGER': '/bin/cat', 10:53:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:52 INFO - 'PWD': '/builds/slave/test', 10:53:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:52 INFO - 'SHELL': '/bin/bash', 10:53:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OVpJaWbjm2/Listeners', 10:53:52 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:53:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:52 INFO - 'USER': 'cltbld', 10:53:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:52 INFO - 'XPC_FLAGS': '0x0', 10:53:52 INFO - 'XPC_SERVICE_NAME': '0', 10:53:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:52 INFO - Downloading/unpacking psutil>=0.7.1 10:53:52 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 10:53:52 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 10:53:52 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 10:53:52 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 10:53:52 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 10:53:52 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 10:53:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:53:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:53:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:53:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:55 INFO - Installing collected packages: psutil 10:53:55 INFO - Running setup.py install for psutil 10:53:55 INFO - building 'psutil._psutil_osx' extension 10:53:55 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 10:53:55 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 10:53:55 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 10:53:55 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 10:53:55 INFO - building 'psutil._psutil_posix' extension 10:53:55 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 10:53:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:53:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:53:55 INFO - ^ 10:53:55 INFO - 1 warning generated. 10:53:55 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 10:53:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:55 INFO - Successfully installed psutil 10:53:55 INFO - Cleaning up... 10:53:55 INFO - Return code: 0 10:53:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10367b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103658228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe839c77fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10359f9f0>, '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 0x1032fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035928c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v7Kkvyhh2w/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.OVpJaWbjm2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:53:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v7Kkvyhh2w/Render', 10:53:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:55 INFO - 'HOME': '/Users/cltbld', 10:53:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:55 INFO - 'LOGNAME': 'cltbld', 10:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:55 INFO - 'MOZ_NO_REMOTE': '1', 10:53:55 INFO - 'NO_EM_RESTART': '1', 10:53:55 INFO - 'PAGER': '/bin/cat', 10:53:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:55 INFO - 'PWD': '/builds/slave/test', 10:53:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:55 INFO - 'SHELL': '/bin/bash', 10:53:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OVpJaWbjm2/Listeners', 10:53:55 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:53:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:55 INFO - 'USER': 'cltbld', 10:53:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:55 INFO - 'XPC_FLAGS': '0x0', 10:53:55 INFO - 'XPC_SERVICE_NAME': '0', 10:53:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:53:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:53:58 INFO - Installing collected packages: mozsystemmonitor 10:53:58 INFO - Running setup.py install for mozsystemmonitor 10:53:58 INFO - Successfully installed mozsystemmonitor 10:53:58 INFO - Cleaning up... 10:53:58 INFO - Return code: 0 10:53:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:53: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')]} 10:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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')]} 10:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:58 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 0x10367b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103658228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe839c77fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10359f9f0>, '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 0x1032fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035928c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v7Kkvyhh2w/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.OVpJaWbjm2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:58 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 10:53:58 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 10:53:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v7Kkvyhh2w/Render', 10:53:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:58 INFO - 'HOME': '/Users/cltbld', 10:53:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:58 INFO - 'LOGNAME': 'cltbld', 10:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:58 INFO - 'MOZ_NO_REMOTE': '1', 10:53:58 INFO - 'NO_EM_RESTART': '1', 10:53:58 INFO - 'PAGER': '/bin/cat', 10:53:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:58 INFO - 'PWD': '/builds/slave/test', 10:53:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:58 INFO - 'SHELL': '/bin/bash', 10:53:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OVpJaWbjm2/Listeners', 10:53:58 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:53:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:58 INFO - 'USER': 'cltbld', 10:53:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:58 INFO - 'XPC_FLAGS': '0x0', 10:53:58 INFO - 'XPC_SERVICE_NAME': '0', 10:53:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:58 INFO - Downloading/unpacking blobuploader==1.2.4 10:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:01 INFO - Downloading blobuploader-1.2.4.tar.gz 10:54:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:54:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:54:01 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 10:54:01 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 10:54:01 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 10:54:01 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 10:54:01 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 10:54:01 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 10:54:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:54:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:54:01 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 10:54:01 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 10:54:01 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 10:54:01 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 10:54:01 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 10:54:01 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 10:54:02 INFO - Downloading docopt-0.6.1.tar.gz 10:54:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:54:02 INFO - Installing collected packages: blobuploader, requests, docopt 10:54:02 INFO - Running setup.py install for blobuploader 10:54:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:54:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:54:02 INFO - Running setup.py install for requests 10:54:02 INFO - Running setup.py install for docopt 10:54:03 INFO - Successfully installed blobuploader requests docopt 10:54:03 INFO - Cleaning up... 10:54:03 INFO - Return code: 0 10:54:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:03 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 0x10367b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103658228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe839c77fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10359f9f0>, '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 0x1032fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035928c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v7Kkvyhh2w/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.OVpJaWbjm2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:03 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 10:54:03 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 10:54:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v7Kkvyhh2w/Render', 10:54:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:03 INFO - 'HOME': '/Users/cltbld', 10:54:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:03 INFO - 'LOGNAME': 'cltbld', 10:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:03 INFO - 'MOZ_NO_REMOTE': '1', 10:54:03 INFO - 'NO_EM_RESTART': '1', 10:54:03 INFO - 'PAGER': '/bin/cat', 10:54:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:03 INFO - 'PWD': '/builds/slave/test', 10:54:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:03 INFO - 'SHELL': '/bin/bash', 10:54:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OVpJaWbjm2/Listeners', 10:54:03 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:54:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:03 INFO - 'USER': 'cltbld', 10:54:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:03 INFO - 'XPC_FLAGS': '0x0', 10:54:03 INFO - 'XPC_SERVICE_NAME': '0', 10:54:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:54:03 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-hwFy7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:54:03 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-djfTLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:54:03 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-hKFplF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:54:03 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-UVwsKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:54:03 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-dibaev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:54:03 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-YgBtGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:54:04 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-jC7jlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:54:04 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-wFKyM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:54:04 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-PR1fVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:54:04 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-m5Onoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:54:04 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-JYdojw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:54:04 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-o8Kxl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:54:04 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-7uaB1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:54:04 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-9xD5n9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:04 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-UGW52l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:54:04 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-gsIMLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:54:05 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-ymRacQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:54:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:54:05 INFO - Running setup.py install for manifestparser 10:54:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:54:05 INFO - Running setup.py install for mozcrash 10:54:05 INFO - Running setup.py install for mozdebug 10:54:05 INFO - Running setup.py install for mozdevice 10:54:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:54:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:54:05 INFO - Running setup.py install for mozfile 10:54:05 INFO - Running setup.py install for mozhttpd 10:54:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:54:06 INFO - Running setup.py install for mozinfo 10:54:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:54:06 INFO - Running setup.py install for mozInstall 10:54:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:54:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:54:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:54:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:54:06 INFO - Running setup.py install for mozleak 10:54:06 INFO - Running setup.py install for mozlog 10:54:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:54:06 INFO - Running setup.py install for moznetwork 10:54:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:54:06 INFO - Running setup.py install for mozprocess 10:54:06 INFO - Running setup.py install for mozprofile 10:54:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:54:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:54:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:54:07 INFO - Running setup.py install for mozrunner 10:54:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:54:07 INFO - Running setup.py install for mozscreenshot 10:54:07 INFO - Running setup.py install for moztest 10:54:07 INFO - Running setup.py install for mozversion 10:54:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:54:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:54:07 INFO - Cleaning up... 10:54:07 INFO - Return code: 0 10:54:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:07 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')]} 10:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:07 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')]} 10:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:07 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 0x10367b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103658228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe839c77fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10359f9f0>, '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 0x1032fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035928c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v7Kkvyhh2w/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.OVpJaWbjm2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:07 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 10:54:07 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 10:54:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v7Kkvyhh2w/Render', 10:54:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:07 INFO - 'HOME': '/Users/cltbld', 10:54:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:07 INFO - 'LOGNAME': 'cltbld', 10:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:07 INFO - 'MOZ_NO_REMOTE': '1', 10:54:07 INFO - 'NO_EM_RESTART': '1', 10:54:07 INFO - 'PAGER': '/bin/cat', 10:54:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:07 INFO - 'PWD': '/builds/slave/test', 10:54:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:07 INFO - 'SHELL': '/bin/bash', 10:54:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OVpJaWbjm2/Listeners', 10:54:07 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:54:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:07 INFO - 'USER': 'cltbld', 10:54:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:07 INFO - 'XPC_FLAGS': '0x0', 10:54:07 INFO - 'XPC_SERVICE_NAME': '0', 10:54:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:54:07 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-DC_sjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:54:08 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)) 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:54:08 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-I__6r7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:54:08 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)) 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:54:08 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-64hN_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:54:08 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)) 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:54:08 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-PPrmnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:54:08 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)) 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:54:08 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-7aClUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:54:08 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)) 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:54:08 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-7V_dLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:54:08 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)) 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:54:08 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-e4Z91L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:54:08 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)) 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:54:08 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-pv3Rxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:54:08 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)) 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:54:08 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-LGRxqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:54:08 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)) 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:54:08 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-S7ZI4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:54:09 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)) 10:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:54:09 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-bJp8Xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:54:09 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)) 10:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:54:09 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-rQFtSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:54:09 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)) 10:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:54:09 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-g4uk3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:54:09 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)) 10:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:54:09 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-vu1byN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:54:09 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)) 10:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:09 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-evVOnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:09 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)) 10:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:54:09 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-nMdLDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:54:09 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)) 10:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:54:09 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-x5ygoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:54:09 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)) 10:54:09 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)) 10:54:09 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)) 10:54:09 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)) 10:54:09 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)) 10:54:09 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)) 10:54:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:54:09 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 10:54:09 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 10:54:09 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 10:54:09 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 10:54:09 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 10:54:09 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 10:54:11 INFO - Downloading blessings-1.5.1.tar.gz 10:54:11 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 10:54:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:54:11 INFO - Installing collected packages: blessings 10:54:11 INFO - Running setup.py install for blessings 10:54:12 INFO - Successfully installed blessings 10:54:12 INFO - Cleaning up... 10:54:12 INFO - Return code: 0 10:54:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:54:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:54:12 INFO - Reading from file tmpfile_stdout 10:54:12 INFO - Current package versions: 10:54:12 INFO - blessings == 1.5.1 10:54:12 INFO - blobuploader == 1.2.4 10:54:12 INFO - docopt == 0.6.1 10:54:12 INFO - manifestparser == 1.1 10:54:12 INFO - mozInstall == 1.12 10:54:12 INFO - mozcrash == 0.16 10:54:12 INFO - mozdebug == 0.1 10:54:12 INFO - mozdevice == 0.47 10:54:12 INFO - mozfile == 1.2 10:54:12 INFO - mozhttpd == 0.7 10:54:12 INFO - mozinfo == 0.9 10:54:12 INFO - mozleak == 0.1 10:54:12 INFO - mozlog == 3.0 10:54:12 INFO - moznetwork == 0.27 10:54:12 INFO - mozprocess == 0.22 10:54:12 INFO - mozprofile == 0.27 10:54:12 INFO - mozrunner == 6.11 10:54:12 INFO - mozscreenshot == 0.1 10:54:12 INFO - mozsystemmonitor == 0.0 10:54:12 INFO - moztest == 0.7 10:54:12 INFO - mozversion == 1.4 10:54:12 INFO - psutil == 3.1.1 10:54:12 INFO - requests == 1.2.3 10:54:12 INFO - wsgiref == 0.1.2 10:54:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:12 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 0x10367b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103658228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe839c77fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10359f9f0>, '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 0x1032fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035928c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v7Kkvyhh2w/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.OVpJaWbjm2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:54:12 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 10:54:12 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 10:54:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v7Kkvyhh2w/Render', 10:54:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:12 INFO - 'HOME': '/Users/cltbld', 10:54:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:12 INFO - 'LOGNAME': 'cltbld', 10:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:12 INFO - 'MOZ_NO_REMOTE': '1', 10:54:12 INFO - 'NO_EM_RESTART': '1', 10:54:12 INFO - 'PAGER': '/bin/cat', 10:54:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:12 INFO - 'PWD': '/builds/slave/test', 10:54:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:12 INFO - 'SHELL': '/bin/bash', 10:54:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OVpJaWbjm2/Listeners', 10:54:12 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:54:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:12 INFO - 'USER': 'cltbld', 10:54:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:12 INFO - 'XPC_FLAGS': '0x0', 10:54:12 INFO - 'XPC_SERVICE_NAME': '0', 10:54:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:12 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)) 10:54:12 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)) 10:54:12 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)) 10:54:12 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)) 10:54:12 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)) 10:54:12 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)) 10:54:12 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)) 10:54:12 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)) 10:54:12 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)) 10:54:12 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)) 10:54:12 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)) 10:54:12 INFO - Cleaning up... 10:54:12 INFO - Return code: 0 10:54:12 INFO - Running post-action listener: _resource_record_post_action 10:54:12 INFO - Running post-action listener: _start_resource_monitoring 10:54:12 INFO - Starting resource monitoring. 10:54:12 INFO - ##### 10:54:12 INFO - ##### Running install step. 10:54:12 INFO - ##### 10:54:12 INFO - Running pre-action listener: _resource_record_pre_action 10:54:12 INFO - Running main action method: install 10:54:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:54:13 INFO - Reading from file tmpfile_stdout 10:54:13 INFO - Detecting whether we're running mozinstall >=1.0... 10:54:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:54:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:54:13 INFO - Reading from file tmpfile_stdout 10:54:13 INFO - Output received: 10:54:13 INFO - Usage: mozinstall [options] installer 10:54:13 INFO - Options: 10:54:13 INFO - -h, --help show this help message and exit 10:54:13 INFO - -d DEST, --destination=DEST 10:54:13 INFO - Directory to install application into. [default: 10:54:13 INFO - "/builds/slave/test"] 10:54:13 INFO - --app=APP Application being installed. [default: firefox] 10:54:13 INFO - mkdir: /builds/slave/test/build/application 10:54:13 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'] 10:54:13 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 10:54:43 INFO - Reading from file tmpfile_stdout 10:54:43 INFO - Output received: 10:54:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:54:43 INFO - Running post-action listener: _resource_record_post_action 10:54:43 INFO - ##### 10:54:43 INFO - ##### Running run-tests step. 10:54:43 INFO - ##### 10:54:43 INFO - Running pre-action listener: _resource_record_pre_action 10:54:43 INFO - Running main action method: run_tests 10:54:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:54:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:54:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:54:43 INFO - 2015-11-19 10:54:43.372 screenresolution[1966:14010] starting screenresolution argv=screenresolution get 10:54:43 INFO - 2015-11-19 10:54:43.375 screenresolution[1966:14010] Display 0: 1600x1200x32@60 10:54:43 INFO - 2015-11-19 10:54:43.381 screenresolution[1967:14012] starting screenresolution argv=screenresolution list 10:54:43 INFO - Available Modes on Display 0 10:54:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:54:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:54:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:54:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:54:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:54:43 INFO - Intel Iris: 10:54:43 INFO - Chipset Model: Intel Iris 10:54:43 INFO - Type: GPU 10:54:43 INFO - Bus: Built-In 10:54:43 INFO - VRAM (Dynamic, Max): 1536 MB 10:54:43 INFO - Vendor: Intel (0x8086) 10:54:43 INFO - Device ID: 0x0a2e 10:54:43 INFO - Revision ID: 0x0009 10:54:43 INFO - Displays: 10:54:43 INFO - Display: 10:54:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:54:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:54:43 INFO - Display Serial Number: 1600x1200 60 10:54:43 INFO - Main Display: Yes 10:54:43 INFO - Mirror: Off 10:54:43 INFO - Online: Yes 10:54:43 INFO - Rotation: Supported 10:54:43 INFO - Return code: 0 10:54:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:54:43 INFO - Python 2.7.3 10:54:43 INFO - Return code: 0 10:54:43 INFO - grabbing minidump binary from tooltool 10:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:43 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 0x10359f9f0>, '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 0x1032fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035928c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:54:43 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 10:54:43 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 10:54:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:54:43 INFO - Return code: 0 10:54:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:54:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:54:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:54:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:54:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:54:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--webServer', 'localhost'] in /builds/slave/test/build 10:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0062 --webServer localhost 10:54:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v7Kkvyhh2w/Render', 10:54:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:43 INFO - 'HOME': '/Users/cltbld', 10:54:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:43 INFO - 'LOGNAME': 'cltbld', 10:54:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:54:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:43 INFO - 'MOZ_NO_REMOTE': '1', 10:54:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:54:43 INFO - 'NO_EM_RESTART': '1', 10:54:43 INFO - 'PAGER': '/bin/cat', 10:54:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:43 INFO - 'PWD': '/builds/slave/test', 10:54:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:54:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:43 INFO - 'SHELL': '/bin/bash', 10:54:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OVpJaWbjm2/Listeners', 10:54:43 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 10:54:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:43 INFO - 'USER': 'cltbld', 10:54:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:43 INFO - 'XPC_FLAGS': '0x0', 10:54:43 INFO - 'XPC_SERVICE_NAME': '0', 10:54:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--webServer', 'localhost'] with output_timeout 3600 10:54:43 INFO - mozversion INFO | application_buildid: 20151119072803 10:54:43 INFO - mozversion INFO | application_changeset: d052d9447bf90d0fedaae937afb76e672ca6d49b 10:54:43 INFO - mozversion INFO | application_display_name: Nightly 10:54:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:54:43 INFO - mozversion INFO | application_name: Firefox 10:54:43 INFO - mozversion INFO | application_remotingname: firefox 10:54:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:54:43 INFO - mozversion INFO | application_vendor: Mozilla 10:54:43 INFO - mozversion INFO | application_version: 45.0a1 10:54:43 INFO - mozversion INFO | platform_buildid: 20151119072803 10:54:43 INFO - mozversion INFO | platform_changeset: d052d9447bf90d0fedaae937afb76e672ca6d49b 10:54:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:54:43 INFO - mozversion INFO | platform_version: 45.0a1 10:54:43 INFO - 2015-11-19 10:54:43,916 DEBUG : using testdate: 1447959283 10:54:43 INFO - 2015-11-19 10:54:43,917 DEBUG : actual date: 1447959283 10:54:44 INFO - 2015-11-19 10:54:44,360 INFO : starting webserver on 'localhost:49500' 10:54:44 INFO - 2015-11-19 10:54:44,361 INFO : Starting test suite t-yosemite-r7-0062.e 10:54:44 INFO - 2015-11-19 10:54:44,361 INFO : Starting test dromaeo_css 10:54:44 INFO - 2015-11-19 10:54:44,361 DEBUG : operating with platform_type : mac_ 10:54:44 INFO - 2015-11-19 10:54:44,362 INFO : Initialising browser for dromaeo_css test... 10:54:44 INFO - 2015-11-19 10:54:44,374 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpCizDEM/profile http://localhost:49500/getInfo.html 10:54:47 INFO - 2015-11-19 10:54:47,013 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:54:47 INFO - 2015-11-19 10:54:47,013 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:54:47 INFO - 2015-11-19 10:54:47,013 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:54:47 INFO - 2015-11-19 10:54:47,013 DEBUG : BROWSER_OUTPUT: __metrics 10:54:47 INFO - 2015-11-19 10:54:47,813 INFO : Browser initialized. 10:54:47 INFO - 2015-11-19 10:54:47,813 INFO : Running cycle 1/1 for dromaeo_css test... 10:54:47 INFO - 2015-11-19 10:54:47,813 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpCizDEM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:54:59 INFO - 2015-11-19 10:54:59,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 237043712 10:54:59 INFO - 2015-11-19 10:54:59,787 DEBUG : BROWSER_OUTPUT: 10:55:49 INFO - 2015-11-19 10:55:49,467 DEBUG : BROWSER_OUTPUT: 1447959349467 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] 10:58:00 INFO - 2015-11-19 10:58:00,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49500/tests/dromaeo/cssquery-ext.html) 10:58:01 INFO - 2015-11-19 10:58:01,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 253521920 10:58:01 INFO - 2015-11-19 10:58:01,942 DEBUG : BROWSER_OUTPUT: 11:01:04 INFO - 2015-11-19 11:01:04,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/dromaeo/cssquery-ext.html (next: http://localhost:49500/tests/dromaeo/cssquery-jquery.html) 11:01:04 INFO - 2015-11-19 11:01:04,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 262868992 11:01:04 INFO - 2015-11-19 11:01:04,675 DEBUG : BROWSER_OUTPUT: 11:04:06 INFO - 2015-11-19 11:04:06,223 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49500/tests/dromaeo/cssquery-mootools.html) 11:04:06 INFO - 2015-11-19 11:04:06,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 263561216 11:04:06 INFO - 2015-11-19 11:04:06,809 DEBUG : BROWSER_OUTPUT: 11:07:08 INFO - 2015-11-19 11:07:08,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49500/tests/dromaeo/cssquery-prototype.html) 11:07:09 INFO - 2015-11-19 11:07:09,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 266047488 11:07:09 INFO - 2015-11-19 11:07:09,058 DEBUG : BROWSER_OUTPUT: 11:10:11 INFO - 2015-11-19 11:10:11,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49500/tests/dromaeo/cssquery-yui.html) 11:10:12 INFO - 2015-11-19 11:10:12,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 268783616 11:10:12 INFO - 2015-11-19 11:10:12,173 DEBUG : BROWSER_OUTPUT: 11:13:14 INFO - 2015-11-19 11:13:14,382 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/dromaeo/cssquery-yui.html (next: http://localhost:49500/tests/dromaeo/cssquery-dojo.html) 11:13:14 INFO - 2015-11-19 11:13:14,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 271642624 11:13:14 INFO - 2015-11-19 11:13:14,634 DEBUG : BROWSER_OUTPUT: 11:13:14 INFO - 2015-11-19 11:13:14,634 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:13:14 INFO - 2015-11-19 11:13:14,634 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:13:14 INFO - 2015-11-19 11:13:14,634 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:13:14 INFO - 2015-11-19 11:13:14,634 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:13:14 INFO - 2015-11-19 11:13:14,637 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2829.787765917556;2832.745052945235;3529.94705079424;3570.0896271450774;3570.696490798282;5878.23582934219;5963.165156878041;6017.729202185901;6033.1855199548045;6056.121862329959;4345.217860785057;5780.72823978724;5807.332156801969;5995.310539287983;6000.639961602307;5316.282301889234;5350.759215835277;5370.43610420906;5407.324084489439;5486.533644640211;5355.98236335095;5388.326459192601;5401.864953376177;5423.3491980962335;5425.348958125031;5402.8109016184635;5428.348598168205;5460.071787796064;5472.72636368182;5519.972400138014;5134.973005398935;5161.66449180802;5282.392524859613;5304.098303288451;5403.108487099624;5293.788248470057;5326.813561525367;5376.301080859464;5385.973070134663;5412.864678383033;5656.2929633795775;5775.451332123442;5864.06175011996;5865.530757539386;6015.0375939849855;5554.611177217596;6142.617910970041;6210.937890621081;6272.65500397478;6282.685865706742;6334.113224148623;6377.968110159466;6384.233891932998;6395;6476.060971159155;5946;6085.330613632497;6129.69351532426;6143.600665956698;6150.569460137792;5050.570701490415;6535.901961470582;6545.083688283644;6556.049372840911;6559.048937903977;6281.2462504498835;6282.560220784592;6293.402126797947;6298.527610429236;6302.905456418157;5727.8854422912145;5813.215215945793;6208.161898143783;6244.313125556185;6401.295857455676;6256;6263.78076767311;6305.054241863665;6328.6202827830475;6340.968295158495;6309.968450157719;6310.116583678288;6315.273743519462;6321.304656487782;6324.683765811691;4960.107180707508;5058.54473097423;5074.06129865976;5124.103281925648;5193.896122077537;4599.816007359668;4613.815447382134;4616.053708989649;4628.282616194495;4644.651651126179;5657.80197693087;6145.201123853871;6176.382361763877;6186.226721659793;6198.938010619836;6190.907136392958;6205.906911396332;6275.309715931244;6351;6374.203224596926;6159.4456498915315;6163.3836616338;6193.287771906288;6206.007038873759;6235.064740288993;5433.375161856358;5644.689542075143;5651;5656.123300888369;5700.7719691212715;6387;6458.483321334282;6459.9031014533875;6483.610983341015;6560.573562718408;6338.271098823509;6341.302456729848;6354.6822658867795;6358.491320694241;6374.90437643445;6472.417482426604;6493.383128602775;6547.443467305332;6551.344865513411;6571.34286571339;5178.818741344035;5342.839714808562;6218;6352;6378.33027532121;5522.978249023943;6380.904286435614;6400.51996100285;6402.9679851602305;6417.422431981144;5633.126865335879;6141.42463864406;6280.591761535486;6285.779997700059;6291.779787707408;6134.478569321479;6183;6213.65824879636;6228.190335256388;6255.655938923403;5438.619296649196;5918.2898052232285;6057.606255593372;6090.299615544269;6141.815745527641;5973.402659733992;6093.957602078378;6240.344763799736;6252.249730032425;6253.499720022478;5226.712530810842;6152.7538898445355;6232.065190221503;6235.251769787655;6241.500679945684 11:13:14 INFO - 2015-11-19 11:13:14,638 DEBUG : BROWSER_OUTPUT: |1;ext.html;526.7208379558836;565.380907905843;583.2359608912325;616.938306169383;617.5214208988034;40836.979075523086;41437.0994030418;41577.58422415775;41709.58290417095;41753.16493670129;44052.3392149118;44409.77795111028;44558.554414455844;44688.3296750549;44844.551554484446;9664;9831.606735730598;9832.803343933118;9848.60605575776;9850.556724947359;9615.375000624972;9646.180074693624;9693.70918872435;9717.659881904136;9790.167835733972;9645.276604254674;9692.41845489273;9696.418214907093;9733.124018838338;9785.902140978571;9706.466144362057;9724.513774311255;9745.31782775206;9760.41437513748;9796.559154838049;9589.42463452195;9656.082672146134;9729.805403891953;9755.268354873342;9771.364861284064;33995.49006764901;40929.38605920914;40978.18043639111;41067.794661026805;41300.108992370544;3251.5122731590213;3347.548081009057;3407.812570308632;3435.986384016696;3798.6771124454453;28442.857785710938;29292.560611590845;30003.549946750816;30007.399852003055;30033.549496757565;2257.9887100564392;2432.2095319021214;2498.1756020513185;2516.660250866128;2608.0480624572083;499264;499302;511980;522815;677114.9999999951;55214.72392638011;55364;55408.6147846299;55766.72116639391;55953.72023139858;56535;56999.43000570024;57000.42999570034;57713.71143144257;57833.421665783644;16348.836511634969;16419.1790410479;16567.337306507845;16576.419825306057;16769.1615419231;12699.301538415475;12832.935835320764;12872.613821585368;12947.223166609845;12972.15680980752;19775.60448791045;20108.195672173242;20116.597668046557;20140.39578812638;20142.798572014384;7952.204779522117;8087.231712987257;8128.9593552031865;8129.430939834155;8192.221738934792;999.4153420249236;1034.343192073039;1055.3087727538475;1075.7902209069314;1130.9321440713584;24506.387340316636;27246.727532724817;30176.94380696665;30772;30795.076147715605;893.5353616119581;1007.1640538353149;1114.8327750837439;1183.248637115438;1195.8445402097673;15353.769693454607;15641.061536307858;15691.607709807118;15748.133852637986;16537.338506459848;659262;659521;660079;660398;672986;62448.75102497925;62891.742165156444;62903;62919;63152.05271920925;1416.7874818777266;1445.2051371745497;1451.477468111479;1468.2365170111696;1472.889533285008;30528.08415747531;30664.119675506532;30681;30819;30872.228194295323;54402.727986359816;54702.452975469736;54789.726051369486;54941.72529137329;54967;474602;476380;477007;477850;478233;35159.29681406306;47910.76044619754;48069.03861922812;49605;49770.50229497803;46474.535254647024;47055.76472117617;47064.058718824745;47150.29274560816;47647;38906.10938906087;39240.803795980835;40487.595124048385;40775;41624.04571565696;38617;38934.80532597319;39193;39223.60776392314;39847.80076099601;38611.80694096624;38669.6133038666;38716.80641596774;38758.6124138755;39001;28111.859440703483;33634.66365336413;34431.311373772885;34721.65278347184;34853;21292.893535532225;25544.105956292184;25971;26203.68981550953;26270.949162033303 11:13:14 INFO - 2015-11-19 11:13:14,641 DEBUG : BROWSER_OUTPUT: |2;jquery.html;322.4099897188146;356.5471850749548;364.87958973538724;365.32415032190437;366.7121309771829;16357;20027;20089.59820803583;20506.2822801202;21177.788222117793;19993;20171.697424538645;20545;20576;21270.468238294052;5649.774009039644;5756.194132821408;5787.508061814729;5804.419558044204;5825.737841797109;4857.34425852509;4990.201567749161;4997.625178111638;5000.5999520038495;5987.880242395149;4701.106789709944;4886.682365646239;4903.338049363344;4911.214205727084;4912.680675756064;4382.561743825608;4847.321375007502;4920.360353154085;4921.212605983062;4950.727709975968;4135.545090040093;4164.4586203793315;4181.247375472413;4235.788210589458;4277.016286254147;13725.931370343083;13876.722465550733;13920.095193812369;14022.859771402258;14238.857611423857;1881.5578339090303;1943.7375954246138;1952.9023548822645;2052.7331446911953;2138.4068868692766;10108.696739097839;10230.38617682934;10236.385816850938;10321.225908056851;10352.275340726152;1560.36805093936;1577.960550986223;1589.721798685237;1595.728726116563;1609.2919115589104;92723;95962.04037959602;96898.9999999993;97098;97180;6678.699458524378;6770.119884415093;6770.187577490733;6787.592744435349;6822.147231596051;7589.924100759032;7681.846363072707;7694.07671079474;7736.845263094707;7764.6894124234395;5685.658860468385;5690.231818704505;5716.88520738452;5726.112452569859;5738.368779434259;6186.443220110212;6198.845028874314;6216.53375996793;6220.688965551795;6249.437550620466;2819.3515491437083;3006.2784931616256;3008.533677280025;3041.422129795332;3048.5731997520365;985.6545814962525;1080.6757972608186;1084.8426978088291;1098.242212873115;1122.449999500239;443.63400194839386;453.14808160657753;460.48195779747783;478.7582270953146;486.1807853766415;11367.602133925273;12390.938045309897;12414.503419863104;12572;12634.431450584745;437.319967450611;480.4402870655647;482.2043628013735;483.82824097445604;491.82786024891715;6681.265060843303;6693.330666933365;6748.730050798012;6769.1876974763345;6802.387785099365;778356;784487;789052;803608;812184;114741;115827.84172158339;118059.40970295093;120210;122444.16333754822;517.9300794392709;520.6901893373437;523.4190049045633;524.3917056214697;525.6609486881017;11059.557617695202;11844.230125041844;11967.700807479883;11971.98238149767;12043;42378;55188.17217741657;55482.72258638842;55525.44474555203;55577.444225558844;77097;77727.61136194282;77825.22174778406;78713;79021;6419.839504012437;6464.191976003;6469.77355792545;6505.902411463737;6510.381513756186;10530.05229529346;10769.192310576582;12086.15396922207;12570.811437828257;12679.746405072032;9981;10649.988251116132;10884.292520986111;10956.178286628694;11026.724331891766;10624.36253824742;10639.202059845697;10644.254902156774;10854;10921.726956826144;10873.96697313754;11077.667669969915;11084.390358530358;11143.052840508648;11176.385298808644;6331.366863313632;6337.493000559852;6457.709403076967;6472.223333200046;6482;10801.837972430578;10820.4048777318;11035.558577656804;11037.227394082338;11189.04893084097 11:13:14 INFO - 2015-11-19 11:13:14,643 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1497.15410792902;1536.0553259745252;1797.074506629087;1886.6226754649065;1895.3461055935702;7562.735304264352;7629.580373079492;8104.716334928279;8258.00903891534;8281.544515051677;7835.725749598765;8170.060443049051;8323.500589964606;8366.581670916461;8380.371472139583;2327.138958585326;2366.526694661066;2368.265837590344;2370.7866292033714;2374.548835721216;2072.668373060311;2377.4413012941945;2396.149366974725;2412.5898597238424;2425.333033415807;2341.625339945609;2360.9173678921243;2379.4170428245016;2382.404398900275;2395.197608801054;1993.6610776168013;2351.71779386473;2378.0250097460043;2379.785819276256;2387.78509934105;2382.7617238276207;2383;2403.7596240375824;2412.16780210827;2426.97573024271;7095.538789978635;8344.791380215482;8353.624086916043;8418.621162047722;8450.19723126302;5132.871678208037;5223.399309079467;5230.189320655304;5234.842954711365;5242.266082748418;3471.1643633784556;3547.8048707321086;3548.822558872072;3559.1280136366495;3598.838052287653;1047.4867315015663;1063.3991794636006;1068.3483075324045;1081.453865797775;1083.6261489786011;11077.335359878432;11102.666919992333;11104.167187460973;11122.944385278102;11148.275362101518;4679.789409476582;4690.89763905482;4727.196376615983;4736.052789442126;4748.881277968078;9571.856422153673;9630.133288004114;9638.759031024281;9644.75888102803;9674.661386851427;5198.792048318025;5207.0887594670785;5208.114620514446;5224.686518808883;5225.555827754683;4291.206126866539;4366.563343665608;4635.281531362644;4739.075880203396;4749.95250047502;3860.7876566788536;3898.0644645285493;3912.7065470089856;3926.450296958428;3963.2667956428154;1279.4178648714812;1286.8648791876906;1295.430010795247;1296.1121631682329;1297.6690943809458;1140.2645293785463;1144.8683401408778;1157.7626586549736;1158.9685180189638;1163.203205804027;7834.099078606033;7864.567448790257;7894.763157105296;7929.32600728933;7933.365330773524;1209.8427204463364;1209.8729633388543;1210.5218438716659;1213.0538180219266;1230.4524486603375;6232.283287421914;6277.780277690259;6283.497320214372;6320.71556779946;6342.429181373606;8366.916330836735;10100.74748131288;10100.797984040279;10138.746531336628;10185.287029907984;9722.513874306256;9973.700788976343;9985.550650220757;10041.598336066621;10061.245406594535;7862.292393684482;7866.528008319519;7901.644426000844;7920.485168464032;7957.801054973556;7437.665305061393;7494.250574942462;7535.54786712799;7540.698372065056;7562.886556701764;8876.600552975002;8937.240334571634;9029.322800789836;9073.092690731139;9201.263898888206;9247.953760231156;9337.346385752931;9369.109934556207;9396.67111651089;9422.670206542738;6332.493400527855;6423.807285781434;6761.661916904233;6893.345132212432;6955.1653801544135;6756.729730810713;7875.684972601031;7876.6061696913775;7941.444098913021;7949.7217597383815;7325.230850760593;7424.368928641126;7455.7017719290625;7557.05536807899;7603.0876294844975;7209.243029482039;7375.078115235596;7434.1450733166375;7442.032535770315;7464.328210461084;6392.296847346881;7457.701691932262;7493.063367079115;7512.661930213263;7516.812079698051;6794.966025169842;6834.794956151323;6864.039034535269;6870.2442731298515;6885.4835887309655;6922.861542769016;6945.548539344926;6962.721491140298;6972.58164510131;6978.162620485574 11:13:14 INFO - 2015-11-19 11:13:14,644 DEBUG : BROWSER_OUTPUT: |4;prototype.html;317.22280412988175;320.35288716792064;324.8895375572305;327.0809026635156;331.42663192676685;6297.779577714781;6775.254721980578;6922.861542769142;6982.4763142764305;6990.965045174773;6094.817155485332;6135.631862088278;6181.536384771138;6351.142595749572;6359.841003974903;4109.609587089221;5104.387473503176;5113.1307677694695;5115.232715092748;5145.2796608474655;4137.793110344486;5143.3570803649545;5143.974280128594;5154.098032844237;5166.147585648364;4810.470848206694;4963.751812409365;4966.826161084363;4981.402231732197;4995.150824359849;4962.0820148272505;4971.925421118686;4981.676191047606;4985.700857948535;4995.325631039799;3992.7803970781597;4059.6955228357992;4099.528554216274;4182.853600123981;4190.015346393595;6111.991521398963;6135.693215339215;6580.80257592273;6626.701798419034;6679.732810687567;5878.294604647427;5884.617499862496;5900.321463031763;5911.320198177222;5934.406559344075;5931.525477961753;7228.566286022856;7342.7797166084565;7357.190709022003;7376.96311518439;4791.401074865642;4807.18277892759;4814.831480898187;4858.514148585148;4874.2444921037295;7813.96093019537;7891.053073631144;7894.842103157962;7908.841823163504;7920.603969801545;4758.5241475852135;4935.950640493621;4954.677945933503;4960.8759781005765;4966.1309270877455;5037.992401519711;5042.747862606855;5046.44489106198;5047.621428392812;5061.822836200715;4873.098476781806;5936.901673190388;5964.761409543569;5974.701264936736;5994.820155395345;6137.693115344215;7423.331900129015;7428.591427471541;7446.553206807609;7472.17806041335;1418.432626949208;1454.7163303155783;1731.3074770092064;1741.8780685351903;1742.0418769676628;931;1119.451468780308;1132.2357408749226;1132.3092913322866;1132.3998280910967;6969.860602787916;6976.232614412411;6978.546394484342;6984.4063254623925;7067.151941767021;7683.500572462772;7711.498752581064;7713.190115037953;7723.343515801107;7734.071911370559;5702.0021496238;6849.726010959605;6919;6938.79183624482;7022.367986881205;3202.615686117681;4034.455348527911;4069.409935559327;4121;4123.628873401408;7864.2922137007945;8014.519128852287;8072.757817265491;8079.919200807916;8116.715914942949;8005.479643823133;8020.639071241808;8022.598870056474;8029.59852007409;8090.1909809018625;7060.764366235991;7805.41459390548;8065;8086;8091.433599648086;7618.238176182559;7770.300672939463;7770.417218708506;7786.416018798726;7801.609919503889;7288.744893928687;7581.370005448634;7591.734289299848;7599.620018998918;7635.770926871981;6474.539674923499;7045.718171273092;7552.980347653216;8041.959790201012;8061.838763224585;4687.718736875799;4792.880177995578;4803.231482962709;4822.831200907952;4835.661503694708;7182.102237220348;7576.052993375828;7655.349295309961;7814.88277675824;7850.293473587176;7464.776056718307;7466.328030477283;7471.439642026761;7479.476436649382;7497.100347958061;6818.93181068183;7416.629168541659;7433.628318584158;7480.193024347817;7496.287852653989;5955.553333500092;6607.339266073546;7054.682539285642;7308.940203670331;7350.77947661571;7470.925290747023;7483.214262502359;7491.775246742606;7495.62521873915;7511.47419680639;7141.357277845019;7325.413966882743;7339.706411743684;7362.447816413897;7377.741779037708 11:13:14 INFO - 2015-11-19 11:13:14,647 DEBUG : BROWSER_OUTPUT: |5;yui.html;678.6199728152232;735.3492159438895;780.1379475679375;801.194799226777;812.6383759227144;14738.705225895488;14939.327730252138;15059.665751808487;15076;15104.546863594096;13890.23603701796;13956;14015.15909045458;14498.782518262207;14526.854731452682;944.3059351376733;945.0502245243521;958.2908647600794;968.6803354892903;971.8687977123069;952.1811242331623;952.647520417443;960.7309953213112;965.8985806490323;967.8451447768358;1001.5092604623718;1006.6074231049896;1014.6600888702294;1019.8929112443197;1020.5356562763961;998.0119681515284;1002.4787110702393;1007.7480629842539;1012.2003617142485;1014.137982714694;726.3789460011667;731.9524230924973;735.1141874041767;739.4232498651061;742.1835980421547;13448.596542103753;13450.596482105553;13519.864801352058;13547.254900980442;13550;9300.441973481613;10828.945855270673;10953.397563134024;11052.447377631086;11376.772464550746;9480.24158067353;9564.617415303379;9610.567524461416;9784.070513301225;9990.9500452498;3465.8786942457145;3475.739319551044;3491.633378495272;3498.7201023918024;3500.247446798925;64340.67829660868;67392;69740;70696.6465167676;73794;8050.913126727934;9594.472304023346;9630.4703241321;9908.80182396348;10147.137493313003;20895.582088358147;20932.79067209339;21142.78857211439;21200.681989770164;21222.893885530782;6503.577267477599;7344.70621175147;7421.1094668639025;7465;7688.577128257888;3972.940405893914;4165.66674666026;4193.454850869368;4267.0825772459075;4280.481006609869;2768.9477998360494;3178.3643271345823;3201.2797120648133;3225.8064516129107;3228.5157226416227;538.6579522003556;563.9210510528529;569.0383252303594;569.9230603868425;572.3046498504254;500.22215454967875;509.9056674515227;510.94124175719526;542.1271752478507;552.2985808023788;8391.580420978926;8493.532855692873;8657.52383618907;8719.171678690514;8959.955200223958;550.3148580017903;558.9770719583153;589.8938191125638;602.5270162922085;614.2536817766435;3994.3009973254566;4033.858814941463;4067.5525692173837;4131.628153466202;4165.541790403053;89361.55319223362;89713.55143224372;90624;91098.54450727704;91513;64899.02651460138;74971.87542186871;81815.81867807708;83467.58266208631;83488;70376.29623703698;70716;71497;72504;72724;8728.738137855875;8762;8980.236679882284;9189.310801689766;9274.582643780912;39029;51902.74048629733;52079;52767.68080797857;54256;68389.31610684028;73190;74892;76350.61824690842;77553.61223193847;7921.128675845537;7930.365570754441;8012.479188852706;8128.471649342774;8379.58102094905;11983.34091624969;12181.39093045362;12201;12244.89795918336;12883.162594431707;11609;11801.52793888235;11838.644840654793;12103.75792484163;12165.817512737493;10202.234832387749;10594.152467802403;11641.59254426091;11797.76404471923;11811.291322520676;11515.769684606428;11538.076953843505;11567.652970410902;11628.360440175533;11704;9675.462240036668;9796.506571918233;9875.111239988435;10020.549075291776;10042.748931276776;8725.607347669244;9564.66523671668;9977.351472154287;10077.949610251902;10140.29017968735 11:13:14 INFO - 2015-11-19 11:13:14,647 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:13:14 INFO - 2015-11-19 11:13:14,648 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:13:14 INFO - 2015-11-19 11:13:14,648 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,321 11:13:14 INFO - 2015-11-19 11:13:14,648 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:13:14 INFO - 2015-11-19 11:13:14,648 DEBUG : BROWSER_OUTPUT: __startTimestamp1447960394633__endTimestamp 11:13:14 INFO - 2015-11-19 11:13:14,648 DEBUG : BROWSER_OUTPUT: 11:13:14 INFO - 2015-11-19 11:13:14,648 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:13:14 INFO - 2015-11-19 11:13:14,648 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:13:14 INFO - 2015-11-19 11:13:14,648 DEBUG : BROWSER_OUTPUT: 11:13:14 INFO - 2015-11-19 11:13:14,648 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5852.14 Median:6142.62 stddev:678.02 (11.0%) stddev-sans-first:637.30 11:13:14 INFO - 2015-11-19 11:13:14,648 DEBUG : BROWSER_OUTPUT: Values: 2829.8 2832.7 3529.9 3570.1 3570.7 5878.2 5963.2 6017.7 6033.2 6056.1 4345.2 5780.7 5807.3 5995.3 6000.6 5316.3 5350.8 5370.4 5407.3 5486.5 5356.0 5388.3 5401.9 5423.3 5425.3 5402.8 5428.3 5460.1 5472.7 5520.0 5135.0 5161.7 5282.4 5304.1 5403.1 5293.8 5326.8 5376.3 5386.0 5412.9 5656.3 5775.5 5864.1 5865.5 6015.0 5554.6 6142.6 6210.9 6272.7 6282.7 6334.1 6378.0 6384.2 6395.0 6476.1 5946.0 6085.3 6129.7 6143.6 6150.6 5050.6 6535.9 6545.1 6556.0 6559.0 6281.2 6282.6 6293.4 6298.5 6302.9 5727.9 5813.2 6208.2 6244.3 6401.3 6256.0 6263.8 6305.1 6328.6 6341.0 6310.0 6310.1 6315.3 6321.3 6324.7 4960.1 5058.5 5074.1 5124.1 5193.9 4599.8 4613.8 4616.1 4628.3 4644.7 5657.8 6145.2 6176.4 6186.2 6198.9 6190.9 6205.9 6275.3 6351.0 6374.2 6159.4 6163.4 6193.3 6206.0 6235.1 5433.4 5644.7 5651.0 5656.1 5700.8 6387.0 6458.5 6459.9 6483.6 6560.6 6338.3 6341.3 6354.7 6358.5 6374.9 6472.4 6493.4 6547.4 6551.3 6571.3 5178.8 5342.8 6218.0 6352.0 6378.3 5523.0 6380.9 6400.5 6403.0 6417.4 5633.1 6141.4 6280.6 6285.8 6291.8 6134.5 6183.0 6213.7 6228.2 6255.7 5438.6 5918.3 6057.6 6090.3 6141.8 5973.4 6094.0 6240.3 6252.2 6253.5 5226.7 6152.8 6232.1 6235.3 6241.5 11:13:14 INFO - 2015-11-19 11:13:14,648 DEBUG : BROWSER_OUTPUT: 11:13:14 INFO - 2015-11-19 11:13:14,648 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:70220.39 Median:41600.81 stddev:151423.69 (364.0%) stddev-sans-first:151758.06 11:13:14 INFO - 2015-11-19 11:13:14,650 DEBUG : BROWSER_OUTPUT: Values: 526.7 565.4 583.2 616.9 617.5 40837.0 41437.1 41577.6 41709.6 41753.2 44052.3 44409.8 44558.6 44688.3 44844.6 9664.0 9831.6 9832.8 9848.6 9850.6 9615.4 9646.2 9693.7 9717.7 9790.2 9645.3 9692.4 9696.4 9733.1 9785.9 9706.5 9724.5 9745.3 9760.4 9796.6 9589.4 9656.1 9729.8 9755.3 9771.4 33995.5 40929.4 40978.2 41067.8 41300.1 3251.5 3347.5 3407.8 3436.0 3798.7 28442.9 29292.6 30003.5 30007.4 30033.5 2258.0 2432.2 2498.2 2516.7 2608.0 499264.0 499302.0 511980.0 522815.0 677115.0 55214.7 55364.0 55408.6 55766.7 55953.7 56535.0 56999.4 57000.4 57713.7 57833.4 16348.8 16419.2 16567.3 16576.4 16769.2 12699.3 12832.9 12872.6 12947.2 12972.2 19775.6 20108.2 20116.6 20140.4 20142.8 7952.2 8087.2 8129.0 8129.4 8192.2 999.4 1034.3 1055.3 1075.8 1130.9 24506.4 27246.7 30176.9 30772.0 30795.1 893.5 1007.2 1114.8 1183.2 1195.8 15353.8 15641.1 15691.6 15748.1 16537.3 659262.0 659521.0 660079.0 660398.0 672986.0 62448.8 62891.7 62903.0 62919.0 63152.1 1416.8 1445.2 1451.5 1468.2 1472.9 30528.1 30664.1 30681.0 30819.0 30872.2 54402.7 54702.5 54789.7 54941.7 54967.0 474602.0 476380.0 477007.0 477850.0 478233.0 35159.3 47910.8 48069.0 49605.0 49770.5 46474.5 47055.8 47064.1 47150.3 47647.0 38906.1 39240.8 40487.6 40775.0 41624.0 38617.0 38934.8 39193.0 39223.6 39847.8 38611.8 38669.6 38716.8 38758.6 39001.0 28111.9 33634.7 34431.3 34721.7 34853.0 21292.9 25544.1 25971.0 26203.7 26270.9 11:13:14 INFO - 2015-11-19 11:13:14,650 DEBUG : BROWSER_OUTPUT: 11:13:14 INFO - 2015-11-19 11:13:14,650 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:37848.79 Median:2413.10 stddev:130840.06 (5422.1%) stddev-sans-first:131176.75 11:13:14 INFO - 2015-11-19 11:13:14,652 DEBUG : BROWSER_OUTPUT: Values: 322.4 356.5 364.9 365.3 366.7 16357.0 20027.0 20089.6 20506.3 21177.8 19993.0 20171.7 20545.0 20576.0 21270.5 5649.8 5756.2 5787.5 5804.4 5825.7 4857.3 4990.2 4997.6 5000.6 5987.9 4701.1 4886.7 4903.3 4911.2 4912.7 4382.6 4847.3 4920.4 4921.2 4950.7 4135.5 4164.5 4181.2 4235.8 4277.0 13725.9 13876.7 13920.1 14022.9 14238.9 1881.6 1943.7 1952.9 2052.7 2138.4 10108.7 10230.4 10236.4 10321.2 10352.3 1560.4 1578.0 1589.7 1595.7 1609.3 92723.0 95962.0 96899.0 97098.0 97180.0 6678.7 6770.1 6770.2 6787.6 6822.1 7589.9 7681.8 7694.1 7736.8 7764.7 5685.7 5690.2 5716.9 5726.1 5738.4 6186.4 6198.8 6216.5 6220.7 6249.4 2819.4 3006.3 3008.5 3041.4 3048.6 985.7 1080.7 1084.8 1098.2 1122.4 443.6 453.1 460.5 478.8 486.2 11367.6 12390.9 12414.5 12572.0 12634.4 437.3 480.4 482.2 483.8 491.8 6681.3 6693.3 6748.7 6769.2 6802.4 778356.0 784487.0 789052.0 803608.0 812184.0 114741.0 115827.8 118059.4 120210.0 122444.2 517.9 520.7 523.4 524.4 525.7 11059.6 11844.2 11967.7 11972.0 12043.0 42378.0 55188.2 55482.7 55525.4 55577.4 77097.0 77727.6 77825.2 78713.0 79021.0 6419.8 6464.2 6469.8 6505.9 6510.4 10530.1 10769.2 12086.2 12570.8 12679.7 9981.0 10650.0 10884.3 10956.2 11026.7 10624.4 10639.2 10644.3 10854.0 10921.7 10874.0 11077.7 11084.4 11143.1 11176.4 6331.4 6337.5 6457.7 6472.2 6482.0 10801.8 10820.4 11035.6 11037.2 11189.0 11:13:14 INFO - 2015-11-19 11:13:14,652 DEBUG : BROWSER_OUTPUT: 11:13:14 INFO - 2015-11-19 11:13:14,652 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5789.97 Median:5737.27 stddev:2971.64 (51.8%) stddev-sans-first:2962.45 11:13:14 INFO - 2015-11-19 11:13:14,652 DEBUG : BROWSER_OUTPUT: Values: 1497.2 1536.1 1797.1 1886.6 1895.3 7562.7 7629.6 8104.7 8258.0 8281.5 7835.7 8170.1 8323.5 8366.6 8380.4 2327.1 2366.5 2368.3 2370.8 2374.5 2072.7 2377.4 2396.1 2412.6 2425.3 2341.6 2360.9 2379.4 2382.4 2395.2 1993.7 2351.7 2378.0 2379.8 2387.8 2382.8 2383.0 2403.8 2412.2 2427.0 7095.5 8344.8 8353.6 8418.6 8450.2 5132.9 5223.4 5230.2 5234.8 5242.3 3471.2 3547.8 3548.8 3559.1 3598.8 1047.5 1063.4 1068.3 1081.5 1083.6 11077.3 11102.7 11104.2 11122.9 11148.3 4679.8 4690.9 4727.2 4736.1 4748.9 9571.9 9630.1 9638.8 9644.8 9674.7 5198.8 5207.1 5208.1 5224.7 5225.6 4291.2 4366.6 4635.3 4739.1 4750.0 3860.8 3898.1 3912.7 3926.5 3963.3 1279.4 1286.9 1295.4 1296.1 1297.7 1140.3 1144.9 1157.8 1159.0 1163.2 7834.1 7864.6 7894.8 7929.3 7933.4 1209.8 1209.9 1210.5 1213.1 1230.5 6232.3 6277.8 6283.5 6320.7 6342.4 8366.9 10100.7 10100.8 10138.7 10185.3 9722.5 9973.7 9985.6 10041.6 10061.2 7862.3 7866.5 7901.6 7920.5 7957.8 7437.7 7494.3 7535.5 7540.7 7562.9 8876.6 8937.2 9029.3 9073.1 9201.3 9248.0 9337.3 9369.1 9396.7 9422.7 6332.5 6423.8 6761.7 6893.3 6955.2 6756.7 7875.7 7876.6 7941.4 7949.7 7325.2 7424.4 7455.7 7557.1 7603.1 7209.2 7375.1 7434.1 7442.0 7464.3 6392.3 7457.7 7493.1 7512.7 7516.8 6795.0 6834.8 6864.0 6870.2 6885.5 6922.9 6945.5 6962.7 6972.6 6978.2 11:13:14 INFO - 2015-11-19 11:13:14,652 DEBUG : BROWSER_OUTPUT: 11:13:14 INFO - 2015-11-19 11:13:14,653 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5991.87 Median:6727.49 stddev:1957.27 (29.1%) stddev-sans-first:1915.86 11:13:14 INFO - 2015-11-19 11:13:14,654 DEBUG : BROWSER_OUTPUT: Values: 317.2 320.4 324.9 327.1 331.4 6297.8 6775.3 6922.9 6982.5 6991.0 6094.8 6135.6 6181.5 6351.1 6359.8 4109.6 5104.4 5113.1 5115.2 5145.3 4137.8 5143.4 5144.0 5154.1 5166.1 4810.5 4963.8 4966.8 4981.4 4995.2 4962.1 4971.9 4981.7 4985.7 4995.3 3992.8 4059.7 4099.5 4182.9 4190.0 6112.0 6135.7 6580.8 6626.7 6679.7 5878.3 5884.6 5900.3 5911.3 5934.4 5931.5 7228.6 7342.8 7357.2 7377.0 4791.4 4807.2 4814.8 4858.5 4874.2 7814.0 7891.1 7894.8 7908.8 7920.6 4758.5 4936.0 4954.7 4960.9 4966.1 5038.0 5042.7 5046.4 5047.6 5061.8 4873.1 5936.9 5964.8 5974.7 5994.8 6137.7 7423.3 7428.6 7446.6 7472.2 1418.4 1454.7 1731.3 1741.9 1742.0 931.0 1119.5 1132.2 1132.3 1132.4 6969.9 6976.2 6978.5 6984.4 7067.2 7683.5 7711.5 7713.2 7723.3 7734.1 5702.0 6849.7 6919.0 6938.8 7022.4 3202.6 4034.5 4069.4 4121.0 4123.6 7864.3 8014.5 8072.8 8079.9 8116.7 8005.5 8020.6 8022.6 8029.6 8090.2 7060.8 7805.4 8065.0 8086.0 8091.4 7618.2 7770.3 7770.4 7786.4 7801.6 7288.7 7581.4 7591.7 7599.6 7635.8 6474.5 7045.7 7553.0 8042.0 8061.8 4687.7 4792.9 4803.2 4822.8 4835.7 7182.1 7576.1 7655.3 7814.9 7850.3 7464.8 7466.3 7471.4 7479.5 7497.1 6818.9 7416.6 7433.6 7480.2 7496.3 5955.6 6607.3 7054.7 7308.9 7350.8 7470.9 7483.2 7491.8 7495.6 7511.5 7141.4 7325.4 7339.7 7362.4 7377.7 11:13:14 INFO - 2015-11-19 11:13:14,654 DEBUG : BROWSER_OUTPUT: 11:13:14 INFO - 2015-11-19 11:13:14,654 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18004.54 Median:561.45 stddev:25340.44 (4513.4%) stddev-sans-first:25378.13 11:13:14 INFO - 2015-11-19 11:13:14,655 DEBUG : BROWSER_OUTPUT: Values: 678.6 735.3 780.1 801.2 812.6 14738.7 14939.3 15059.7 15076.0 15104.5 13890.2 13956.0 14015.2 14498.8 14526.9 944.3 945.1 958.3 968.7 971.9 952.2 952.6 960.7 965.9 967.8 1001.5 1006.6 1014.7 1019.9 1020.5 998.0 1002.5 1007.7 1012.2 1014.1 726.4 732.0 735.1 739.4 742.2 13448.6 13450.6 13519.9 13547.3 13550.0 9300.4 10828.9 10953.4 11052.4 11376.8 9480.2 9564.6 9610.6 9784.1 9991.0 3465.9 3475.7 3491.6 3498.7 3500.2 64340.7 67392.0 69740.0 70696.6 73794.0 8050.9 9594.5 9630.5 9908.8 10147.1 20895.6 20932.8 21142.8 21200.7 21222.9 6503.6 7344.7 7421.1 7465.0 7688.6 3972.9 4165.7 4193.5 4267.1 4280.5 2768.9 3178.4 3201.3 3225.8 3228.5 538.7 563.9 569.0 569.9 572.3 500.2 509.9 510.9 542.1 552.3 8391.6 8493.5 8657.5 8719.2 8960.0 550.3 559.0 589.9 602.5 614.3 3994.3 4033.9 4067.6 4131.6 4165.5 89361.6 89713.6 90624.0 91098.5 91513.0 64899.0 74971.9 81815.8 83467.6 83488.0 70376.3 70716.0 71497.0 72504.0 72724.0 8728.7 8762.0 8980.2 9189.3 9274.6 39029.0 51902.7 52079.0 52767.7 54256.0 68389.3 73190.0 74892.0 76350.6 77553.6 7921.1 7930.4 8012.5 8128.5 8379.6 11983.3 12181.4 12201.0 12244.9 12883.2 11609.0 11801.5 11838.6 12103.8 12165.8 10202.2 10594.2 11641.6 11797.8 11811.3 11515.8 11538.1 11567.7 11628.4 11704.0 9675.5 9796.5 9875.1 10020.5 10042.7 8725.6 9564.7 9977.4 10077.9 10140.3 11:13:14 INFO - 2015-11-19 11:13:14,655 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:13:14 INFO - 2015-11-19 11:13:14,655 DEBUG : BROWSER_OUTPUT: 11:13:15 INFO - 2015-11-19 11:13:15,123 INFO : Browser exited with error code: 0 11:13:15 INFO - 2015-11-19 11:13:15,147 INFO : Completed test dromaeo_css (00:18:30) 11:13:15 INFO - 2015-11-19 11:13:15,147 INFO : Starting test kraken 11:13:15 INFO - 2015-11-19 11:13:15,147 DEBUG : operating with platform_type : mac_ 11:13:15 INFO - 2015-11-19 11:13:15,147 INFO : Initialising browser for kraken test... 11:13:15 INFO - 2015-11-19 11:13:15,159 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpP9GN8v/profile http://localhost:49500/getInfo.html 11:13:17 INFO - 2015-11-19 11:13:17,839 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:13:17 INFO - 2015-11-19 11:13:17,839 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:13:17 INFO - 2015-11-19 11:13:17,839 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:13:17 INFO - 2015-11-19 11:13:17,839 DEBUG : BROWSER_OUTPUT: __metrics 11:13:18 INFO - 2015-11-19 11:13:18,444 INFO : Browser initialized. 11:13:18 INFO - 2015-11-19 11:13:18,445 INFO : Running cycle 1/1 for kraken test... 11:13:18 INFO - 2015-11-19 11:13:18,445 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpP9GN8v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:13:30 INFO - 2015-11-19 11:13:30,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 236859392 11:13:30 INFO - 2015-11-19 11:13:30,448 DEBUG : BROWSER_OUTPUT: 11:13:33 INFO - 2015-11-19 11:13:33,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49500/tests/kraken/driver.html?testName=audio-beat-detection) 11:13:34 INFO - 2015-11-19 11:13:34,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 248365056 11:13:34 INFO - 2015-11-19 11:13:34,095 DEBUG : BROWSER_OUTPUT: 11:13:36 INFO - 2015-11-19 11:13:36,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49500/tests/kraken/driver.html?testName=audio-dft) 11:13:37 INFO - 2015-11-19 11:13:37,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 259297280 11:13:37 INFO - 2015-11-19 11:13:37,272 DEBUG : BROWSER_OUTPUT: 11:13:40 INFO - 2015-11-19 11:13:40,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49500/tests/kraken/driver.html?testName=audio-fft) 11:13:41 INFO - 2015-11-19 11:13:41,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 260653056 11:13:41 INFO - 2015-11-19 11:13:41,168 DEBUG : BROWSER_OUTPUT: 11:13:43 INFO - 2015-11-19 11:13:43,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49500/tests/kraken/driver.html?testName=audio-oscillator) 11:13:43 INFO - 2015-11-19 11:13:43,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 263004160 11:13:43 INFO - 2015-11-19 11:13:43,656 DEBUG : BROWSER_OUTPUT: 11:13:45 INFO - 2015-11-19 11:13:45,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49500/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:13:46 INFO - 2015-11-19 11:13:46,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 263106560 11:13:46 INFO - 2015-11-19 11:13:46,161 DEBUG : BROWSER_OUTPUT: 11:13:49 INFO - 2015-11-19 11:13:49,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49500/tests/kraken/driver.html?testName=imaging-darkroom) 11:13:49 INFO - 2015-11-19 11:13:49,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 263507968 11:13:49 INFO - 2015-11-19 11:13:49,705 DEBUG : BROWSER_OUTPUT: 11:13:52 INFO - 2015-11-19 11:13:52,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49500/tests/kraken/driver.html?testName=imaging-desaturate) 11:13:53 INFO - 2015-11-19 11:13:53,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 263405568 11:13:53 INFO - 2015-11-19 11:13:53,531 DEBUG : BROWSER_OUTPUT: 11:13:56 INFO - 2015-11-19 11:13:56,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49500/tests/kraken/driver.html?testName=json-parse-financial) 11:13:57 INFO - 2015-11-19 11:13:57,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 263577600 11:13:57 INFO - 2015-11-19 11:13:57,012 DEBUG : BROWSER_OUTPUT: 11:13:58 INFO - 2015-11-19 11:13:58,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49500/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:13:59 INFO - 2015-11-19 11:13:59,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 264609792 11:13:59 INFO - 2015-11-19 11:13:59,092 DEBUG : BROWSER_OUTPUT: 11:14:01 INFO - 2015-11-19 11:14:01,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49500/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:14:01 INFO - 2015-11-19 11:14:01,664 DEBUG : BROWSER_OUTPUT: RSS: Main: 264290304 11:14:01 INFO - 2015-11-19 11:14:01,665 DEBUG : BROWSER_OUTPUT: 11:14:03 INFO - 2015-11-19 11:14:03,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49500/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:14:04 INFO - 2015-11-19 11:14:04,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 264986624 11:14:04 INFO - 2015-11-19 11:14:04,277 DEBUG : BROWSER_OUTPUT: 11:14:06 INFO - 2015-11-19 11:14:06,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:14:07 INFO - 2015-11-19 11:14:07,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 264974336 11:14:07 INFO - 2015-11-19 11:14:07,417 DEBUG : BROWSER_OUTPUT: 11:14:09 INFO - 2015-11-19 11:14:09,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:14:10 INFO - 2015-11-19 11:14:10,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 264724480 11:14:10 INFO - 2015-11-19 11:14:10,437 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49500/tests/kraken/driver.html?testName=ai-astar) 11:14:12 INFO - 2015-11-19 11:14:12,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 264785920 11:14:12 INFO - 2015-11-19 11:14:12,308 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,309 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:14:12 INFO - 2015-11-19 11:14:12,309 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:14:12 INFO - 2015-11-19 11:14:12,309 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:14:12 INFO - 2015-11-19 11:14:12,309 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:14:12 INFO - 2015-11-19 11:14:12,309 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;105;163;164;94;173;169;150;115;114 11:14:12 INFO - 2015-11-19 11:14:12,309 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;142;125;144;161;150;140;138;121;155;125 11:14:12 INFO - 2015-11-19 11:14:12,310 DEBUG : BROWSER_OUTPUT: |2;audio-dft;190;206;261;222;196;194;199;195;203;197 11:14:12 INFO - 2015-11-19 11:14:12,310 DEBUG : BROWSER_OUTPUT: |3;audio-fft;63;62;61;129;81;81;50;59;65;77 11:14:12 INFO - 2015-11-19 11:14:12,311 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;78;75;104;76;78;78;105;77;77;109 11:14:12 INFO - 2015-11-19 11:14:12,311 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;133;97;90;88;76;85;124;133;132;88 11:14:12 INFO - 2015-11-19 11:14:12,311 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;134;151;133;105;152;102;138;150;95;96 11:14:12 INFO - 2015-11-19 11:14:12,311 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;91;91;112;120;95;92;90;89;145;128 11:14:12 INFO - 2015-11-19 11:14:12,311 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;57;56;58;57;59;66;56;56 11:14:12 INFO - 2015-11-19 11:14:12,311 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;65;65;66;91;106;103;103;76;70 11:14:12 INFO - 2015-11-19 11:14:12,311 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;77;84;82;84;86;84;84;83;84 11:14:12 INFO - 2015-11-19 11:14:12,311 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;134;122;132;128;122;125;133;121;119;123 11:14:12 INFO - 2015-11-19 11:14:12,311 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;143;144;139;136;143;146;133;138;139 11:14:12 INFO - 2015-11-19 11:14:12,311 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;66;67;76;67;65;66;67;66;65 11:14:12 INFO - 2015-11-19 11:14:12,311 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:14:12 INFO - 2015-11-19 11:14:12,311 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:14:12 INFO - 2015-11-19 11:14:12,311 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,816 11:14:12 INFO - 2015-11-19 11:14:12,312 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:14:12 INFO - 2015-11-19 11:14:12,312 DEBUG : BROWSER_OUTPUT: __startTimestamp1447960452308__endTimestamp 11:14:12 INFO - 2015-11-19 11:14:12,312 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,314 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:14:12 INFO - 2015-11-19 11:14:12,314 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:14:12 INFO - 2015-11-19 11:14:12,314 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,314 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:136.20 Median:163.50 stddev:30.29 (18.5%) stddev-sans-first:31.14 11:14:12 INFO - 2015-11-19 11:14:12,314 DEBUG : BROWSER_OUTPUT: Values: 115.0 105.0 163.0 164.0 94.0 173.0 169.0 150.0 115.0 114.0 11:14:12 INFO - 2015-11-19 11:14:12,314 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,314 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.10 Median:143.00 stddev:13.34 (9.3%) stddev-sans-first:14.13 11:14:12 INFO - 2015-11-19 11:14:12,314 DEBUG : BROWSER_OUTPUT: Values: 142.0 125.0 144.0 161.0 150.0 140.0 138.0 121.0 155.0 125.0 11:14:12 INFO - 2015-11-19 11:14:12,314 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,314 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:206.30 Median:201.00 stddev:21.19 (10.5%) stddev-sans-first:21.64 11:14:12 INFO - 2015-11-19 11:14:12,314 DEBUG : BROWSER_OUTPUT: Values: 190.0 206.0 261.0 222.0 196.0 194.0 199.0 195.0 203.0 197.0 11:14:12 INFO - 2015-11-19 11:14:12,315 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,315 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:72.80 Median:64.00 stddev:22.20 (34.7%) stddev-sans-first:23.26 11:14:12 INFO - 2015-11-19 11:14:12,315 DEBUG : BROWSER_OUTPUT: Values: 63.0 62.0 61.0 129.0 81.0 81.0 50.0 59.0 65.0 77.0 11:14:12 INFO - 2015-11-19 11:14:12,315 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,315 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:85.70 Median:77.00 stddev:14.10 (18.3%) stddev-sans-first:14.67 11:14:12 INFO - 2015-11-19 11:14:12,315 DEBUG : BROWSER_OUTPUT: Values: 78.0 75.0 104.0 76.0 78.0 78.0 105.0 77.0 77.0 109.0 11:14:12 INFO - 2015-11-19 11:14:12,315 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,315 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:104.60 Median:86.50 stddev:23.01 (26.6%) stddev-sans-first:21.99 11:14:12 INFO - 2015-11-19 11:14:12,315 DEBUG : BROWSER_OUTPUT: Values: 133.0 97.0 90.0 88.0 76.0 85.0 124.0 133.0 132.0 88.0 11:14:12 INFO - 2015-11-19 11:14:12,315 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,315 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:125.60 Median:150.50 stddev:23.59 (15.7%) stddev-sans-first:24.83 11:14:12 INFO - 2015-11-19 11:14:12,316 DEBUG : BROWSER_OUTPUT: Values: 134.0 151.0 133.0 105.0 152.0 102.0 138.0 150.0 95.0 96.0 11:14:12 INFO - 2015-11-19 11:14:12,316 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,317 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:105.30 Median:90.50 stddev:19.84 (21.9%) stddev-sans-first:20.36 11:14:12 INFO - 2015-11-19 11:14:12,317 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 112.0 120.0 95.0 92.0 90.0 89.0 145.0 128.0 11:14:12 INFO - 2015-11-19 11:14:12,317 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,317 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:2.97 (5.1%) stddev-sans-first:3.14 11:14:12 INFO - 2015-11-19 11:14:12,317 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 57.0 56.0 58.0 57.0 59.0 66.0 56.0 56.0 11:14:12 INFO - 2015-11-19 11:14:12,317 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,318 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:81.20 Median:66.50 stddev:17.55 (26.4%) stddev-sans-first:17.85 11:14:12 INFO - 2015-11-19 11:14:12,318 DEBUG : BROWSER_OUTPUT: Values: 67.0 65.0 65.0 66.0 91.0 106.0 103.0 103.0 76.0 70.0 11:14:12 INFO - 2015-11-19 11:14:12,318 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,318 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.00 stddev:2.45 (2.9%) stddev-sans-first:2.52 11:14:12 INFO - 2015-11-19 11:14:12,318 DEBUG : BROWSER_OUTPUT: Values: 85.0 77.0 84.0 82.0 84.0 86.0 84.0 84.0 83.0 84.0 11:14:12 INFO - 2015-11-19 11:14:12,318 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,318 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:126.50 stddev:5.47 (4.3%) stddev-sans-first:4.95 11:14:12 INFO - 2015-11-19 11:14:12,318 DEBUG : BROWSER_OUTPUT: Values: 134.0 122.0 132.0 128.0 122.0 125.0 133.0 121.0 119.0 123.0 11:14:12 INFO - 2015-11-19 11:14:12,318 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,318 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.80 Median:141.00 stddev:4.08 (2.9%) stddev-sans-first:4.20 11:14:12 INFO - 2015-11-19 11:14:12,318 DEBUG : BROWSER_OUTPUT: Values: 137.0 143.0 144.0 139.0 136.0 143.0 146.0 133.0 138.0 139.0 11:14:12 INFO - 2015-11-19 11:14:12,318 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,318 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:66.50 stddev:3.27 (4.9%) stddev-sans-first:3.38 11:14:12 INFO - 2015-11-19 11:14:12,319 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 67.0 76.0 67.0 65.0 66.0 67.0 66.0 65.0 11:14:12 INFO - 2015-11-19 11:14:12,319 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:14:12 INFO - 2015-11-19 11:14:12,319 DEBUG : BROWSER_OUTPUT: 11:14:12 INFO - 2015-11-19 11:14:12,926 INFO : Browser exited with error code: 0 11:14:12 INFO - 2015-11-19 11:14:12,972 INFO : Completed test kraken (00:00:57) 11:14:12 INFO - 2015-11-19 11:14:12,972 INFO : Starting test v8_7 11:14:12 INFO - 2015-11-19 11:14:12,973 DEBUG : operating with platform_type : mac_ 11:14:12 INFO - 2015-11-19 11:14:12,973 INFO : Initialising browser for v8_7 test... 11:14:12 INFO - 2015-11-19 11:14:12,984 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpcU6GOp/profile http://localhost:49500/getInfo.html 11:14:15 INFO - 2015-11-19 11:14:15,613 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:14:15 INFO - 2015-11-19 11:14:15,613 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:14:15 INFO - 2015-11-19 11:14:15,613 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:14:15 INFO - 2015-11-19 11:14:15,613 DEBUG : BROWSER_OUTPUT: __metrics 11:14:16 INFO - 2015-11-19 11:14:16,338 INFO : Browser initialized. 11:14:16 INFO - 2015-11-19 11:14:16,338 INFO : Running cycle 1/1 for v8_7 test... 11:14:16 INFO - 2015-11-19 11:14:16,338 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpcU6GOp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:14:28 INFO - 2015-11-19 11:14:28,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 237228032 11:14:28 INFO - 2015-11-19 11:14:28,192 DEBUG : BROWSER_OUTPUT: 11:14:49 INFO - 2015-11-19 11:14:49,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49500/tests/v8_7/run.html (next: http://localhost:49500/tests/v8_7/run.html) 11:14:49 INFO - 2015-11-19 11:14:49,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 246927360 11:14:49 INFO - 2015-11-19 11:14:49,808 DEBUG : BROWSER_OUTPUT: 11:14:49 INFO - 2015-11-19 11:14:49,808 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:14:49 INFO - 2015-11-19 11:14:49,808 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:14:49 INFO - 2015-11-19 11:14:49,808 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:14:49 INFO - 2015-11-19 11:14:49,808 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:14:49 INFO - 2015-11-19 11:14:49,808 DEBUG : BROWSER_OUTPUT: |0;Richards;642.2607578676943 11:14:49 INFO - 2015-11-19 11:14:49,808 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;155.1590380139643 11:14:49 INFO - 2015-11-19 11:14:49,808 DEBUG : BROWSER_OUTPUT: |2;Encrypt;291.97080291970804 11:14:49 INFO - 2015-11-19 11:14:49,808 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4873.78640776699 11:14:49 INFO - 2015-11-19 11:14:49,808 DEBUG : BROWSER_OUTPUT: |4;RayTrace;946.969696969697 11:14:49 INFO - 2015-11-19 11:14:49,808 DEBUG : BROWSER_OUTPUT: |5;Earley;820.3445447087777 11:14:49 INFO - 2015-11-19 11:14:49,808 DEBUG : BROWSER_OUTPUT: |6;Boyer;12948.71794871795 11:14:49 INFO - 2015-11-19 11:14:49,808 DEBUG : BROWSER_OUTPUT: |7;RegExp;26763.157894736843 11:14:49 INFO - 2015-11-19 11:14:49,808 DEBUG : BROWSER_OUTPUT: |8;Splay;710.9540636042403 11:14:49 INFO - 2015-11-19 11:14:49,809 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4538.461538461538 11:14:49 INFO - 2015-11-19 11:14:49,809 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:14:49 INFO - 2015-11-19 11:14:49,809 DEBUG : BROWSER_OUTPUT: __startTimestamp1447960489804__endTimestamp 11:14:49 INFO - 2015-11-19 11:14:49,809 DEBUG : BROWSER_OUTPUT: 11:14:49 INFO - 2015-11-19 11:14:49,809 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:14:49 INFO - 2015-11-19 11:14:49,809 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:14:49 INFO - 2015-11-19 11:14:49,809 DEBUG : BROWSER_OUTPUT: 11:14:49 INFO - 2015-11-19 11:14:49,809 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:642.26 Median:642.26 stddev:0.00 (0.0%) 11:14:49 INFO - 2015-11-19 11:14:49,809 DEBUG : BROWSER_OUTPUT: Values: 642.3 11:14:49 INFO - 2015-11-19 11:14:49,809 DEBUG : BROWSER_OUTPUT: 11:14:49 INFO - 2015-11-19 11:14:49,809 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:155.16 Median:155.16 stddev:0.00 (0.0%) 11:14:49 INFO - 2015-11-19 11:14:49,809 DEBUG : BROWSER_OUTPUT: Values: 155.2 11:14:49 INFO - 2015-11-19 11:14:49,809 DEBUG : BROWSER_OUTPUT: 11:14:49 INFO - 2015-11-19 11:14:49,810 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:291.97 Median:291.97 stddev:0.00 (0.0%) 11:14:49 INFO - 2015-11-19 11:14:49,810 DEBUG : BROWSER_OUTPUT: Values: 292.0 11:14:49 INFO - 2015-11-19 11:14:49,810 DEBUG : BROWSER_OUTPUT: 11:14:49 INFO - 2015-11-19 11:14:49,810 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4873.79 Median:4873.79 stddev:0.00 (0.0%) 11:14:49 INFO - 2015-11-19 11:14:49,810 DEBUG : BROWSER_OUTPUT: Values: 4873.8 11:14:49 INFO - 2015-11-19 11:14:49,810 DEBUG : BROWSER_OUTPUT: 11:14:49 INFO - 2015-11-19 11:14:49,810 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:946.97 Median:946.97 stddev:0.00 (0.0%) 11:14:49 INFO - 2015-11-19 11:14:49,810 DEBUG : BROWSER_OUTPUT: Values: 947.0 11:14:49 INFO - 2015-11-19 11:14:49,810 DEBUG : BROWSER_OUTPUT: 11:14:49 INFO - 2015-11-19 11:14:49,810 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:820.34 Median:820.34 stddev:0.00 (0.0%) 11:14:49 INFO - 2015-11-19 11:14:49,810 DEBUG : BROWSER_OUTPUT: Values: 820.3 11:14:49 INFO - 2015-11-19 11:14:49,810 DEBUG : BROWSER_OUTPUT: 11:14:49 INFO - 2015-11-19 11:14:49,811 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12948.72 Median:12948.72 stddev:0.00 (0.0%) 11:14:49 INFO - 2015-11-19 11:14:49,811 DEBUG : BROWSER_OUTPUT: Values: 12948.7 11:14:49 INFO - 2015-11-19 11:14:49,811 DEBUG : BROWSER_OUTPUT: 11:14:49 INFO - 2015-11-19 11:14:49,811 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26763.16 Median:26763.16 stddev:0.00 (0.0%) 11:14:49 INFO - 2015-11-19 11:14:49,811 DEBUG : BROWSER_OUTPUT: Values: 26763.2 11:14:49 INFO - 2015-11-19 11:14:49,811 DEBUG : BROWSER_OUTPUT: 11:14:49 INFO - 2015-11-19 11:14:49,811 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:710.95 Median:710.95 stddev:0.00 (0.0%) 11:14:49 INFO - 2015-11-19 11:14:49,811 DEBUG : BROWSER_OUTPUT: Values: 711.0 11:14:49 INFO - 2015-11-19 11:14:49,811 DEBUG : BROWSER_OUTPUT: 11:14:49 INFO - 2015-11-19 11:14:49,811 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4538.46 Median:4538.46 stddev:0.00 (0.0%) 11:14:49 INFO - 2015-11-19 11:14:49,811 DEBUG : BROWSER_OUTPUT: Values: 4538.5 11:14:49 INFO - 2015-11-19 11:14:49,811 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:14:49 INFO - 2015-11-19 11:14:49,811 DEBUG : BROWSER_OUTPUT: 11:14:50 INFO - 2015-11-19 11:14:50,553 INFO : Browser exited with error code: 0 11:14:50 INFO - 2015-11-19 11:14:50,570 INFO : Completed test v8_7 (00:00:37) 11:14:50 INFO - 2015-11-19 11:14:50,903 INFO : Completed test suite (00:20:06) 11:14:50 INFO - 2015-11-19 11:14:50,903 DEBUG : Working with test: dromaeo_css 11:14:50 INFO - 2015-11-19 11:14:50,903 DEBUG : Generating results file: dromaeo_css 11:14:50 INFO - 2015-11-19 11:14:50,904 DEBUG : Working with test: kraken 11:14:50 INFO - 2015-11-19 11:14:50,904 DEBUG : Generating results file: kraken 11:14:50 INFO - 2015-11-19 11:14:50,904 INFO : javascript benchmark 11:14:50 INFO - 2015-11-19 11:14:50,904 DEBUG : Working with test: v8_7 11:14:50 INFO - 2015-11-19 11:14:50,904 DEBUG : Generating results file: v8_7 11:14:50 INFO - 2015-11-19 11:14:50,905 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:14:51 INFO - 2015-11-19 11:14:51,432 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 11:14:51 INFO - 2015-11-19 11:14:51,432 DEBUG : process_Request line: dromaeo_css 7326.42 graph.html#tests=[[72,64,61]] 11:14:51 INFO - 2015-11-19 11:14:51,432 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:14:51 INFO - 2015-11-19 11:14:51,462 DEBUG : process_Request line: kraken 1532.00 graph.html#tests=[[232,64,61]] 11:14:51 INFO - 2015-11-19 11:14:51,462 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:14:51 INFO - 2015-11-19 11:14:51,487 DEBUG : process_Request line: v8_7 18654.65 graph.html#tests=[[230,64,61]] 11:14:51 INFO - 2015-11-19 11:14:51,488 INFO : javascript benchmark 11:14:51 INFO - 2015-11-19 11:14:51,490 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2829.787765917556, 2832.745052945235, 3529.94705079424, 3570.0896271450774, 3570.696490798282, 5878.23582934219, 5963.165156878041, 6017.729202185901, 6033.1855199548045, 6056.121862329959, 4345.217860785057, 5780.72823978724, 5807.332156801969, 5995.310539287983, 6000.639961602307, 5316.282301889234, 5350.759215835277, 5370.43610420906, 5407.324084489439, 5486.533644640211, 5355.98236335095, 5388.326459192601, 5401.864953376177, 5423.3491980962335, 5425.348958125031, 5402.8109016184635, 5428.348598168205, 5460.071787796064, 5472.72636368182, 5519.972400138014, 5134.973005398935, 5161.66449180802, 5282.392524859613, 5304.098303288451, 5403.108487099624, 5293.788248470057, 5326.813561525367, 5376.301080859464, 5385.973070134663, 5412.864678383033, 5656.2929633795775, 5775.451332123442, 5864.06175011996, 5865.530757539386, 6015.0375939849855, 5554.611177217596, 6142.617910970041, 6210.937890621081, 6272.65500397478, 6282.685865706742, 6334.113224148623, 6377.968110159466, 6384.233891932998, 6395.0, 6476.060971159155, 5946.0, 6085.330613632497, 6129.69351532426, 6143.600665956698, 6150.569460137792, 5050.570701490415, 6535.901961470582, 6545.083688283644, 6556.049372840911, 6559.048937903977, 6281.2462504498835, 6282.560220784592, 6293.402126797947, 6298.527610429236, 6302.905456418157, 5727.8854422912145, 5813.215215945793, 6208.161898143783, 6244.313125556185, 6401.295857455676, 6256.0, 6263.78076767311, 6305.054241863665, 6328.6202827830475, 6340.968295158495, 6309.968450157719, 6310.116583678288, 6315.273743519462, 6321.304656487782, 6324.683765811691, 4960.107180707508, 5058.54473097423, 5074.06129865976, 5124.103281925648, 5193.896122077537, 4599.816007359668, 4613.815447382134, 4616.053708989649, 4628.282616194495, 4644.651651126179, 5657.80197693087, 6145.201123853871, 6176.382361763877, 6186.226721659793, 6198.938010619836, 6190.907136392958, 6205.906911396332, 6275.309715931244, 6351.0, 6374.203224596926, 6159.4456498915315, 6163.3836616338, 6193.287771906288, 6206.007038873759, 6235.064740288993, 5433.375161856358, 5644.689542075143, 5651.0, 5656.123300888369, 5700.7719691212715, 6387.0, 6458.483321334282, 6459.9031014533875, 6483.610983341015, 6560.573562718408, 6338.271098823509, 6341.302456729848, 6354.6822658867795, 6358.491320694241, 6374.90437643445, 6472.417482426604, 6493.383128602775, 6547.443467305332, 6551.344865513411, 6571.34286571339, 5178.818741344035, 5342.839714808562, 6218.0, 6352.0, 6378.33027532121, 5522.978249023943, 6380.904286435614, 6400.51996100285, 6402.9679851602305, 6417.422431981144, 5633.126865335879, 6141.42463864406, 6280.591761535486, 6285.779997700059, 6291.779787707408, 6134.478569321479, 6183.0, 6213.65824879636, 6228.190335256388, 6255.655938923403, 5438.619296649196, 5918.2898052232285, 6057.606255593372, 6090.299615544269, 6141.815745527641, 5973.402659733992, 6093.957602078378, 6240.344763799736, 6252.249730032425, 6253.499720022478, 5226.712530810842, 6152.7538898445355, 6232.065190221503, 6235.251769787655, 6241.500679945684], "unit": "ms", "name": "dojo.html", "value": 5809.687531610135}, {"lowerIsBetter": false, "replicates": [526.7208379558836, 565.380907905843, 583.2359608912325, 616.938306169383, 617.5214208988034, 40836.979075523086, 41437.0994030418, 41577.58422415775, 41709.58290417095, 41753.16493670129, 44052.3392149118, 44409.77795111028, 44558.554414455844, 44688.3296750549, 44844.551554484446, 9664.0, 9831.606735730598, 9832.803343933118, 9848.60605575776, 9850.556724947359, 9615.375000624972, 9646.180074693624, 9693.70918872435, 9717.659881904136, 9790.167835733972, 9645.276604254674, 9692.41845489273, 9696.418214907093, 9733.124018838338, 9785.902140978571, 9706.466144362057, 9724.513774311255, 9745.31782775206, 9760.41437513748, 9796.559154838049, 9589.42463452195, 9656.082672146134, 9729.805403891953, 9755.268354873342, 9771.364861284064, 33995.49006764901, 40929.38605920914, 40978.18043639111, 41067.794661026805, 41300.108992370544, 3251.5122731590213, 3347.548081009057, 3407.812570308632, 3435.986384016696, 3798.6771124454453, 28442.857785710938, 29292.560611590845, 30003.549946750816, 30007.399852003055, 30033.549496757565, 2257.9887100564392, 2432.2095319021214, 2498.1756020513185, 2516.660250866128, 2608.0480624572083, 499264.0, 499302.0, 511980.0, 522815.0, 677114.9999999951, 55214.72392638011, 55364.0, 55408.6147846299, 55766.72116639391, 55953.72023139858, 56535.0, 56999.43000570024, 57000.42999570034, 57713.71143144257, 57833.421665783644, 16348.836511634969, 16419.1790410479, 16567.337306507845, 16576.419825306057, 16769.1615419231, 12699.301538415475, 12832.935835320764, 12872.613821585368, 12947.223166609845, 12972.15680980752, 19775.60448791045, 20108.195672173242, 20116.597668046557, 20140.39578812638, 20142.798572014384, 7952.204779522117, 8087.231712987257, 8128.9593552031865, 8129.430939834155, 8192.221738934792, 999.4153420249236, 1034.343192073039, 1055.3087727538475, 1075.7902209069314, 1130.9321440713584, 24506.387340316636, 27246.727532724817, 30176.94380696665, 30772.0, 30795.076147715605, 893.5353616119581, 1007.1640538353149, 1114.8327750837439, 1183.248637115438, 1195.8445402097673, 15353.769693454607, 15641.061536307858, 15691.607709807118, 15748.133852637986, 16537.338506459848, 659262.0, 659521.0, 660079.0, 660398.0, 672986.0, 62448.75102497925, 62891.742165156444, 62903.0, 62919.0, 63152.05271920925, 1416.7874818777266, 1445.2051371745497, 1451.477468111479, 1468.2365170111696, 1472.889533285008, 30528.08415747531, 30664.119675506532, 30681.0, 30819.0, 30872.228194295323, 54402.727986359816, 54702.452975469736, 54789.726051369486, 54941.72529137329, 54967.0, 474602.0, 476380.0, 477007.0, 477850.0, 478233.0, 35159.29681406306, 47910.76044619754, 48069.03861922812, 49605.0, 49770.50229497803, 46474.535254647024, 47055.76472117617, 47064.058718824745, 47150.29274560816, 47647.0, 38906.10938906087, 39240.803795980835, 40487.595124048385, 40775.0, 41624.04571565696, 38617.0, 38934.80532597319, 39193.0, 39223.60776392314, 39847.80076099601, 38611.80694096624, 38669.6133038666, 38716.80641596774, 38758.6124138755, 39001.0, 28111.859440703483, 33634.66365336413, 34431.311373772885, 34721.65278347184, 34853.0, 21292.893535532225, 25544.105956292184, 25971.0, 26203.68981550953, 26270.949162033303], "unit": "ms", "name": "ext.html", "value": 20453.329893669736}, {"lowerIsBetter": false, "replicates": [322.4099897188146, 356.5471850749548, 364.87958973538724, 365.32415032190437, 366.7121309771829, 16357.0, 20027.0, 20089.59820803583, 20506.2822801202, 21177.788222117793, 19993.0, 20171.697424538645, 20545.0, 20576.0, 21270.468238294052, 5649.774009039644, 5756.194132821408, 5787.508061814729, 5804.419558044204, 5825.737841797109, 4857.34425852509, 4990.201567749161, 4997.625178111638, 5000.5999520038495, 5987.880242395149, 4701.106789709944, 4886.682365646239, 4903.338049363344, 4911.214205727084, 4912.680675756064, 4382.561743825608, 4847.321375007502, 4920.360353154085, 4921.212605983062, 4950.727709975968, 4135.545090040093, 4164.4586203793315, 4181.247375472413, 4235.788210589458, 4277.016286254147, 13725.931370343083, 13876.722465550733, 13920.095193812369, 14022.859771402258, 14238.857611423857, 1881.5578339090303, 1943.7375954246138, 1952.9023548822645, 2052.7331446911953, 2138.4068868692766, 10108.696739097839, 10230.38617682934, 10236.385816850938, 10321.225908056851, 10352.275340726152, 1560.36805093936, 1577.960550986223, 1589.721798685237, 1595.728726116563, 1609.2919115589104, 92723.0, 95962.04037959602, 96898.9999999993, 97098.0, 97180.0, 6678.699458524378, 6770.119884415093, 6770.187577490733, 6787.592744435349, 6822.147231596051, 7589.924100759032, 7681.846363072707, 7694.07671079474, 7736.845263094707, 7764.6894124234395, 5685.658860468385, 5690.231818704505, 5716.88520738452, 5726.112452569859, 5738.368779434259, 6186.443220110212, 6198.845028874314, 6216.53375996793, 6220.688965551795, 6249.437550620466, 2819.3515491437083, 3006.2784931616256, 3008.533677280025, 3041.422129795332, 3048.5731997520365, 985.6545814962525, 1080.6757972608186, 1084.8426978088291, 1098.242212873115, 1122.449999500239, 443.63400194839386, 453.14808160657753, 460.48195779747783, 478.7582270953146, 486.1807853766415, 11367.602133925273, 12390.938045309897, 12414.503419863104, 12572.0, 12634.431450584745, 437.319967450611, 480.4402870655647, 482.2043628013735, 483.82824097445604, 491.82786024891715, 6681.265060843303, 6693.330666933365, 6748.730050798012, 6769.1876974763345, 6802.387785099365, 778356.0, 784487.0, 789052.0, 803608.0, 812184.0, 114741.0, 115827.84172158339, 118059.40970295093, 120210.0, 122444.16333754822, 517.9300794392709, 520.6901893373437, 523.4190049045633, 524.3917056214697, 525.6609486881017, 11059.557617695202, 11844.230125041844, 11967.700807479883, 11971.98238149767, 12043.0, 42378.0, 55188.17217741657, 55482.72258638842, 55525.44474555203, 55577.444225558844, 77097.0, 77727.61136194282, 77825.22174778406, 78713.0, 79021.0, 6419.839504012437, 6464.191976003, 6469.77355792545, 6505.902411463737, 6510.381513756186, 10530.05229529346, 10769.192310576582, 12086.15396922207, 12570.811437828257, 12679.746405072032, 9981.0, 10649.988251116132, 10884.292520986111, 10956.178286628694, 11026.724331891766, 10624.36253824742, 10639.202059845697, 10644.254902156774, 10854.0, 10921.726956826144, 10873.96697313754, 11077.667669969915, 11084.390358530358, 11143.052840508648, 11176.385298808644, 6331.366863313632, 6337.493000559852, 6457.709403076967, 6472.223333200046, 6482.0, 10801.837972430578, 10820.4048777318, 11035.558577656804, 11037.227394082338, 11189.04893084097], "unit": "ms", "name": "jquery.html", "value": 7502.060923179806}, {"lowerIsBetter": false, "replicates": [1497.15410792902, 1536.0553259745252, 1797.074506629087, 1886.6226754649065, 1895.3461055935702, 7562.735304264352, 7629.580373079492, 8104.716334928279, 8258.00903891534, 8281.544515051677, 7835.725749598765, 8170.060443049051, 8323.500589964606, 8366.581670916461, 8380.371472139583, 2327.138958585326, 2366.526694661066, 2368.265837590344, 2370.7866292033714, 2374.548835721216, 2072.668373060311, 2377.4413012941945, 2396.149366974725, 2412.5898597238424, 2425.333033415807, 2341.625339945609, 2360.9173678921243, 2379.4170428245016, 2382.404398900275, 2395.197608801054, 1993.6610776168013, 2351.71779386473, 2378.0250097460043, 2379.785819276256, 2387.78509934105, 2382.7617238276207, 2383.0, 2403.7596240375824, 2412.16780210827, 2426.97573024271, 7095.538789978635, 8344.791380215482, 8353.624086916043, 8418.621162047722, 8450.19723126302, 5132.871678208037, 5223.399309079467, 5230.189320655304, 5234.842954711365, 5242.266082748418, 3471.1643633784556, 3547.8048707321086, 3548.822558872072, 3559.1280136366495, 3598.838052287653, 1047.4867315015663, 1063.3991794636006, 1068.3483075324045, 1081.453865797775, 1083.6261489786011, 11077.335359878432, 11102.666919992333, 11104.167187460973, 11122.944385278102, 11148.275362101518, 4679.789409476582, 4690.89763905482, 4727.196376615983, 4736.052789442126, 4748.881277968078, 9571.856422153673, 9630.133288004114, 9638.759031024281, 9644.75888102803, 9674.661386851427, 5198.792048318025, 5207.0887594670785, 5208.114620514446, 5224.686518808883, 5225.555827754683, 4291.206126866539, 4366.563343665608, 4635.281531362644, 4739.075880203396, 4749.95250047502, 3860.7876566788536, 3898.0644645285493, 3912.7065470089856, 3926.450296958428, 3963.2667956428154, 1279.4178648714812, 1286.8648791876906, 1295.430010795247, 1296.1121631682329, 1297.6690943809458, 1140.2645293785463, 1144.8683401408778, 1157.7626586549736, 1158.9685180189638, 1163.203205804027, 7834.099078606033, 7864.567448790257, 7894.763157105296, 7929.32600728933, 7933.365330773524, 1209.8427204463364, 1209.8729633388543, 1210.5218438716659, 1213.0538180219266, 1230.4524486603375, 6232.283287421914, 6277.780277690259, 6283.497320214372, 6320.71556779946, 6342.429181373606, 8366.916330836735, 10100.74748131288, 10100.797984040279, 10138.746531336628, 10185.287029907984, 9722.513874306256, 9973.700788976343, 9985.550650220757, 10041.598336066621, 10061.245406594535, 7862.292393684482, 7866.528008319519, 7901.644426000844, 7920.485168464032, 7957.801054973556, 7437.665305061393, 7494.250574942462, 7535.54786712799, 7540.698372065056, 7562.886556701764, 8876.600552975002, 8937.240334571634, 9029.322800789836, 9073.092690731139, 9201.263898888206, 9247.953760231156, 9337.346385752931, 9369.109934556207, 9396.67111651089, 9422.670206542738, 6332.493400527855, 6423.807285781434, 6761.661916904233, 6893.345132212432, 6955.1653801544135, 6756.729730810713, 7875.684972601031, 7876.6061696913775, 7941.444098913021, 7949.7217597383815, 7325.230850760593, 7424.368928641126, 7455.7017719290625, 7557.05536807899, 7603.0876294844975, 7209.243029482039, 7375.078115235596, 7434.1450733166375, 7442.032535770315, 7464.328210461084, 6392.296847346881, 7457.701691932262, 7493.063367079115, 7512.661930213263, 7516.812079698051, 6794.966025169842, 6834.794956151323, 6864.039034535269, 6870.2442731298515, 6885.4835887309655, 6922.861542769016, 6945.548539344926, 6962.721491140298, 6972.58164510131, 6978.162620485574], "unit": "ms", "name": "mootools.html", "value": 4768.5845276057125}, {"lowerIsBetter": false, "replicates": [317.22280412988175, 320.35288716792064, 324.8895375572305, 327.0809026635156, 331.42663192676685, 6297.779577714781, 6775.254721980578, 6922.861542769142, 6982.4763142764305, 6990.965045174773, 6094.817155485332, 6135.631862088278, 6181.536384771138, 6351.142595749572, 6359.841003974903, 4109.609587089221, 5104.387473503176, 5113.1307677694695, 5115.232715092748, 5145.2796608474655, 4137.793110344486, 5143.3570803649545, 5143.974280128594, 5154.098032844237, 5166.147585648364, 4810.470848206694, 4963.751812409365, 4966.826161084363, 4981.402231732197, 4995.150824359849, 4962.0820148272505, 4971.925421118686, 4981.676191047606, 4985.700857948535, 4995.325631039799, 3992.7803970781597, 4059.6955228357992, 4099.528554216274, 4182.853600123981, 4190.015346393595, 6111.991521398963, 6135.693215339215, 6580.80257592273, 6626.701798419034, 6679.732810687567, 5878.294604647427, 5884.617499862496, 5900.321463031763, 5911.320198177222, 5934.406559344075, 5931.525477961753, 7228.566286022856, 7342.7797166084565, 7357.190709022003, 7376.96311518439, 4791.401074865642, 4807.18277892759, 4814.831480898187, 4858.514148585148, 4874.2444921037295, 7813.96093019537, 7891.053073631144, 7894.842103157962, 7908.841823163504, 7920.603969801545, 4758.5241475852135, 4935.950640493621, 4954.677945933503, 4960.8759781005765, 4966.1309270877455, 5037.992401519711, 5042.747862606855, 5046.44489106198, 5047.621428392812, 5061.822836200715, 4873.098476781806, 5936.901673190388, 5964.761409543569, 5974.701264936736, 5994.820155395345, 6137.693115344215, 7423.331900129015, 7428.591427471541, 7446.553206807609, 7472.17806041335, 1418.432626949208, 1454.7163303155783, 1731.3074770092064, 1741.8780685351903, 1742.0418769676628, 931.0, 1119.451468780308, 1132.2357408749226, 1132.3092913322866, 1132.3998280910967, 6969.860602787916, 6976.232614412411, 6978.546394484342, 6984.4063254623925, 7067.151941767021, 7683.500572462772, 7711.498752581064, 7713.190115037953, 7723.343515801107, 7734.071911370559, 5702.0021496238, 6849.726010959605, 6919.0, 6938.79183624482, 7022.367986881205, 3202.615686117681, 4034.455348527911, 4069.409935559327, 4121.0, 4123.628873401408, 7864.2922137007945, 8014.519128852287, 8072.757817265491, 8079.919200807916, 8116.715914942949, 8005.479643823133, 8020.639071241808, 8022.598870056474, 8029.59852007409, 8090.1909809018625, 7060.764366235991, 7805.41459390548, 8065.0, 8086.0, 8091.433599648086, 7618.238176182559, 7770.300672939463, 7770.417218708506, 7786.416018798726, 7801.609919503889, 7288.744893928687, 7581.370005448634, 7591.734289299848, 7599.620018998918, 7635.770926871981, 6474.539674923499, 7045.718171273092, 7552.980347653216, 8041.959790201012, 8061.838763224585, 4687.718736875799, 4792.880177995578, 4803.231482962709, 4822.831200907952, 4835.661503694708, 7182.102237220348, 7576.052993375828, 7655.349295309961, 7814.88277675824, 7850.293473587176, 7464.776056718307, 7466.328030477283, 7471.439642026761, 7479.476436649382, 7497.100347958061, 6818.93181068183, 7416.629168541659, 7433.628318584158, 7480.193024347817, 7496.287852653989, 5955.553333500092, 6607.339266073546, 7054.682539285642, 7308.940203670331, 7350.77947661571, 7470.925290747023, 7483.214262502359, 7491.775246742606, 7495.62521873915, 7511.47419680639, 7141.357277845019, 7325.413966882743, 7339.706411743684, 7362.447816413897, 7377.741779037708], "unit": "ms", "name": "prototype.html", "value": 5328.84509495987}, {"lowerIsBetter": false, "replicates": [678.6199728152232, 735.3492159438895, 780.1379475679375, 801.194799226777, 812.6383759227144, 14738.705225895488, 14939.327730252138, 15059.665751808487, 15076.0, 15104.546863594096, 13890.23603701796, 13956.0, 14015.15909045458, 14498.782518262207, 14526.854731452682, 944.3059351376733, 945.0502245243521, 958.2908647600794, 968.6803354892903, 971.8687977123069, 952.1811242331623, 952.647520417443, 960.7309953213112, 965.8985806490323, 967.8451447768358, 1001.5092604623718, 1006.6074231049896, 1014.6600888702294, 1019.8929112443197, 1020.5356562763961, 998.0119681515284, 1002.4787110702393, 1007.7480629842539, 1012.2003617142485, 1014.137982714694, 726.3789460011667, 731.9524230924973, 735.1141874041767, 739.4232498651061, 742.1835980421547, 13448.596542103753, 13450.596482105553, 13519.864801352058, 13547.254900980442, 13550.0, 9300.441973481613, 10828.945855270673, 10953.397563134024, 11052.447377631086, 11376.772464550746, 9480.24158067353, 9564.617415303379, 9610.567524461416, 9784.070513301225, 9990.9500452498, 3465.8786942457145, 3475.739319551044, 3491.633378495272, 3498.7201023918024, 3500.247446798925, 64340.67829660868, 67392.0, 69740.0, 70696.6465167676, 73794.0, 8050.913126727934, 9594.472304023346, 9630.4703241321, 9908.80182396348, 10147.137493313003, 20895.582088358147, 20932.79067209339, 21142.78857211439, 21200.681989770164, 21222.893885530782, 6503.577267477599, 7344.70621175147, 7421.1094668639025, 7465.0, 7688.577128257888, 3972.940405893914, 4165.66674666026, 4193.454850869368, 4267.0825772459075, 4280.481006609869, 2768.9477998360494, 3178.3643271345823, 3201.2797120648133, 3225.8064516129107, 3228.5157226416227, 538.6579522003556, 563.9210510528529, 569.0383252303594, 569.9230603868425, 572.3046498504254, 500.22215454967875, 509.9056674515227, 510.94124175719526, 542.1271752478507, 552.2985808023788, 8391.580420978926, 8493.532855692873, 8657.52383618907, 8719.171678690514, 8959.955200223958, 550.3148580017903, 558.9770719583153, 589.8938191125638, 602.5270162922085, 614.2536817766435, 3994.3009973254566, 4033.858814941463, 4067.5525692173837, 4131.628153466202, 4165.541790403053, 89361.55319223362, 89713.55143224372, 90624.0, 91098.54450727704, 91513.0, 64899.02651460138, 74971.87542186871, 81815.81867807708, 83467.58266208631, 83488.0, 70376.29623703698, 70716.0, 71497.0, 72504.0, 72724.0, 8728.738137855875, 8762.0, 8980.236679882284, 9189.310801689766, 9274.582643780912, 39029.0, 51902.74048629733, 52079.0, 52767.68080797857, 54256.0, 68389.31610684028, 73190.0, 74892.0, 76350.61824690842, 77553.61223193847, 7921.128675845537, 7930.365570754441, 8012.479188852706, 8128.471649342774, 8379.58102094905, 11983.34091624969, 12181.39093045362, 12201.0, 12244.89795918336, 12883.162594431707, 11609.0, 11801.52793888235, 11838.644840654793, 12103.75792484163, 12165.817512737493, 10202.234832387749, 10594.152467802403, 11641.59254426091, 11797.76404471923, 11811.291322520676, 11515.769684606428, 11538.076953843505, 11567.652970410902, 11628.360440175533, 11704.0, 9675.462240036668, 9796.506571918233, 9875.111239988435, 10020.549075291776, 10042.748931276776, 8725.607347669244, 9564.66523671668, 9977.351472154287, 10077.949610251902, 10140.29017968735], "unit": "ms", "name": "yui.html", "value": 6826.474313548125}], "name": "dromaeo_css", "value": 7326.419857578581}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 105.0, 163.0, 164.0, 94.0, 173.0, 169.0, 150.0, 115.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 136.2}, {"lowerIsBetter": true, "replicates": [142.0, 125.0, 144.0, 161.0, 150.0, 140.0, 138.0, 121.0, 155.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.1}, {"lowerIsBetter": true, "replicates": [190.0, 206.0, 261.0, 222.0, 196.0, 194.0, 199.0, 195.0, 203.0, 197.0], "unit": "ms", "name": "audio-dft", "value": 206.3}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 61.0, 129.0, 81.0, 81.0, 50.0, 59.0, 65.0, 77.0], "unit": "ms", "name": "audio-fft", "value": 72.8}, {"lowerIsBetter": true, "replicates": [78.0, 75.0, 104.0, 76.0, 78.0, 78.0, 105.0, 77.0, 77.0, 109.0], "unit": "ms", "name": "audio-oscillator", "value": 85.7}, {"lowerIsBetter": true, "replicates": [133.0, 97.0, 90.0, 88.0, 76.0, 85.0, 124.0, 133.0, 132.0, 88.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 104.6}, {"lowerIsBetter": true, "replicates": [134.0, 151.0, 133.0, 105.0, 152.0, 102.0, 138.0, 150.0, 95.0, 96.0], "unit": "ms", "name": "imaging-darkroom", "value": 125.6}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 112.0, 120.0, 95.0, 92.0, 90.0, 89.0, 145.0, 128.0], "unit": "ms", "name": "imaging-desaturate", "value": 105.3}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 57.0, 56.0, 58.0, 57.0, 59.0, 66.0, 56.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 65.0, 66.0, 91.0, 106.0, 103.0, 103.0, 76.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 81.2}, {"lowerIsBetter": true, "replicates": [85.0, 77.0, 84.0, 82.0, 84.0, 86.0, 84.0, 84.0, 83.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [134.0, 122.0, 132.0, 128.0, 122.0, 125.0, 133.0, 121.0, 119.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [137.0, 143.0, 144.0, 139.0, 136.0, 143.0, 146.0, 133.0, 138.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 139.8}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 67.0, 76.0, 67.0, 65.0, 66.0, 67.0, 66.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1532.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [642.2607578676943], "unit": "score", "name": "Richards", "value": 54.965213999999975}, {"lowerIsBetter": false, "replicates": [155.1590380139643], "unit": "score", "name": "DeltaBlue", "value": 426.1305100000001}, {"lowerIsBetter": false, "replicates": [291.97080291970804], "unit": "score", "name": "Encrypt", "value": 911.6699249999998}, {"lowerIsBetter": false, "replicates": [4873.78640776699], "unit": "score", "name": "Decrypt", "value": 54.61482669322707}, {"lowerIsBetter": false, "replicates": [946.969696969697], "unit": "score", "name": "RayTrace", "value": 781.4283840000004}, {"lowerIsBetter": false, "replicates": [820.3445447087777], "unit": "score", "name": "Earley", "value": 812.418397}, {"lowerIsBetter": false, "replicates": [12948.71794871795], "unit": "score", "name": "Boyer", "value": 51.46941980198023}, {"lowerIsBetter": false, "replicates": [26763.157894736843], "unit": "score", "name": "RegExp", "value": 34.0387708947886}, {"lowerIsBetter": false, "replicates": [710.9540636042403], "unit": "score", "name": "Splay", "value": 114.6220328031809}, {"lowerIsBetter": false, "replicates": [4538.461538461538], "unit": "score", "name": "NavierStokes", "value": 326.98305084745743}], "name": "v8_7", "value": 18654.646407119428}]} 11:14:51 INFO - RETURN: dromaeo_css: 7326.42 11:14:51 INFO - RETURN: kraken: 1532.00 11:14:51 INFO - RETURN: v8_7: 18654.65 11:14:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "18654.65"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1532.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7326.42"}}} 11:14:51 INFO - Return code: 0 11:14:51 INFO - # TBPL SUCCESS # 11:14:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:14:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:14:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:14:51 INFO - 2015-11-19 11:14:51.566 screenresolution[1999:16959] starting screenresolution argv=screenresolution get 11:14:51 INFO - 2015-11-19 11:14:51.568 screenresolution[1999:16959] Display 0: 1600x1200x32@60 11:14:51 INFO - 2015-11-19 11:14:51.574 screenresolution[2000:16962] starting screenresolution argv=screenresolution list 11:14:51 INFO - Available Modes on Display 0 11:14:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:14:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:14:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:14:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:14:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:14:51 INFO - Intel Iris: 11:14:51 INFO - Chipset Model: Intel Iris 11:14:51 INFO - Type: GPU 11:14:51 INFO - Bus: Built-In 11:14:51 INFO - VRAM (Dynamic, Max): 1536 MB 11:14:51 INFO - Vendor: Intel (0x8086) 11:14:51 INFO - Device ID: 0x0a2e 11:14:51 INFO - Revision ID: 0x0009 11:14:51 INFO - Displays: 11:14:51 INFO - Display: 11:14:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:14:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:14:51 INFO - Display Serial Number: 1600x1200 60 11:14:51 INFO - Main Display: Yes 11:14:51 INFO - Mirror: Off 11:14:51 INFO - Online: Yes 11:14:51 INFO - Rotation: Supported 11:14:51 INFO - Return code: 0 11:14:51 INFO - Running post-action listener: _resource_record_post_action 11:14:51 INFO - Running post-run listener: _resource_record_post_run 11:14:52 INFO - Total resource usage - Wall time: 1238s; CPU: 54.0%; Read bytes: 970752; Write bytes: 691573760; Read time: 12; Write time: 2183 11:14:52 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 338379264; Write bytes: 336213504; Read time: 26236; Write time: 598 11:14:52 INFO - run-tests - Wall time: 1208s; CPU: 54.0%; Read bytes: 970752; Write bytes: 344149504; Read time: 12; Write time: 1550 11:14:52 INFO - Running post-run listener: _upload_blobber_files 11:14:52 INFO - Blob upload gear active. 11:14:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:14:52 INFO - Copying logs to upload dir... 11:14:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.280647 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-19 11:14:52.951176) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 11:14:52.952204) ========= 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.v7Kkvyhh2w/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.OVpJaWbjm2/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009592 build_url: 'https://queue.taskcluster.net/v1/task/OAvYD5BgTs2jpty7qt7xLw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 11:14:52.985567) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 11:14:52.985995) ========= 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.v7Kkvyhh2w/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.OVpJaWbjm2/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005232 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 11:14:53.035549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 11:14:53.035908) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 11:14:53.036364) ========= ========= Total master_lag: 0.22 =========