builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0027 starttime: 1448336281.96 results: success (0) buildid: 20151123185257 builduid: 3994e6afd70e4d1dabe715cb9217aa69 revision: befb8e2645ef77775bbd5ef7eb866fd51b376458 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:01.964671) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:01.967438) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:01.967755) ========= 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.AFLL732OwT/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.QkLkLbfOl2/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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.005599 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:01.988373) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:01.988680) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:02.003335) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:02.003729) ========= 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.AFLL732OwT/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.QkLkLbfOl2/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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.005337 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:02.052178) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:02.052502) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:02.052888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:02.053158) ========= 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.AFLL732OwT/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.QkLkLbfOl2/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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-23 19:38:02-- 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% 8.38M=0.001s 2015-11-23 19:38:02 (8.38 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.410271 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:02.477220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:02.477570) ========= 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.AFLL732OwT/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.QkLkLbfOl2/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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.019536 ========= master_lag: 0.19 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:02.684153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 19:38:02.684557) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev befb8e2645ef77775bbd5ef7eb866fd51b376458 --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 befb8e2645ef77775bbd5ef7eb866fd51b376458 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AFLL732OwT/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.QkLkLbfOl2/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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-23 19:38:02,762 truncating revision to first 12 chars 2015-11-23 19:38:02,762 Setting DEBUG logging. 2015-11-23 19:38:02,762 attempt 1/10 2015-11-23 19:38:02,762 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/befb8e2645ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 19:38:04,193 unpacking tar archive at: fx-team-befb8e2645ef/testing/mozharness/ program finished with exit code 0 elapsedTime=1.674057 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 19:38:04.373111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:04.373437) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:04.385087) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:04.385476) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 19:38:04.385924) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-23 19:38:04.386207) ========= /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.AFLL732OwT/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.QkLkLbfOl2/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 19:38:04 INFO - MultiFileLogger online at 20151123 19:38:04 in /builds/slave/test 19:38:04 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 19:38:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:38:04 INFO - {'append_to_log': False, 19:38:04 INFO - 'base_work_dir': '/builds/slave/test', 19:38:04 INFO - 'blob_upload_branch': 'Fx-Team', 19:38:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:38:04 INFO - 'branch': 'Fx-Team', 19:38:04 INFO - 'buildbot_json_path': 'buildprops.json', 19:38:04 INFO - 'config_files': ('talos/mac_config.py',), 19:38:04 INFO - 'default_actions': ('clobber', 19:38:04 INFO - 'read-buildbot-config', 19:38:04 INFO - 'download-and-extract', 19:38:04 INFO - 'populate-webroot', 19:38:04 INFO - 'create-virtualenv', 19:38:04 INFO - 'install', 19:38:04 INFO - 'run-tests'), 19:38:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:38:04 INFO - 'download_minidump_stackwalk': True, 19:38:04 INFO - 'download_symbols': 'ondemand', 19:38:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:38:04 INFO - 'tooltool.py': '/tools/tooltool.py', 19:38:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:38:04 INFO - '/tools/misc-python/virtualenv.py')}, 19:38:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:38:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:38:04 INFO - 'installer_path': 'installer.exe', 19:38:04 INFO - 'log_level': 'info', 19:38:04 INFO - 'log_name': 'talos', 19:38:04 INFO - 'log_to_console': True, 19:38:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:38:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:38:04 INFO - 'opt_config_files': (), 19:38:04 INFO - 'pip_index': False, 19:38:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:38:04 INFO - 'cmd': ('bash', 19:38:04 INFO - '-c', 19:38:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:38:04 INFO - 'enabled': True, 19:38:04 INFO - 'halt_on_failure': False, 19:38:04 INFO - 'name': 'check_screen_resolution'},), 19:38:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:38:04 INFO - 'cmd': ('bash', 19:38:04 INFO - '-c', 19:38:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:38:04 INFO - 'enabled': True, 19:38:04 INFO - 'halt_on_failure': False, 19:38:04 INFO - 'name': 'check_screen_resolution'},), 19:38:04 INFO - 'run_cmd_checks_enabled': True, 19:38:04 INFO - 'sps_profile': False, 19:38:04 INFO - 'sps_profile_interval': 0, 19:38:04 INFO - 'suite': 'dromaeojs-e10s', 19:38:04 INFO - 'system_bits': '64', 19:38:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:38:04 INFO - 'title': 't-yosemite-r7-0027', 19:38:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:38:04 INFO - 'use_talos_json': True, 19:38:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:38:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:38:04 INFO - 'work_dir': 'build'} 19:38:04 INFO - ##### 19:38:04 INFO - ##### Running clobber step. 19:38:04 INFO - ##### 19:38:04 INFO - Running pre-action listener: _resource_record_pre_action 19:38:04 INFO - Running main action method: clobber 19:38:04 INFO - rmtree: /builds/slave/test/build 19:38:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:38:05 INFO - Running post-action listener: _resource_record_post_action 19:38:05 INFO - ##### 19:38:05 INFO - ##### Running read-buildbot-config step. 19:38:05 INFO - ##### 19:38:05 INFO - Running pre-action listener: _resource_record_pre_action 19:38:05 INFO - Running main action method: read_buildbot_config 19:38:05 INFO - Using buildbot properties: 19:38:05 INFO - { 19:38:05 INFO - "properties": { 19:38:05 INFO - "buildnumber": 21, 19:38:05 INFO - "product": "firefox", 19:38:05 INFO - "script_repo_revision": "production", 19:38:05 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 19:38:05 INFO - "repository": "", 19:38:05 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 19:38:05 INFO - "buildid": "20151123185257", 19:38:05 INFO - "slavename": "t-yosemite-r7-0027", 19:38:05 INFO - "pgo_build": "False", 19:38:05 INFO - "basedir": "/builds/slave/test", 19:38:05 INFO - "project": "", 19:38:05 INFO - "platform": "yosemite_r7", 19:38:05 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:38:05 INFO - "slavebuilddir": "test", 19:38:05 INFO - "scheduler": "tests-fx-team-macosx64-talos", 19:38:05 INFO - "branch": "fx-team", 19:38:05 INFO - "repo_path": "integration/fx-team", 19:38:05 INFO - "stage_platform": "macosx64", 19:38:05 INFO - "builduid": "3994e6afd70e4d1dabe715cb9217aa69", 19:38:05 INFO - "revision": "befb8e2645ef77775bbd5ef7eb866fd51b376458" 19:38:05 INFO - }, 19:38:05 INFO - "sourcestamp": { 19:38:05 INFO - "repository": "", 19:38:05 INFO - "hasPatch": false, 19:38:05 INFO - "project": "", 19:38:05 INFO - "branch": "fx-team-macosx64-talos", 19:38:05 INFO - "changes": [ 19:38:05 INFO - { 19:38:05 INFO - "category": null, 19:38:05 INFO - "files": [ 19:38:05 INFO - { 19:38:05 INFO - "url": null, 19:38:05 INFO - "name": "https://queue.taskcluster.net/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 19:38:05 INFO - } 19:38:05 INFO - ], 19:38:05 INFO - "repository": "", 19:38:05 INFO - "rev": "befb8e2645ef77775bbd5ef7eb866fd51b376458", 19:38:05 INFO - "who": "xquan@mozilla.com", 19:38:05 INFO - "when": 1448336165, 19:38:05 INFO - "number": 6698724, 19:38:05 INFO - "comments": "Bug 1227129 - Apply 'will-change: transform' to fullscreen-warning when it is shown. r=roc\n\nSince there is a 3s timeout to hide the fullscreen warning, it makes\nsense to always apply will-change transform when it is not hidden. This\ncould also avoid slight rendering difference when it stops moving.", 19:38:05 INFO - "project": "", 19:38:05 INFO - "at": "Mon 23 Nov 2015 19:36:05", 19:38:05 INFO - "branch": "fx-team-macosx64-talos", 19:38:05 INFO - "revlink": "", 19:38:05 INFO - "properties": [ 19:38:05 INFO - [ 19:38:05 INFO - "buildid", 19:38:05 INFO - "20151123185257", 19:38:05 INFO - "Change" 19:38:05 INFO - ], 19:38:05 INFO - [ 19:38:05 INFO - "builduid", 19:38:05 INFO - "3994e6afd70e4d1dabe715cb9217aa69", 19:38:05 INFO - "Change" 19:38:05 INFO - ], 19:38:05 INFO - [ 19:38:05 INFO - "pgo_build", 19:38:05 INFO - "False", 19:38:05 INFO - "Change" 19:38:05 INFO - ] 19:38:05 INFO - ], 19:38:05 INFO - "revision": "befb8e2645ef77775bbd5ef7eb866fd51b376458" 19:38:05 INFO - } 19:38:05 INFO - ], 19:38:05 INFO - "revision": "befb8e2645ef77775bbd5ef7eb866fd51b376458" 19:38:05 INFO - } 19:38:05 INFO - } 19:38:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 19:38:05 INFO - Running post-action listener: _resource_record_post_action 19:38:05 INFO - ##### 19:38:05 INFO - ##### Running download-and-extract step. 19:38:05 INFO - ##### 19:38:05 INFO - Running pre-action listener: _resource_record_pre_action 19:38:05 INFO - Running main action method: download_and_extract 19:38:05 INFO - mkdir: /builds/slave/test/build/tests 19:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:05 INFO - https://queue.taskcluster.net/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:38:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/test_packages.json 19:38:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/test_packages.json 19:38:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:38:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:38:08 INFO - Downloaded 1149 bytes. 19:38:08 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:38:08 INFO - Using the following test package requirements: 19:38:08 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:38:08 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:38:08 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 19:38:08 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:38:08 INFO - u'jsshell-mac.zip'], 19:38:08 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:38:08 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 19:38:08 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:38:08 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:38:08 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 19:38:08 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:38:08 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 19:38:08 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:38:08 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 19:38:08 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:38:08 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:38:08 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 19:38:08 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:08 INFO - https://queue.taskcluster.net/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:38:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:38:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:38:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/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 19:38:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/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 19:38:09 INFO - Downloaded 17526935 bytes. 19:38:09 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 19:38:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:38:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:38:12 INFO - Return code: 0 19:38:12 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 19:38: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')]} 19:38:12 INFO - https://queue.taskcluster.net/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:38:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:38:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:38:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/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 19:38:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/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 19:38:13 INFO - Downloaded 17526935 bytes. 19:38:13 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 19:38:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:38:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:38:16 INFO - Return code: 0 19:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:16 INFO - https://queue.taskcluster.net/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:38:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:38:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:38:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/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 19:38:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/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 19:38:17 INFO - Downloaded 11130997 bytes. 19:38:17 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 19:38:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:38:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 19:38:17 INFO - Return code: 0 19:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:17 INFO - https://queue.taskcluster.net/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:38:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:38:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:38:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 19:38:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/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 19:38:21 INFO - Downloaded 109907772 bytes. 19:38:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:38:21 INFO - mkdir: /builds/slave/test/properties 19:38:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:38:21 INFO - Writing to file /builds/slave/test/properties/build_url 19:38:21 INFO - Contents: 19:38:21 INFO - build_url:https://queue.taskcluster.net/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:38:21 INFO - Running post-action listener: _resource_record_post_action 19:38:21 INFO - Running post-action listener: set_extra_try_arguments 19:38:21 INFO - ##### 19:38:21 INFO - ##### Running populate-webroot step. 19:38:21 INFO - ##### 19:38:21 INFO - Running pre-action listener: _resource_record_pre_action 19:38:21 INFO - Running main action method: populate_webroot 19:38:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:38:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:38:21 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:38:21 INFO - '../fennec_ids.txt'], 19:38:21 INFO - 'tests': ['tcheck2']}, 19:38:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:38:21 INFO - '--tppagecycles', 19:38:21 INFO - '7'], 19:38:21 INFO - 'tests': ['tsvgm']}}, 19:38:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:38:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:38:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:38:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:38:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:38:21 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:38:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:38:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:38:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:38:21 INFO - 'talos_options': ['--e10s'], 19:38:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:38:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:38:21 INFO - 'tests': ['damp', 'tps']}, 19:38:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:38:21 INFO - 'talos_options': ['--e10s'], 19:38:21 INFO - 'tests': ['damp', 'tps']}, 19:38:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:38:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:38:21 INFO - 'other': {'tests': ['a11yr', 19:38:21 INFO - 'ts_paint', 19:38:21 INFO - 'tpaint', 19:38:21 INFO - 'sessionrestore', 19:38:21 INFO - 'sessionrestore_no_auto_restore']}, 19:38:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:38:21 INFO - 'tests': ['a11yr', 19:38:21 INFO - 'ts_paint', 19:38:21 INFO - 'tpaint', 19:38:21 INFO - 'sessionrestore', 19:38:21 INFO - 'sessionrestore_no_auto_restore']}, 19:38:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:38:21 INFO - 'tests': ['a11yr', 19:38:21 INFO - 'ts_paint', 19:38:21 INFO - 'tpaint', 19:38:21 INFO - 'sessionrestore', 19:38:21 INFO - 'sessionrestore_no_auto_restore']}, 19:38:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:38:21 INFO - 'tests': ['a11yr', 19:38:21 INFO - 'ts_paint', 19:38:21 INFO - 'tpaint', 19:38:21 INFO - 'sessionrestore', 19:38:21 INFO - 'sessionrestore_no_auto_restore']}, 19:38:21 INFO - 'other_l64': {'tests': ['a11yr', 19:38:21 INFO - 'ts_paint', 19:38:21 INFO - 'tpaint', 19:38:21 INFO - 'sessionrestore', 19:38:21 INFO - 'sessionrestore_no_auto_restore']}, 19:38:21 INFO - 'other_nol64': {'tests': ['a11yr', 19:38:21 INFO - 'ts_paint', 19:38:21 INFO - 'tpaint', 19:38:21 INFO - 'sessionrestore', 19:38:21 INFO - 'sessionrestore_no_auto_restore']}, 19:38:21 INFO - 'svgr': {'tests': ['tsvgx', 19:38:21 INFO - 'tsvgr_opacity', 19:38:21 INFO - 'tart', 19:38:21 INFO - 'tscrollx', 19:38:21 INFO - 'cart']}, 19:38:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:38:21 INFO - 'tests': ['tsvgx', 19:38:21 INFO - 'tsvgr_opacity', 19:38:21 INFO - 'tart', 19:38:21 INFO - 'tscrollx', 19:38:21 INFO - 'cart']}, 19:38:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:38:21 INFO - 'tests': ['tp5o']}, 19:38:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:38:21 INFO - 'talos_options': ['--e10s'], 19:38:21 INFO - 'tests': ['tp5o']}, 19:38:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:38:21 INFO - 'talos_options': ['--xperf_path', 19:38:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:38:21 INFO - 'tests': ['tp5n']}, 19:38:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:38:21 INFO - 'talos_options': ['--e10s', 19:38:21 INFO - '--xperf_path', 19:38:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:38:21 INFO - 'tests': ['tp5n']}}, 19:38:21 INFO - 'talos.zip': {'path': '', 19:38:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:38:21 INFO - Running post-action listener: _resource_record_post_action 19:38:21 INFO - ##### 19:38:21 INFO - ##### Running create-virtualenv step. 19:38:21 INFO - ##### 19:38:21 INFO - Running pre-action listener: _resource_record_pre_action 19:38:21 INFO - Running main action method: create_virtualenv 19:38:21 INFO - Creating virtualenv /builds/slave/test/build/venv 19:38:21 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 19:38:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:38:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:38:21 INFO - Using real prefix '/tools/python27' 19:38:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:38:22 INFO - Installing distribute.............................................................................................................................................................................................done. 19:38:25 INFO - Installing pip.................done. 19:38:25 INFO - Return code: 0 19:38:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:38:25 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')]} 19:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:25 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')]} 19:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:25 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 0x10571b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a805809b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10563f9f0>, '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 0x10539edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056328c8>, '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.AFLL732OwT/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.QkLkLbfOl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 19:38:25 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 19:38:25 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 19:38:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFLL732OwT/Render', 19:38:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:38:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:38:25 INFO - 'HOME': '/Users/cltbld', 19:38:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:38:25 INFO - 'LOGNAME': 'cltbld', 19:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:25 INFO - 'MOZ_NO_REMOTE': '1', 19:38:25 INFO - 'NO_EM_RESTART': '1', 19:38:25 INFO - 'PAGER': '/bin/cat', 19:38:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:25 INFO - 'PWD': '/builds/slave/test', 19:38:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:38:25 INFO - 'SHELL': '/bin/bash', 19:38:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkLkLbfOl2/Listeners', 19:38:25 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 19:38:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:38:25 INFO - 'USER': 'cltbld', 19:38:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:38:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:25 INFO - 'XPC_FLAGS': '0x0', 19:38:25 INFO - 'XPC_SERVICE_NAME': '0', 19:38:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:25 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 19:38:25 INFO - Cleaning up... 19:38:25 INFO - Return code: 0 19:38:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:38:25 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')]} 19:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:25 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')]} 19:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:25 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 0x10571b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a805809b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10563f9f0>, '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 0x10539edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056328c8>, '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.AFLL732OwT/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.QkLkLbfOl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 19:38:25 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 19:38:25 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 19:38:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFLL732OwT/Render', 19:38:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:38:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:38:25 INFO - 'HOME': '/Users/cltbld', 19:38:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:38:25 INFO - 'LOGNAME': 'cltbld', 19:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:25 INFO - 'MOZ_NO_REMOTE': '1', 19:38:25 INFO - 'NO_EM_RESTART': '1', 19:38:25 INFO - 'PAGER': '/bin/cat', 19:38:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:25 INFO - 'PWD': '/builds/slave/test', 19:38:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:38:25 INFO - 'SHELL': '/bin/bash', 19:38:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkLkLbfOl2/Listeners', 19:38:25 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 19:38:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:38:25 INFO - 'USER': 'cltbld', 19:38:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:38:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:25 INFO - 'XPC_FLAGS': '0x0', 19:38:25 INFO - 'XPC_SERVICE_NAME': '0', 19:38:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:25 INFO - Downloading/unpacking psutil>=0.7.1 19:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:28 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:38:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:38:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:38:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:38:28 INFO - Installing collected packages: psutil 19:38:28 INFO - Running setup.py install for psutil 19:38:28 INFO - building 'psutil._psutil_osx' extension 19:38:28 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 19:38:28 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 19:38:28 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 19:38:28 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 19:38:28 INFO - building 'psutil._psutil_posix' extension 19:38:28 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 19:38:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:38:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:38:28 INFO - ^ 19:38:28 INFO - 1 warning generated. 19:38:28 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 19:38:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:38:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:38:28 INFO - Successfully installed psutil 19:38:28 INFO - Cleaning up... 19:38:29 INFO - Return code: 0 19:38:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:38:29 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')]} 19:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:29 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')]} 19:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:29 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 0x10571b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a805809b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10563f9f0>, '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 0x10539edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056328c8>, '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.AFLL732OwT/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.QkLkLbfOl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 19:38:29 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 19:38:29 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 19:38:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFLL732OwT/Render', 19:38:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:38:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:38:29 INFO - 'HOME': '/Users/cltbld', 19:38:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:38:29 INFO - 'LOGNAME': 'cltbld', 19:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:29 INFO - 'MOZ_NO_REMOTE': '1', 19:38:29 INFO - 'NO_EM_RESTART': '1', 19:38:29 INFO - 'PAGER': '/bin/cat', 19:38:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:29 INFO - 'PWD': '/builds/slave/test', 19:38:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:38:29 INFO - 'SHELL': '/bin/bash', 19:38:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkLkLbfOl2/Listeners', 19:38:29 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 19:38:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:38:29 INFO - 'USER': 'cltbld', 19:38:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:38:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:29 INFO - 'XPC_FLAGS': '0x0', 19:38:29 INFO - 'XPC_SERVICE_NAME': '0', 19:38:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:38:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:38:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:38:31 INFO - Installing collected packages: mozsystemmonitor 19:38:31 INFO - Running setup.py install for mozsystemmonitor 19:38:31 INFO - Successfully installed mozsystemmonitor 19:38:31 INFO - Cleaning up... 19:38:31 INFO - Return code: 0 19:38:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:31 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 0x10571b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a805809b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10563f9f0>, '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 0x10539edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056328c8>, '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.AFLL732OwT/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.QkLkLbfOl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 19:38:31 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 19:38:31 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 19:38:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFLL732OwT/Render', 19:38:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:38:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:38:31 INFO - 'HOME': '/Users/cltbld', 19:38:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:38:31 INFO - 'LOGNAME': 'cltbld', 19:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:31 INFO - 'MOZ_NO_REMOTE': '1', 19:38:31 INFO - 'NO_EM_RESTART': '1', 19:38:31 INFO - 'PAGER': '/bin/cat', 19:38:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:31 INFO - 'PWD': '/builds/slave/test', 19:38:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:38:31 INFO - 'SHELL': '/bin/bash', 19:38:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkLkLbfOl2/Listeners', 19:38:31 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 19:38:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:38:31 INFO - 'USER': 'cltbld', 19:38:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:38:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:31 INFO - 'XPC_FLAGS': '0x0', 19:38:31 INFO - 'XPC_SERVICE_NAME': '0', 19:38:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:32 INFO - Downloading/unpacking blobuploader==1.2.4 19:38:32 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 19:38:32 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 19:38:32 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 19:38:32 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 19:38:32 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 19:38:32 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 19:38:35 INFO - Downloading blobuploader-1.2.4.tar.gz 19:38:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:38:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:38:35 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 19:38:35 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 19:38:35 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 19:38:35 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 19:38:35 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 19:38:35 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 19:38:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:38:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:38:35 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 19:38:35 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 19:38:35 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 19:38:35 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 19:38:35 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 19:38:35 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 19:38:36 INFO - Downloading docopt-0.6.1.tar.gz 19:38:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:38:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:38:36 INFO - Installing collected packages: blobuploader, requests, docopt 19:38:36 INFO - Running setup.py install for blobuploader 19:38:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:38:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:38:36 INFO - Running setup.py install for requests 19:38:36 INFO - Running setup.py install for docopt 19:38:37 INFO - Successfully installed blobuploader requests docopt 19:38:37 INFO - Cleaning up... 19:38:37 INFO - Return code: 0 19:38:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:38:37 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')]} 19:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:37 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')]} 19:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:37 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 0x10571b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a805809b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10563f9f0>, '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 0x10539edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056328c8>, '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.AFLL732OwT/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.QkLkLbfOl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 19:38:37 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 19:38:37 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 19:38:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFLL732OwT/Render', 19:38:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:38:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:38:37 INFO - 'HOME': '/Users/cltbld', 19:38:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:38:37 INFO - 'LOGNAME': 'cltbld', 19:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:37 INFO - 'MOZ_NO_REMOTE': '1', 19:38:37 INFO - 'NO_EM_RESTART': '1', 19:38:37 INFO - 'PAGER': '/bin/cat', 19:38:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:37 INFO - 'PWD': '/builds/slave/test', 19:38:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:38:37 INFO - 'SHELL': '/bin/bash', 19:38:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkLkLbfOl2/Listeners', 19:38:37 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 19:38:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:38:37 INFO - 'USER': 'cltbld', 19:38:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:38:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:37 INFO - 'XPC_FLAGS': '0x0', 19:38:37 INFO - 'XPC_SERVICE_NAME': '0', 19:38:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:38:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-y4w5tQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:38:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-QcPofT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:38:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-VPYt7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:38:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-o8LSiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:38:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-QKojyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:38:37 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-XXdiz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:38:38 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-HG1lkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:38:38 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-iXbmEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:38:38 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-5G7YeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:38:38 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-2Y11Uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:38:38 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-GWbdg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:38:38 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-SMt70W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:38:38 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-SIclYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:38:38 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-TskXyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:38:38 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-ZKi3ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:38:39 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-nyOMg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:38:39 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-kts_qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:38:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:38:39 INFO - Running setup.py install for manifestparser 19:38:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:38:39 INFO - Running setup.py install for mozcrash 19:38:39 INFO - Running setup.py install for mozdebug 19:38:39 INFO - Running setup.py install for mozdevice 19:38:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:38:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:38:39 INFO - Running setup.py install for mozfile 19:38:39 INFO - Running setup.py install for mozhttpd 19:38:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:38:40 INFO - Running setup.py install for mozinfo 19:38:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:38:40 INFO - Running setup.py install for mozInstall 19:38:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:38:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:38:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:38:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:38:40 INFO - Running setup.py install for mozleak 19:38:40 INFO - Running setup.py install for mozlog 19:38:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:38:40 INFO - Running setup.py install for moznetwork 19:38:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:38:40 INFO - Running setup.py install for mozprocess 19:38:40 INFO - Running setup.py install for mozprofile 19:38:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:38:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:38:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:38:41 INFO - Running setup.py install for mozrunner 19:38:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:38:41 INFO - Running setup.py install for mozscreenshot 19:38:41 INFO - Running setup.py install for moztest 19:38:41 INFO - Running setup.py install for mozversion 19:38:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:38:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:38:41 INFO - Cleaning up... 19:38:41 INFO - Return code: 0 19:38:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:41 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 0x10571b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a805809b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10563f9f0>, '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 0x10539edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056328c8>, '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.AFLL732OwT/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.QkLkLbfOl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 19:38:41 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 19:38:41 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 19:38:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFLL732OwT/Render', 19:38:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:38:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:38:41 INFO - 'HOME': '/Users/cltbld', 19:38:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:38:41 INFO - 'LOGNAME': 'cltbld', 19:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:41 INFO - 'MOZ_NO_REMOTE': '1', 19:38:41 INFO - 'NO_EM_RESTART': '1', 19:38:41 INFO - 'PAGER': '/bin/cat', 19:38:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:41 INFO - 'PWD': '/builds/slave/test', 19:38:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:38:41 INFO - 'SHELL': '/bin/bash', 19:38:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkLkLbfOl2/Listeners', 19:38:41 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 19:38:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:38:41 INFO - 'USER': 'cltbld', 19:38:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:38:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:41 INFO - 'XPC_FLAGS': '0x0', 19:38:41 INFO - 'XPC_SERVICE_NAME': '0', 19:38:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:38:42 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-w0lNPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:38:42 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)) 19:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:38:42 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-W4Zukl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:38:42 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)) 19:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:38:42 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-95A0fX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:38:42 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)) 19:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:38:42 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-GicRl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:38:42 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)) 19:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:38:42 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-CLezV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:38:42 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)) 19:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:38:42 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-MWd1cT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:38:42 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)) 19:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:38:42 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-WGOrEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:38:42 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)) 19:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:38:42 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-ud_Eeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:38:42 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)) 19:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:38:42 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-tBsutm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:38:43 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)) 19:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:38:43 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-k_RPqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 19:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:38:43 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-HGYusF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:38:43 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)) 19:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:38:43 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-LUwTvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:38:43 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)) 19:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:38:43 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-8WvAED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:38:43 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)) 19:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:38:43 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-zepj4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:38:43 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)) 19:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:38:43 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-ojxfe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:38:43 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)) 19:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:38:43 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-cMoGjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:38:43 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)) 19:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:38:43 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-iUKHko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:38:43 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)) 19:38:43 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)) 19:38:43 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)) 19:38:43 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)) 19:38:43 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)) 19:38:43 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)) 19:38:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:38:43 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 19:38:43 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 19:38:43 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 19:38:43 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 19:38:43 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 19:38:43 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 19:38:46 INFO - Downloading blessings-1.5.1.tar.gz 19:38:46 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 19:38:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:38:46 INFO - Installing collected packages: blessings 19:38:46 INFO - Running setup.py install for blessings 19:38:46 INFO - Successfully installed blessings 19:38:46 INFO - Cleaning up... 19:38:46 INFO - Return code: 0 19:38:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:38:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:38:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:38:46 INFO - Reading from file tmpfile_stdout 19:38:46 INFO - Current package versions: 19:38:46 INFO - blessings == 1.5.1 19:38:46 INFO - blobuploader == 1.2.4 19:38:46 INFO - docopt == 0.6.1 19:38:46 INFO - manifestparser == 1.1 19:38:46 INFO - mozInstall == 1.12 19:38:46 INFO - mozcrash == 0.16 19:38:46 INFO - mozdebug == 0.1 19:38:46 INFO - mozdevice == 0.47 19:38:46 INFO - mozfile == 1.2 19:38:46 INFO - mozhttpd == 0.7 19:38:46 INFO - mozinfo == 0.9 19:38:46 INFO - mozleak == 0.1 19:38:46 INFO - mozlog == 3.1 19:38:46 INFO - moznetwork == 0.27 19:38:46 INFO - mozprocess == 0.22 19:38:46 INFO - mozprofile == 0.27 19:38:46 INFO - mozrunner == 6.11 19:38:46 INFO - mozscreenshot == 0.1 19:38:46 INFO - mozsystemmonitor == 0.0 19:38:46 INFO - moztest == 0.7 19:38:46 INFO - mozversion == 1.4 19:38:46 INFO - psutil == 3.1.1 19:38:46 INFO - requests == 1.2.3 19:38:46 INFO - wsgiref == 0.1.2 19:38:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:38:46 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')]} 19:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:46 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')]} 19:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:46 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 0x10571b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a805809b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10563f9f0>, '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 0x10539edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056328c8>, '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.AFLL732OwT/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.QkLkLbfOl2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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 19:38:46 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 19:38:46 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 19:38:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFLL732OwT/Render', 19:38:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:38:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:38:46 INFO - 'HOME': '/Users/cltbld', 19:38:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:38:46 INFO - 'LOGNAME': 'cltbld', 19:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:46 INFO - 'MOZ_NO_REMOTE': '1', 19:38:46 INFO - 'NO_EM_RESTART': '1', 19:38:46 INFO - 'PAGER': '/bin/cat', 19:38:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:38:46 INFO - 'PWD': '/builds/slave/test', 19:38:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:38:46 INFO - 'SHELL': '/bin/bash', 19:38:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkLkLbfOl2/Listeners', 19:38:46 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 19:38:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:38:46 INFO - 'USER': 'cltbld', 19:38:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:38:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:46 INFO - 'XPC_FLAGS': '0x0', 19:38:46 INFO - 'XPC_SERVICE_NAME': '0', 19:38:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:46 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)) 19:38:46 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)) 19:38:46 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)) 19:38:46 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)) 19:38:46 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)) 19:38:46 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)) 19:38:46 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)) 19:38:46 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)) 19:38:46 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)) 19:38:46 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)) 19:38:46 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)) 19:38:46 INFO - Cleaning up... 19:38:46 INFO - Return code: 0 19:38:46 INFO - Running post-action listener: _resource_record_post_action 19:38:46 INFO - Running post-action listener: _start_resource_monitoring 19:38:47 INFO - Starting resource monitoring. 19:38:47 INFO - ##### 19:38:47 INFO - ##### Running install step. 19:38:47 INFO - ##### 19:38:47 INFO - Running pre-action listener: _resource_record_pre_action 19:38:47 INFO - Running main action method: install 19:38:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:38:47 INFO - Reading from file tmpfile_stdout 19:38:47 INFO - Detecting whether we're running mozinstall >=1.0... 19:38:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:38:47 INFO - Reading from file tmpfile_stdout 19:38:47 INFO - Output received: 19:38:47 INFO - Usage: mozinstall [options] installer 19:38:47 INFO - Options: 19:38:47 INFO - -h, --help show this help message and exit 19:38:47 INFO - -d DEST, --destination=DEST 19:38:47 INFO - Directory to install application into. [default: 19:38:47 INFO - "/builds/slave/test"] 19:38:47 INFO - --app=APP Application being installed. [default: firefox] 19:38:47 INFO - mkdir: /builds/slave/test/build/application 19:38:47 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'] 19:38:47 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 19:39:17 INFO - Reading from file tmpfile_stdout 19:39:17 INFO - Output received: 19:39:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:39:17 INFO - Running post-action listener: _resource_record_post_action 19:39:17 INFO - ##### 19:39:17 INFO - ##### Running run-tests step. 19:39:17 INFO - ##### 19:39:17 INFO - Running pre-action listener: _resource_record_pre_action 19:39:17 INFO - Running main action method: run_tests 19:39:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:39:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:39:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:39:17 INFO - 2015-11-23 19:39:17.880 screenresolution[2225:22246] starting screenresolution argv=screenresolution get 19:39:17 INFO - 2015-11-23 19:39:17.883 screenresolution[2225:22246] Display 0: 1600x1200x32@60 19:39:17 INFO - 2015-11-23 19:39:17.889 screenresolution[2226:22248] starting screenresolution argv=screenresolution list 19:39:17 INFO - Available Modes on Display 0 19:39:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:39:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:39:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:39:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:39:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:39:18 INFO - Intel Iris: 19:39:18 INFO - Chipset Model: Intel Iris 19:39:18 INFO - Type: GPU 19:39:18 INFO - Bus: Built-In 19:39:18 INFO - VRAM (Dynamic, Max): 1536 MB 19:39:18 INFO - Vendor: Intel (0x8086) 19:39:18 INFO - Device ID: 0x0a2e 19:39:18 INFO - Revision ID: 0x0009 19:39:18 INFO - Displays: 19:39:18 INFO - Display: 19:39:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:39:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:39:18 INFO - Display Serial Number: 1600x1200 60 19:39:18 INFO - Main Display: Yes 19:39:18 INFO - Mirror: Off 19:39:18 INFO - Online: Yes 19:39:18 INFO - Rotation: Supported 19:39:18 INFO - Return code: 0 19:39:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:39:18 INFO - Python 2.7.3 19:39:18 INFO - Return code: 0 19:39:18 INFO - grabbing minidump binary from tooltool 19:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:39:18 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 0x10563f9f0>, '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 0x10539edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056328c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:39:18 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 19:39:18 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 19:39:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:39:18 INFO - Return code: 0 19:39:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:39:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:39:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:39:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:39:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:39:18 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/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0027', '--webServer', 'localhost'] in /builds/slave/test/build 19:39:18 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/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0027 --webServer localhost 19:39:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFLL732OwT/Render', 19:39:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:18 INFO - 'HOME': '/Users/cltbld', 19:39:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:18 INFO - 'LOGNAME': 'cltbld', 19:39:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:39:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:18 INFO - 'MOZ_NO_REMOTE': '1', 19:39:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:39:18 INFO - 'NO_EM_RESTART': '1', 19:39:18 INFO - 'PAGER': '/bin/cat', 19:39:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:18 INFO - 'PWD': '/builds/slave/test', 19:39:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:39:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:18 INFO - 'SHELL': '/bin/bash', 19:39:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QkLkLbfOl2/Listeners', 19:39:18 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 19:39:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:18 INFO - 'USER': 'cltbld', 19:39:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:18 INFO - 'XPC_FLAGS': '0x0', 19:39:18 INFO - 'XPC_SERVICE_NAME': '0', 19:39:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:18 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/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0027', '--webServer', 'localhost'] with output_timeout 3600 19:39:18 INFO - mozversion INFO | application_buildid: 20151123185257 19:39:18 INFO - mozversion INFO | application_changeset: befb8e2645ef77775bbd5ef7eb866fd51b376458 19:39:18 INFO - mozversion INFO | application_display_name: Nightly 19:39:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:39:18 INFO - mozversion INFO | application_name: Firefox 19:39:18 INFO - mozversion INFO | application_remotingname: firefox 19:39:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:39:18 INFO - mozversion INFO | application_vendor: Mozilla 19:39:18 INFO - mozversion INFO | application_version: 45.0a1 19:39:18 INFO - mozversion INFO | platform_buildid: 20151123185257 19:39:18 INFO - mozversion INFO | platform_changeset: befb8e2645ef77775bbd5ef7eb866fd51b376458 19:39:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:39:18 INFO - mozversion INFO | platform_version: 45.0a1 19:39:18 INFO - 2015-11-23 19:39:18,428 DEBUG : using testdate: 1448336358 19:39:18 INFO - 2015-11-23 19:39:18,428 DEBUG : actual date: 1448336358 19:39:18 INFO - 2015-11-23 19:39:18,815 INFO : starting webserver on 'localhost:56481' 19:39:18 INFO - 2015-11-23 19:39:18,816 INFO : Starting test suite t-yosemite-r7-0027.e 19:39:18 INFO - 2015-11-23 19:39:18,816 INFO : Starting test dromaeo_css 19:39:18 INFO - 2015-11-23 19:39:18,816 DEBUG : operating with platform_type : mac_ 19:39:18 INFO - 2015-11-23 19:39:18,818 INFO : Initialising browser for dromaeo_css test... 19:39:18 INFO - 2015-11-23 19:39:18,830 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpOMav83/profile http://localhost:56481/getInfo.html 19:39:21 INFO - 2015-11-23 19:39:21,613 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:39:21 INFO - 2015-11-23 19:39:21,613 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:39:21 INFO - 2015-11-23 19:39:21,613 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:39:21 INFO - 2015-11-23 19:39:21,613 DEBUG : BROWSER_OUTPUT: __metrics 19:39:22 INFO - 2015-11-23 19:39:22,227 INFO : Browser initialized. 19:39:22 INFO - 2015-11-23 19:39:22,228 INFO : Running cycle 1/1 for dromaeo_css test... 19:39:22 INFO - 2015-11-23 19:39:22,228 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpOMav83/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:39:34 INFO - 2015-11-23 19:39:34,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 236392448 19:39:34 INFO - 2015-11-23 19:39:34,200 DEBUG : BROWSER_OUTPUT: 19:40:23 INFO - 2015-11-23 19:40:23,864 DEBUG : BROWSER_OUTPUT: 1448336423862 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] 19:42:34 INFO - 2015-11-23 19:42:34,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56481/tests/dromaeo/cssquery-ext.html) 19:42:35 INFO - 2015-11-23 19:42:35,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 254529536 19:42:35 INFO - 2015-11-23 19:42:35,739 DEBUG : BROWSER_OUTPUT: 19:45:37 INFO - 2015-11-23 19:45:37,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/dromaeo/cssquery-ext.html (next: http://localhost:56481/tests/dromaeo/cssquery-jquery.html) 19:45:38 INFO - 2015-11-23 19:45:38,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 263573504 19:45:38 INFO - 2015-11-23 19:45:38,188 DEBUG : BROWSER_OUTPUT: 19:48:39 INFO - 2015-11-23 19:48:39,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56481/tests/dromaeo/cssquery-mootools.html) 19:48:40 INFO - 2015-11-23 19:48:40,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 264425472 19:48:40 INFO - 2015-11-23 19:48:40,452 DEBUG : BROWSER_OUTPUT: 19:51:42 INFO - 2015-11-23 19:51:42,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56481/tests/dromaeo/cssquery-prototype.html) 19:51:42 INFO - 2015-11-23 19:51:42,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 267673600 19:51:42 INFO - 2015-11-23 19:51:42,641 DEBUG : BROWSER_OUTPUT: 19:54:45 INFO - 2015-11-23 19:54:45,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56481/tests/dromaeo/cssquery-yui.html) 19:54:45 INFO - 2015-11-23 19:54:45,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 270176256 19:54:45 INFO - 2015-11-23 19:54:45,789 DEBUG : BROWSER_OUTPUT: 19:57:48 INFO - 2015-11-23 19:57:48,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/dromaeo/cssquery-yui.html (next: http://localhost:56481/tests/dromaeo/cssquery-dojo.html) 19:57:48 INFO - 2015-11-23 19:57:48,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 273035264 19:57:48 INFO - 2015-11-23 19:57:48,427 DEBUG : BROWSER_OUTPUT: 19:57:48 INFO - 2015-11-23 19:57:48,427 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:57:48 INFO - 2015-11-23 19:57:48,427 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:57:48 INFO - 2015-11-23 19:57:48,427 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:57:48 INFO - 2015-11-23 19:57:48,427 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:57:48 INFO - 2015-11-23 19:57:48,427 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2921.5471601901704;3503.5620547431586;3510.648935106491;3531.434970404734;3550.573931128264;5176.835212077285;5497.39528651848;5917.112433135032;5924.229850119484;5940.88118237635;5658.377578466376;5781.739821708023;5819.214406055181;5830.533557315415;5842.591018628697;5160.6903585784785;5229;5261.552768014713;5357.919631205535;5397.082495975694;5357.598180136486;5393;5415.702136382517;5433.673979561219;5447.891042179154;5098.770555325019;5270.92093618596;5421.322334708161;5427.213054107152;5502.284702988626;5165.328507294028;5267.710275934822;5290.338707661543;5309.814156504503;5311.601629877775;5287.9735601321745;5290.55030322423;5334.519893209591;5360;5369.81205657804;5174.327337446146;5576.609637325389;5708.343540492855;5863.58954873159;5918.2306300181135;6305.905411418832;6312.526560507934;6322.146510221107;6335.176427064498;6338.80983570489;6359.968200159016;6373.9681301593655;6376.521760867953;6394.552381333308;6394.968025159845;5861.677607731573;6000.789972350947;6031.185789918392;6113.816585502442;6163.445289923929;6413.486921046305;6464.385883341075;6484.221893372825;6497.252815926135;6521.380468855451;6252.656103914328;6308.653024083627;6309.558330916791;6317.684115794192;6320.304766475684;6151.800398922167;6220.284667263232;6221.160143380676;6315.431611154926;6356.237251529754;6273.247210334789;6285.654289014056;6299.338569450142;6313;6325.367463253638;5234.2933703949475;6283.560150789493;6312.747490100436;6313.652749098844;6317.210348706411;4902.191138462185;5000.224965130338;5052.747362631853;5072.467390923974;5113.53978141969;4549.749763763025;4556.84051058218;4560.635149188057;4588.197065513522;4620.584147426748;5811.854703632358;5859.2382990211;5903.0260007099205;5957.672328022;5997.490213331916;6217.409346112112;6316.873662526724;6335.176427064452;6336;6359.872802544016;5976.043832986788;5992.940070599326;6014.097885317237;6015.30823955242;6049.637021778707;5366.758495867695;5487.42382049887;5497.285352904177;5602.159676048625;5646.745896434671;5539.169124631257;6431.517636177212;6452.836214123136;6490.253620833664;6531.248906375733;6364.809055728336;6371.331010243857;6388.105665206782;6388.968055159695;6411.711472983634;5467.425920278313;6243.406876346739;6284.120223168668;6350.809475715736;6383.9361606383345;6266.436020758154;6296.0555916612875;6306.527010474141;6320.5891617044745;6325.778597749057;6274.498040156868;6385.936140638534;6423.100765892872;6431.871362572816;6437.163168788027;6081.331053584191;6127.080937859357;6152.138700581832;6167.290761562478;6178.598391104564;6153.230846144232;6171.321154673072;6173.59871608344;6175.876482470415;6196.845078873064;5836;5895.7052147393315;5926.733297001731;6113;6184;5492.835214943558;6066.666333351708;6134.834601026268;6149.815505534841;6255.624662520263;6142.9078563820685;6171.259448866164;6191.9690401547705;6208.844778880383;6241.937580624136 19:57:48 INFO - 2015-11-23 19:57:48,428 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.9185218143369;581.9272590926132;592.7273454211064;634.5304474688729;672.2806596941268;41504.96237594062;41661.166776664446;41823.372649410245;41834.37248441272;41930.79034604831;43409.91475213121;43917.902052448626;44140.55859441405;44251.89370265745;44434.555654443444;9768.804623907517;9866.851997220047;9920.206383489303;9928.6524971626;9948.801023979517;9796.657117000907;9815.754606134868;9855.802883942317;9861.161801246903;9882.209423246159;9794.902050979506;9853.852192217122;9871.407715537054;9898.257630677728;9931.205503559733;9750;9784.217262618973;9786.5596048178;9793.951030244838;9836.90163098367;9594.088561586708;9687.370320929187;9738.464384458852;9758.268129890286;9763.658271960518;39994.60005399938;40004.599954000376;40104.596339128286;40121.39817902734;40296.395554066716;2925.765938724897;3042.7717921156;3156.794808337451;3168.477201261789;3171.5242713592916;28985.420291594262;28988.855055724798;29376.824927002894;29556;29675;2755.1045910079306;2780.304923769058;2801.341684704093;2941.617589713345;2987.118799953997;429473;500282;502732;503703;504433;60955;72444;72531;72734.90897636539;72781.99999999894;59086.704566476896;81080;81245.59377203195;82240.58879705564;83074;16430.1784910754;16441.83558164403;16477.83522164787;16609.920355176873;16698.248578813982;12393.256404615571;12462.314572698408;12463;12532.934700550555;12563;21536.246231381825;22039.228626998298;22305.888470557544;22627.88686056559;22632;8131.349492040623;8179.550124743197;8795.032546419889;9035.277177825757;9480.194183494343;901.8737376767258;945.9195968342631;974.8147851908114;1026.820306446384;1113.1206346985953;24149.637755433683;29859;30013.549796752628;30598.84700576483;30719;962.3071388600197;1111.7887601355878;1179.5105031411867;1195.9581414650445;1226.748516554122;11573.826392604118;12981.870181298065;13391.531296404579;15448.768268475982;15690.450834220748;939676;963343;964739;974139;975527;63194.36805631977;63383.36616633867;63720.68139659272;64148.358516415174;64205.678971604844;1458.3291685824427;1474.1376294867623;1486.3385793321868;1490.1059364381501;1495.1477657735204;31662.05013849588;31680.366392671556;32381.352372951937;33217;33804.3239135211;47385.81535461503;55374;59293.70353148379;59377;60210;480125;481138;484169.5791521161;484889;488268;45703;47387.52612473831;47719.522804772896;48692;48815;46734.53265467438;47181.29228061513;47422.525774741815;47435.76282118567;47496.05007899892;38352.80823595864;38786.4182037264;39528.60471395249;39819;39892;38703;39024.02439939024;39569.406458902566;39632.21655025473;39959.60040399559;37309.06727331838;38651.806740966116;38739.41890871696;38753;38781.41827872528;33335.166620833705;33514.83242583869;34425.139371515914;34458.65541344655;34467.4829877547;21856.562868742854;23899.880500597385;24623.891924863066;26216.34459138537;26464 19:57:48 INFO - 2015-11-23 19:57:48,432 DEBUG : BROWSER_OUTPUT: |2;jquery.html;314.00930065642905;317.6569305150437;361.6690727983893;367.87124506422754;370.7275152762719;16266;19202.23191072359;19538;20657;21613.13547458104;20005.399838004847;20601.587968240627;20757.065932033056;20827.27104551341;20969.16123355064;5905.20279762232;5908.261467316585;6065.454109130177;6069.0592958091565;6091.390860913895;3808.409696497047;4440.178566965122;5603.60774745768;6365.663210725753;6450.612963222198;5876.44173803488;6464.277151762161;6530.6408147551865;6535.509836762238;6558.409743123118;6510.739570417178;6520.315366886503;6523.7716679915975;6543.541952063358;6567.113439685677;5497.862553436156;5571.693556854371;5615.157726341041;5615.354234263071;5650.124230744241;24507.2844900857;25039.12363067302;25227.11705090313;25364.746352536422;25684.743152568422;2057.5473395852887;2071.7099606055162;2142.914283428661;2264.8074913632363;2391.7847393734473;8373.539455329954;8976.730698079004;9549.713508594683;9550.37922535033;9782.119609235131;1738.8869723467933;1755.7541944127831;1779.030428416516;1825.8813177143577;1827.4883032750718;85151;100244.49877750638;104471;106905;107063.3234169152;8913;10848.18638602108;10964.780704385868;11056.557737690564;11072.169587280987;13034.217946923214;13046.347682615831;13076.542321018718;13112;13212.273324967218;7963.960180199062;8154.5514996674565;8196.057453392817;8289.58552072394;8291.58542072894;8141.104478507359;8227.341812654973;8254.42219044673;8326.750197494084;8359.331253499828;4213.157368526246;4240.533541310453;4246.978765106154;4247.766372849461;4287.892802679896;1752.3341130370377;1812.0939530234882;1817.8363947244811;1818.399928023749;1864.412709996374;397.0015411240732;857.7812657772229;968.934172410343;995.1292618958412;999.6857275407409;10694.62568810088;11101.389423581619;11485.310881347146;11684.415779211175;11723.472443740053;439.3804735323179;440.33509400805013;447.55691865053365;452.19960669614596;454.2686275097091;5116.386033675983;5992.790252341147;6102.267727872595;6103.298120716175;6201.937980620136;705623;708180;708403;709331;714689;100571;114869.4256528712;124794.37602811928;125214;126912.36543817222;418.3661752445048;436.28667129243917;479.4079312049686;482.235656484476;482.27176962786444;11090.5563777448;11100.833487497532;11153.051990580892;11156;11175.664730058112;46217;46339;46890.76554617205;46912;47459.05081898412;69328.30671693219;70061.64969175121;70544.6472767633;71623.28376716166;71811;8125.8374832504205;9756.414615123116;9965.750856228362;9991.950040249752;10030.348027378197;12005.63983080509;12013.099017573542;14088.295585220492;16036.438724644582;18644;8573.91426085756;8984.921809382917;15554.688906221585;16083.517494475185;16264.268107935408;15485.303161357991;15635.29641166173;15942.123183225034;16013.95909265894;16290.10404427768;14921.850781492047;15261.008034478167;16182.757258640895;16195.514134575982;17194.054327012134;9603.135717785433;9610.183134433652;9771.169450596779;9842.950785246028;9851.113399793767;10271.589136434459;10290.742731431774;11297.604583839526;15894.761578576099;16384.75422868682 19:57:48 INFO - 2015-11-23 19:57:48,433 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1528.5032364481547;1583.9287232074555;1757.9296828126876;1877.4836919847048;1901.8098190180983;7761.495502792314;7915.564643944581;8529.10444403338;8755.3433492488;8832.60253288602;8270.172982701726;8412.537310447922;8505.44714593551;8536.829263414727;8562.571871406435;2343.461003969084;2369.845960012594;2379.119725701484;2382.1662418153683;2389.7968672662846;2366.550355432471;2388.176079252664;2402.3753824005707;2421.4793819328843;2423.866687332205;2334.4280651240383;2350.7061617297836;2356.140008896749;2369.798567121788;2385.95228095438;1883.0302394266964;2159.438545978057;2349.8707571083582;2360.114956891166;2367.7277113132036;2405.374602603318;2406.831521793475;2429.4898071405028;2434.793042591382;2436.110819550869;8541.530215838126;8620.784480387978;8622.870656940151;8627.525486098262;8632.65469381224;5209.921851172197;5232.633715639907;5277.340332458442;5297.814576489843;5324.92012619811;3478.4434490481653;3511.9648803511895;3537.5224344713392;3553.6091029986683;3563.251717139404;893.4326702543866;1044.5560636729435;1048.638219814163;1074.0655629602218;1075.5536452372335;11184.664460066211;11198.216124871262;11223.943880280547;11263.380514071723;11263.831042534368;4279.914401712011;4389;4633.606143477775;4693.55411235932;4720.693154944917;9535.2371810255;9560.474173920502;9728.659496917715;9750;9767.755806104904;5243.344581927259;5257.185136303879;5262.7631756571045;5289.841304760864;5315.3090098286975;3612.476190952297;4362.8036738346855;4738.3840100787365;4779.259214821708;4807.134715751198;3899.083715326896;3903.921921561553;3905;3937.858021173885;3954.347532657137;1163.4066626020622;1307.6207899708977;1317.413750880868;1320.6368248731483;1328.4885319152197;1312.0422091872986;1334;1334.5529247701934;1377.3182274774051;1383.5365152673967;6974.337437943387;7822.022247219098;7920.4455688102435;7998.960005200053;8019.7995050123045;501.6237821633775;509.45233873586045;509.8597885581495;510.5583670125315;513.9717315547606;6034.559676411966;6077.75688972445;6132.601380910227;6171.876562468726;6177.660228687376;10160.237982151368;10266.127379172705;10327.896721032845;10337.534810933526;10391.220658450646;8652.956735216283;9869.309148359545;10037.548310325907;10145.543450544743;10387.584496620051;7943.046834379911;7968.282854543119;7995.520268783892;8017.559034253055;8047.879281810778;7502.924970750222;7568.356689681439;7597.050368703912;7602.50583712057;7613.695452182073;8884.37809353339;9000.189982901571;9172.724818255463;9182.67860624875;9235.1688348049;9290.16388525036;9328.253739700673;9341.953290233778;9448.007959164188;9506.667266645634;5641.915371269516;6667.899981500378;6814.522983391314;7383.224761399975;7385;8057.355411567178;8081.87877181831;8087.231712987257;8089.635966381645;8100.71647492335;7424.406047516078;7571.091469023752;7577.696892124253;7673.731419400294;7763.262490063435;7238.565686058853;7544.358729508053;7559.659815308214;7668.769936901902;7675.462717609714;6567.802965911031;7658.540487570541;7665.463417560717;7700.114486834086;7734.806629834074;6882.896756548756;6997.545159564612;7005.54463959841;7025.964870175821;7031.542949708252;7100.893486597808;7121.750738724327;7128.786136415916;7132.679029443584;7196.388306993964 19:57:48 INFO - 2015-11-23 19:57:48,435 DEBUG : BROWSER_OUTPUT: |4;prototype.html;287.552855309993;299.30411792582254;331.6087017319565;333.26847569584754;335.5235565496993;6878.140232470942;6950.65246737663;6951.548149370287;7119.288071192878;7153.995321964774;6784.966075169617;6923.896141557881;6934.549254298467;6948.339907708772;7013.649317534128;4307.590778876001;5000.449950505442;5046.091703493379;5051.368578927634;5068.847934561969;4859.902801943959;5047.68760122369;5060.54455099041;5066.847994560169;5098.235264710286;4442.911141777178;4603.378543896564;4963.305137280783;4980.27785971034;5009;4091.89770255743;4937.012597480482;4959.156943319645;4985.775640096204;4991.7504124793795;4058.6753059755147;4170.91658166838;4175.10235299409;4217.313074770086;4252.362145678142;5828.388019257959;6216.03651434024;6644.136262285921;6669.633170175638;6695.497837662146;5093.312402825608;5916.544633976894;5963.105534169866;5970.6716130612795;5993.0710739835395;6070.8785824283705;7210.963945180293;7349.926500735031;7445.590492522909;7501.512401693873;3930.5872883347124;4720.976395118037;4763.095011947754;4767.070421267854;4770.809167633291;6859.348361905561;7512.248775122444;7856.371490280764;7967.482113662593;7985.201479852027;4676.672632915664;4809.591184749335;4812.7968007998;4821.059893320768;4830.903381932341;4220.746755194698;4773.639512738922;4881.145799485076;4903.705777653352;4927.113119638428;5925.40745925404;5944.048952167633;5945.0785128304315;5955.40445955401;5993.0710739835395;7584.165741768401;7602;7604.060964454029;7613.581253031137;7616.04799400075;1417.5463851567606;1432.8065711129072;1662;1698.1763844535637;1721.2942693495606;998.5007496251874;1068.983965240522;1089.7874914391775;1092.1099304067159;1103.5585765693786;6902.758403455855;6910.412614927687;6938.687759050855;6941.375276225063;6968.338007889242;6560.8359791005605;6659.801235777607;7642;7732.884006739903;7738.303552680286;6838.350356716203;6888.450098727846;6899.793006209822;6924;7116.5018448709125;3433.8454769535433;4052.3313653247474;4101.405296232089;4154.189932963043;4166.354215096665;6610.2398224204835;8175.345972322319;8185.590720464072;8238.382121340923;8248.46384984986;7996.720114795954;8181.79545511367;8226.424150309422;8231.917680823235;8274.917250827535;8176.550289734122;8187.71343002992;8217.753467395987;8225.218604232588;8225.917740822515;7872.937153484207;7891.053073631201;7926.048874135141;7931.36549076061;7937.880931786143;7594.8860767089645;7772.533647981139;7791.0650721913735;7806.4925779824125;7827;6583.868322633616;6583.934160658524;8174.754757357289;8176.877346839921;8202.753917382488;4780.378550788375;4808.677613656272;4810.302506136521;4819.831305904277;4833.613310935187;7616.23837616234;7788.143304236416;7801;7820.960895195488;7848.646810893638;6136.570440069331;7512;7541.849163016818;7545.886811697938;7551.848963020599;6365.331640177715;7277.9272207277245;7391.669499490144;7505.549667019996;7553.244675532403;7305.634718264172;7310.488265821342;7339.247782081719;7342.926570734225;7343.632818359168;7501.174870764103;7520.924790752022;7527.322540971339;7530.811729706801;7554.508956917783;5884.411558844081;5927.792527261698;6172;6853.451723861979;7309.707611695472 19:57:48 INFO - 2015-11-23 19:57:48,438 DEBUG : BROWSER_OUTPUT: |5;yui.html;736.4108713029575;744.147950596567;764.5374548398219;775.4339332287431;856.0070318430621;14849.925750371247;15268.923655381735;15565.29956151973;15590.220488975563;15627.765583516242;10818.459077046136;12766.80849787254;13992.950528710362;14023.649408764786;14040.859591404083;762.4586543554083;776.3595034096865;959.4387283439196;985.3939827006375;986.5461887531744;949.9667511637094;960.231814548362;969.0551712080735;969.7478655549537;984.394597322645;1026.6765968719828;1037.2842738510442;1047.1988928469727;1050.789842031593;1051.7002654243543;1014.518103900645;1015.1168483419399;1017.6692574913109;1032.3960483117385;1033.7105610429055;630.4798541203479;752.7365422102275;755.2447552447552;765.9770206893802;771.8456308738275;14820.555383338517;14934.402623895032;14999.32503037355;15042.172680502568;15249.560070388796;12738.426770795337;12739.171953823065;12767;13054.86945130546;13095.541656042087;8357.749267521924;10018.448985305806;10326.793464130675;10559.26085174038;10891.400972946485;3509.6314886937016;3561.7684850484634;3630.6187850275605;3668.394714872043;3723.255348930225;81662.59168704179;82242.58878705629;82335;83850.32299353978;84359.99999999939;9505.524723763785;9865;9980.001999800108;10032.448215348226;10366.533505992249;21623.783762162493;21895.01472433744;22149.44626384321;22403.327900162694;22482.662760058283;7340.0457940467395;7487.625618719151;7631.313181813553;7678.424118191158;7710.498817576951;3460.2387474755515;4052.169305292408;4055.6755459563165;4066.8576599819457;4077.001134722012;3413.3343997920665;3419.9658003420145;3437.05480992729;3456.980190843707;3458.8097654629237;602.2532060245264;615.4522474997256;621.1490258346095;635.291649810458;635.3011687144104;507.5508175264917;533.2960492150324;581;583.2971269620098;590.1266126133347;8659.307255419551;8710.869336959951;8713.477191368538;8725.520096394632;8931.464112153291;495.5812338573899;521.8434469659087;544.9509544140967;553.4327314502667;596.4870211618005;3410.658934106619;4042.818073186655;4209.726367786084;4265.253580623378;4286.8499602514385;96680.03319966851;97788;99605;99863;100237;84113.73829392563;84502;84503.5774821122;84507.5774621123;88395.11604883868;69856.60286794236;74437;74553.25446745571;75725.62137189279;77367.22632773712;8942.239909607757;9001.324900632348;9079.68221112258;9229.723108306762;9315.86026209621;49196;50080.99838003292;54738.45261547333;55822.88354232811;55871.44128558825;69133.65433172802;69477.65261173662;75053;75057.62471187828;77208.61395693211;10707.57169713234;11011.889881101086;11381.54473821038;11400.94299528497;11915.52337906474;12185.51257949672;12517.374131293216;12553.058520611174;12635.873641263837;12683.731626837243;11162.38606876597;11420.31478111316;11567.479463423997;11615.303081815118;12362.44369003379;11374.601888933848;11811.704707382385;11890.34603096838;11936.940315298369;12270.386480676108;11079.72300692489;11595.652130436101;11706.473208705798;11713.590024349107;12261.38693065361;9355.298352623717;9643;9929.950350248202;10423.53094110782;10513.684589462327;8943.195112439911;9311.953440233026;9930.900690993287;9948.722049518776;10030.047145521165 19:57:48 INFO - 2015-11-23 19:57:48,438 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:57:48 INFO - 2015-11-23 19:57:48,438 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:57:48 INFO - 2015-11-23 19:57:48,438 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,340 19:57:48 INFO - 2015-11-23 19:57:48,438 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:57:48 INFO - 2015-11-23 19:57:48,438 DEBUG : BROWSER_OUTPUT: __startTimestamp1448337468423__endTimestamp 19:57:48 INFO - 2015-11-23 19:57:48,439 DEBUG : BROWSER_OUTPUT: 19:57:48 INFO - 2015-11-23 19:57:48,439 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:57:48 INFO - 2015-11-23 19:57:48,439 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:57:48 INFO - 2015-11-23 19:57:48,439 DEBUG : BROWSER_OUTPUT: 19:57:48 INFO - 2015-11-23 19:57:48,439 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5839.55 Median:6113.00 stddev:651.15 (10.7%) stddev-sans-first:611.59 19:57:48 INFO - 2015-11-23 19:57:48,439 DEBUG : BROWSER_OUTPUT: Values: 2921.5 3503.6 3510.6 3531.4 3550.6 5176.8 5497.4 5917.1 5924.2 5940.9 5658.4 5781.7 5819.2 5830.5 5842.6 5160.7 5229.0 5261.6 5357.9 5397.1 5357.6 5393.0 5415.7 5433.7 5447.9 5098.8 5270.9 5421.3 5427.2 5502.3 5165.3 5267.7 5290.3 5309.8 5311.6 5288.0 5290.6 5334.5 5360.0 5369.8 5174.3 5576.6 5708.3 5863.6 5918.2 6305.9 6312.5 6322.1 6335.2 6338.8 6360.0 6374.0 6376.5 6394.6 6395.0 5861.7 6000.8 6031.2 6113.8 6163.4 6413.5 6464.4 6484.2 6497.3 6521.4 6252.7 6308.7 6309.6 6317.7 6320.3 6151.8 6220.3 6221.2 6315.4 6356.2 6273.2 6285.7 6299.3 6313.0 6325.4 5234.3 6283.6 6312.7 6313.7 6317.2 4902.2 5000.2 5052.7 5072.5 5113.5 4549.7 4556.8 4560.6 4588.2 4620.6 5811.9 5859.2 5903.0 5957.7 5997.5 6217.4 6316.9 6335.2 6336.0 6359.9 5976.0 5992.9 6014.1 6015.3 6049.6 5366.8 5487.4 5497.3 5602.2 5646.7 5539.2 6431.5 6452.8 6490.3 6531.2 6364.8 6371.3 6388.1 6389.0 6411.7 5467.4 6243.4 6284.1 6350.8 6383.9 6266.4 6296.1 6306.5 6320.6 6325.8 6274.5 6385.9 6423.1 6431.9 6437.2 6081.3 6127.1 6152.1 6167.3 6178.6 6153.2 6171.3 6173.6 6175.9 6196.8 5836.0 5895.7 5926.7 6113.0 6184.0 5492.8 6066.7 6134.8 6149.8 6255.6 6142.9 6171.3 6192.0 6208.8 6241.9 19:57:48 INFO - 2015-11-23 19:57:48,439 DEBUG : BROWSER_OUTPUT: 19:57:48 INFO - 2015-11-23 19:57:48,439 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:78432.11 Median:235701.90 stddev:184528.75 (78.3%) stddev-sans-first:184953.78 19:57:48 INFO - 2015-11-23 19:57:48,441 DEBUG : BROWSER_OUTPUT: Values: 561.9 581.9 592.7 634.5 672.3 41505.0 41661.2 41823.4 41834.4 41930.8 43409.9 43917.9 44140.6 44251.9 44434.6 9768.8 9866.9 9920.2 9928.7 9948.8 9796.7 9815.8 9855.8 9861.2 9882.2 9794.9 9853.9 9871.4 9898.3 9931.2 9750.0 9784.2 9786.6 9794.0 9836.9 9594.1 9687.4 9738.5 9758.3 9763.7 39994.6 40004.6 40104.6 40121.4 40296.4 2925.8 3042.8 3156.8 3168.5 3171.5 28985.4 28988.9 29376.8 29556.0 29675.0 2755.1 2780.3 2801.3 2941.6 2987.1 429473.0 500282.0 502732.0 503703.0 504433.0 60955.0 72444.0 72531.0 72734.9 72782.0 59086.7 81080.0 81245.6 82240.6 83074.0 16430.2 16441.8 16477.8 16609.9 16698.2 12393.3 12462.3 12463.0 12532.9 12563.0 21536.2 22039.2 22305.9 22627.9 22632.0 8131.3 8179.6 8795.0 9035.3 9480.2 901.9 945.9 974.8 1026.8 1113.1 24149.6 29859.0 30013.5 30598.8 30719.0 962.3 1111.8 1179.5 1196.0 1226.7 11573.8 12981.9 13391.5 15448.8 15690.5 939676.0 963343.0 964739.0 974139.0 975527.0 63194.4 63383.4 63720.7 64148.4 64205.7 1458.3 1474.1 1486.3 1490.1 1495.1 31662.1 31680.4 32381.4 33217.0 33804.3 47385.8 55374.0 59293.7 59377.0 60210.0 480125.0 481138.0 484169.6 484889.0 488268.0 45703.0 47387.5 47719.5 48692.0 48815.0 46734.5 47181.3 47422.5 47435.8 47496.1 38352.8 38786.4 39528.6 39819.0 39892.0 38703.0 39024.0 39569.4 39632.2 39959.6 37309.1 38651.8 38739.4 38753.0 38781.4 33335.2 33514.8 34425.1 34458.7 34467.5 21856.6 23899.9 24623.9 26216.3 26464.0 19:57:48 INFO - 2015-11-23 19:57:48,441 DEBUG : BROWSER_OUTPUT: 19:57:48 INFO - 2015-11-23 19:57:48,441 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:36736.18 Median:4226.85 stddev:116956.81 (2767.0%) stddev-sans-first:117252.93 19:57:48 INFO - 2015-11-23 19:57:48,442 DEBUG : BROWSER_OUTPUT: Values: 314.0 317.7 361.7 367.9 370.7 16266.0 19202.2 19538.0 20657.0 21613.1 20005.4 20601.6 20757.1 20827.3 20969.2 5905.2 5908.3 6065.5 6069.1 6091.4 3808.4 4440.2 5603.6 6365.7 6450.6 5876.4 6464.3 6530.6 6535.5 6558.4 6510.7 6520.3 6523.8 6543.5 6567.1 5497.9 5571.7 5615.2 5615.4 5650.1 24507.3 25039.1 25227.1 25364.7 25684.7 2057.5 2071.7 2142.9 2264.8 2391.8 8373.5 8976.7 9549.7 9550.4 9782.1 1738.9 1755.8 1779.0 1825.9 1827.5 85151.0 100244.5 104471.0 106905.0 107063.3 8913.0 10848.2 10964.8 11056.6 11072.2 13034.2 13046.3 13076.5 13112.0 13212.3 7964.0 8154.6 8196.1 8289.6 8291.6 8141.1 8227.3 8254.4 8326.8 8359.3 4213.2 4240.5 4247.0 4247.8 4287.9 1752.3 1812.1 1817.8 1818.4 1864.4 397.0 857.8 968.9 995.1 999.7 10694.6 11101.4 11485.3 11684.4 11723.5 439.4 440.3 447.6 452.2 454.3 5116.4 5992.8 6102.3 6103.3 6201.9 705623.0 708180.0 708403.0 709331.0 714689.0 100571.0 114869.4 124794.4 125214.0 126912.4 418.4 436.3 479.4 482.2 482.3 11090.6 11100.8 11153.1 11156.0 11175.7 46217.0 46339.0 46890.8 46912.0 47459.1 69328.3 70061.6 70544.6 71623.3 71811.0 8125.8 9756.4 9965.8 9992.0 10030.3 12005.6 12013.1 14088.3 16036.4 18644.0 8573.9 8984.9 15554.7 16083.5 16264.3 15485.3 15635.3 15942.1 16014.0 16290.1 14921.9 15261.0 16182.8 16195.5 17194.1 9603.1 9610.2 9771.2 9843.0 9851.1 10271.6 10290.7 11297.6 15894.8 16384.8 19:57:48 INFO - 2015-11-23 19:57:48,442 DEBUG : BROWSER_OUTPUT: 19:57:48 INFO - 2015-11-23 19:57:48,442 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5850.52 Median:5320.11 stddev:3069.84 (57.7%) stddev-sans-first:3061.27 19:57:48 INFO - 2015-11-23 19:57:48,444 DEBUG : BROWSER_OUTPUT: Values: 1528.5 1583.9 1757.9 1877.5 1901.8 7761.5 7915.6 8529.1 8755.3 8832.6 8270.2 8412.5 8505.4 8536.8 8562.6 2343.5 2369.8 2379.1 2382.2 2389.8 2366.6 2388.2 2402.4 2421.5 2423.9 2334.4 2350.7 2356.1 2369.8 2386.0 1883.0 2159.4 2349.9 2360.1 2367.7 2405.4 2406.8 2429.5 2434.8 2436.1 8541.5 8620.8 8622.9 8627.5 8632.7 5209.9 5232.6 5277.3 5297.8 5324.9 3478.4 3512.0 3537.5 3553.6 3563.3 893.4 1044.6 1048.6 1074.1 1075.6 11184.7 11198.2 11223.9 11263.4 11263.8 4279.9 4389.0 4633.6 4693.6 4720.7 9535.2 9560.5 9728.7 9750.0 9767.8 5243.3 5257.2 5262.8 5289.8 5315.3 3612.5 4362.8 4738.4 4779.3 4807.1 3899.1 3903.9 3905.0 3937.9 3954.3 1163.4 1307.6 1317.4 1320.6 1328.5 1312.0 1334.0 1334.6 1377.3 1383.5 6974.3 7822.0 7920.4 7999.0 8019.8 501.6 509.5 509.9 510.6 514.0 6034.6 6077.8 6132.6 6171.9 6177.7 10160.2 10266.1 10327.9 10337.5 10391.2 8653.0 9869.3 10037.5 10145.5 10387.6 7943.0 7968.3 7995.5 8017.6 8047.9 7502.9 7568.4 7597.1 7602.5 7613.7 8884.4 9000.2 9172.7 9182.7 9235.2 9290.2 9328.3 9342.0 9448.0 9506.7 5641.9 6667.9 6814.5 7383.2 7385.0 8057.4 8081.9 8087.2 8089.6 8100.7 7424.4 7571.1 7577.7 7673.7 7763.3 7238.6 7544.4 7559.7 7668.8 7675.5 6567.8 7658.5 7665.5 7700.1 7734.8 6882.9 6997.5 7005.5 7026.0 7031.5 7100.9 7121.8 7128.8 7132.7 7196.4 19:57:48 INFO - 2015-11-23 19:57:48,444 DEBUG : BROWSER_OUTPUT: 19:57:48 INFO - 2015-11-23 19:57:48,444 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6005.00 Median:6811.66 stddev:1999.99 (29.4%) stddev-sans-first:1959.02 19:57:48 INFO - 2015-11-23 19:57:48,445 DEBUG : BROWSER_OUTPUT: Values: 287.6 299.3 331.6 333.3 335.5 6878.1 6950.7 6951.5 7119.3 7154.0 6785.0 6923.9 6934.5 6948.3 7013.6 4307.6 5000.4 5046.1 5051.4 5068.8 4859.9 5047.7 5060.5 5066.8 5098.2 4442.9 4603.4 4963.3 4980.3 5009.0 4091.9 4937.0 4959.2 4985.8 4991.8 4058.7 4170.9 4175.1 4217.3 4252.4 5828.4 6216.0 6644.1 6669.6 6695.5 5093.3 5916.5 5963.1 5970.7 5993.1 6070.9 7211.0 7349.9 7445.6 7501.5 3930.6 4721.0 4763.1 4767.1 4770.8 6859.3 7512.2 7856.4 7967.5 7985.2 4676.7 4809.6 4812.8 4821.1 4830.9 4220.7 4773.6 4881.1 4903.7 4927.1 5925.4 5944.0 5945.1 5955.4 5993.1 7584.2 7602.0 7604.1 7613.6 7616.0 1417.5 1432.8 1662.0 1698.2 1721.3 998.5 1069.0 1089.8 1092.1 1103.6 6902.8 6910.4 6938.7 6941.4 6968.3 6560.8 6659.8 7642.0 7732.9 7738.3 6838.4 6888.5 6899.8 6924.0 7116.5 3433.8 4052.3 4101.4 4154.2 4166.4 6610.2 8175.3 8185.6 8238.4 8248.5 7996.7 8181.8 8226.4 8231.9 8274.9 8176.6 8187.7 8217.8 8225.2 8225.9 7872.9 7891.1 7926.0 7931.4 7937.9 7594.9 7772.5 7791.1 7806.5 7827.0 6583.9 6583.9 8174.8 8176.9 8202.8 4780.4 4808.7 4810.3 4819.8 4833.6 7616.2 7788.1 7801.0 7821.0 7848.6 6136.6 7512.0 7541.8 7545.9 7551.8 6365.3 7277.9 7391.7 7505.5 7553.2 7305.6 7310.5 7339.2 7342.9 7343.6 7501.2 7520.9 7527.3 7530.8 7554.5 5884.4 5927.8 6172.0 6853.5 7309.7 19:57:48 INFO - 2015-11-23 19:57:48,445 DEBUG : BROWSER_OUTPUT: 19:57:48 INFO - 2015-11-23 19:57:48,445 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19231.25 Median:24845.79 stddev:27457.19 (110.5%) stddev-sans-first:27499.09 19:57:48 INFO - 2015-11-23 19:57:48,446 DEBUG : BROWSER_OUTPUT: Values: 736.4 744.1 764.5 775.4 856.0 14849.9 15268.9 15565.3 15590.2 15627.8 10818.5 12766.8 13993.0 14023.6 14040.9 762.5 776.4 959.4 985.4 986.5 950.0 960.2 969.1 969.7 984.4 1026.7 1037.3 1047.2 1050.8 1051.7 1014.5 1015.1 1017.7 1032.4 1033.7 630.5 752.7 755.2 766.0 771.8 14820.6 14934.4 14999.3 15042.2 15249.6 12738.4 12739.2 12767.0 13054.9 13095.5 8357.7 10018.4 10326.8 10559.3 10891.4 3509.6 3561.8 3630.6 3668.4 3723.3 81662.6 82242.6 82335.0 83850.3 84360.0 9505.5 9865.0 9980.0 10032.4 10366.5 21623.8 21895.0 22149.4 22403.3 22482.7 7340.0 7487.6 7631.3 7678.4 7710.5 3460.2 4052.2 4055.7 4066.9 4077.0 3413.3 3420.0 3437.1 3457.0 3458.8 602.3 615.5 621.1 635.3 635.3 507.6 533.3 581.0 583.3 590.1 8659.3 8710.9 8713.5 8725.5 8931.5 495.6 521.8 545.0 553.4 596.5 3410.7 4042.8 4209.7 4265.3 4286.8 96680.0 97788.0 99605.0 99863.0 100237.0 84113.7 84502.0 84503.6 84507.6 88395.1 69856.6 74437.0 74553.3 75725.6 77367.2 8942.2 9001.3 9079.7 9229.7 9315.9 49196.0 50081.0 54738.5 55822.9 55871.4 69133.7 69477.7 75053.0 75057.6 77208.6 10707.6 11011.9 11381.5 11400.9 11915.5 12185.5 12517.4 12553.1 12635.9 12683.7 11162.4 11420.3 11567.5 11615.3 12362.4 11374.6 11811.7 11890.3 11936.9 12270.4 11079.7 11595.7 11706.5 11713.6 12261.4 9355.3 9643.0 9930.0 10423.5 10513.7 8943.2 9312.0 9930.9 9948.7 10030.0 19:57:48 INFO - 2015-11-23 19:57:48,447 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:57:48 INFO - 2015-11-23 19:57:48,447 DEBUG : BROWSER_OUTPUT: 19:57:48 INFO - 2015-11-23 19:57:48,853 INFO : Browser exited with error code: 0 19:57:48 INFO - 2015-11-23 19:57:48,879 INFO : Completed test dromaeo_css (00:18:30) 19:57:48 INFO - 2015-11-23 19:57:48,879 INFO : Starting test kraken 19:57:48 INFO - 2015-11-23 19:57:48,879 DEBUG : operating with platform_type : mac_ 19:57:48 INFO - 2015-11-23 19:57:48,879 INFO : Initialising browser for kraken test... 19:57:48 INFO - 2015-11-23 19:57:48,892 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpKYlyv1/profile http://localhost:56481/getInfo.html 19:57:51 INFO - 2015-11-23 19:57:51,766 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:57:51 INFO - 2015-11-23 19:57:51,767 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:57:51 INFO - 2015-11-23 19:57:51,767 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:57:51 INFO - 2015-11-23 19:57:51,767 DEBUG : BROWSER_OUTPUT: __metrics 19:57:52 INFO - 2015-11-23 19:57:52,419 INFO : Browser initialized. 19:57:52 INFO - 2015-11-23 19:57:52,419 INFO : Running cycle 1/1 for kraken test... 19:57:52 INFO - 2015-11-23 19:57:52,419 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpKYlyv1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:58:04 INFO - 2015-11-23 19:58:04,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 236519424 19:58:04 INFO - 2015-11-23 19:58:04,354 DEBUG : BROWSER_OUTPUT: 19:58:06 INFO - 2015-11-23 19:58:06,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56481/tests/kraken/driver.html?testName=audio-beat-detection) 19:58:07 INFO - 2015-11-23 19:58:07,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 249073664 19:58:07 INFO - 2015-11-23 19:58:07,607 DEBUG : BROWSER_OUTPUT: 19:58:10 INFO - 2015-11-23 19:58:10,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56481/tests/kraken/driver.html?testName=audio-dft) 19:58:10 INFO - 2015-11-23 19:58:10,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 259350528 19:58:10 INFO - 2015-11-23 19:58:10,733 DEBUG : BROWSER_OUTPUT: 19:58:14 INFO - 2015-11-23 19:58:14,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56481/tests/kraken/driver.html?testName=audio-fft) 19:58:14 INFO - 2015-11-23 19:58:14,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 262180864 19:58:14 INFO - 2015-11-23 19:58:14,705 DEBUG : BROWSER_OUTPUT: 19:58:16 INFO - 2015-11-23 19:58:16,633 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56481/tests/kraken/driver.html?testName=audio-oscillator) 19:58:17 INFO - 2015-11-23 19:58:17,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 262524928 19:58:17 INFO - 2015-11-23 19:58:17,224 DEBUG : BROWSER_OUTPUT: 19:58:19 INFO - 2015-11-23 19:58:19,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56481/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:58:19 INFO - 2015-11-23 19:58:19,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 263667712 19:58:19 INFO - 2015-11-23 19:58:19,882 DEBUG : BROWSER_OUTPUT: 19:58:22 INFO - 2015-11-23 19:58:22,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56481/tests/kraken/driver.html?testName=imaging-darkroom) 19:58:23 INFO - 2015-11-23 19:58:23,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 264187904 19:58:23 INFO - 2015-11-23 19:58:23,162 DEBUG : BROWSER_OUTPUT: 19:58:26 INFO - 2015-11-23 19:58:26,202 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56481/tests/kraken/driver.html?testName=imaging-desaturate) 19:58:26 INFO - 2015-11-23 19:58:26,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 263208960 19:58:26 INFO - 2015-11-23 19:58:26,802 DEBUG : BROWSER_OUTPUT: 19:58:29 INFO - 2015-11-23 19:58:29,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56481/tests/kraken/driver.html?testName=json-parse-financial) 19:58:30 INFO - 2015-11-23 19:58:30,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 263434240 19:58:30 INFO - 2015-11-23 19:58:30,543 DEBUG : BROWSER_OUTPUT: 19:58:32 INFO - 2015-11-23 19:58:32,044 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56481/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:58:32 INFO - 2015-11-23 19:58:32,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 263376896 19:58:32 INFO - 2015-11-23 19:58:32,634 DEBUG : BROWSER_OUTPUT: 19:58:34 INFO - 2015-11-23 19:58:34,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56481/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:58:35 INFO - 2015-11-23 19:58:35,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 265388032 19:58:35 INFO - 2015-11-23 19:58:35,025 DEBUG : BROWSER_OUTPUT: 19:58:37 INFO - 2015-11-23 19:58:37,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56481/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:58:37 INFO - 2015-11-23 19:58:37,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 265306112 19:58:37 INFO - 2015-11-23 19:58:37,779 DEBUG : BROWSER_OUTPUT: 19:58:40 INFO - 2015-11-23 19:58:40,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:58:40 INFO - 2015-11-23 19:58:40,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 265113600 19:58:40 INFO - 2015-11-23 19:58:40,917 DEBUG : BROWSER_OUTPUT: 19:58:43 INFO - 2015-11-23 19:58:43,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:58:43 INFO - 2015-11-23 19:58:43,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 265428992 19:58:43 INFO - 2015-11-23 19:58:43,945 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56481/tests/kraken/driver.html?testName=ai-astar) 19:58:45 INFO - 2015-11-23 19:58:45,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 264560640 19:58:45 INFO - 2015-11-23 19:58:45,803 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,803 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:58:45 INFO - 2015-11-23 19:58:45,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:58:45 INFO - 2015-11-23 19:58:45,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:58:45 INFO - 2015-11-23 19:58:45,803 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:58:45 INFO - 2015-11-23 19:58:45,803 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;107;115;114;114;126;113;119;162;114 19:58:45 INFO - 2015-11-23 19:58:45,803 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;122;160;148;124;139;122;162;146;118 19:58:45 INFO - 2015-11-23 19:58:45,803 DEBUG : BROWSER_OUTPUT: |2;audio-dft;245;278;195;190;202;222;219;204;201;199 19:58:45 INFO - 2015-11-23 19:58:45,804 DEBUG : BROWSER_OUTPUT: |3;audio-fft;55;63;63;64;120;87;82;69;60;111 19:58:45 INFO - 2015-11-23 19:58:45,804 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;78;77;109;102;113;112;111;77;78;104 19:58:45 INFO - 2015-11-23 19:58:45,804 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;106;89;88;88;89;88;89;89;87;88 19:58:45 INFO - 2015-11-23 19:58:45,804 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;151;151;95;129;149;97;104;94;96;95 19:58:45 INFO - 2015-11-23 19:58:45,804 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;145;126;148;87;151;137;128;91;94;91 19:58:45 INFO - 2015-11-23 19:58:45,804 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;59;59;58;60;61;66;58;58 19:58:45 INFO - 2015-11-23 19:58:45,804 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;64;65;64;65;67;67;68;69;69 19:58:45 INFO - 2015-11-23 19:58:45,804 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;84;85;84;83;105;111;114;108;83 19:58:45 INFO - 2015-11-23 19:58:45,804 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;137;132;135;123;141;122;132;134;132 19:58:45 INFO - 2015-11-23 19:58:45,804 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;138;144;137;146;140;137;137;141;142 19:58:45 INFO - 2015-11-23 19:58:45,804 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;61;64;67;66;64;65;66;68;67;64 19:58:45 INFO - 2015-11-23 19:58:45,804 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:58:45 INFO - 2015-11-23 19:58:45,805 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:58:45 INFO - 2015-11-23 19:58:45,805 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,833 19:58:45 INFO - 2015-11-23 19:58:45,805 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:58:45 INFO - 2015-11-23 19:58:45,805 DEBUG : BROWSER_OUTPUT: __startTimestamp1448337525797__endTimestamp 19:58:45 INFO - 2015-11-23 19:58:45,805 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,805 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:58:45 INFO - 2015-11-23 19:58:45,805 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:58:45 INFO - 2015-11-23 19:58:45,805 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,805 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:119.80 Median:114.50 stddev:15.59 (13.6%) stddev-sans-first:16.39 19:58:45 INFO - 2015-11-23 19:58:45,805 DEBUG : BROWSER_OUTPUT: Values: 114.0 107.0 115.0 114.0 114.0 126.0 113.0 119.0 162.0 114.0 19:58:45 INFO - 2015-11-23 19:58:45,805 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,805 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:138.70 Median:146.00 stddev:16.30 (11.2%) stddev-sans-first:17.08 19:58:45 INFO - 2015-11-23 19:58:45,806 DEBUG : BROWSER_OUTPUT: Values: 146.0 122.0 160.0 148.0 124.0 139.0 122.0 162.0 146.0 118.0 19:58:45 INFO - 2015-11-23 19:58:45,806 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,806 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:215.50 Median:211.50 stddev:27.28 (12.9%) stddev-sans-first:26.77 19:58:45 INFO - 2015-11-23 19:58:45,806 DEBUG : BROWSER_OUTPUT: Values: 245.0 278.0 195.0 190.0 202.0 222.0 219.0 204.0 201.0 199.0 19:58:45 INFO - 2015-11-23 19:58:45,806 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,806 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:77.40 Median:63.50 stddev:22.43 (35.3%) stddev-sans-first:22.27 19:58:45 INFO - 2015-11-23 19:58:45,806 DEBUG : BROWSER_OUTPUT: Values: 55.0 63.0 63.0 64.0 120.0 87.0 82.0 69.0 60.0 111.0 19:58:45 INFO - 2015-11-23 19:58:45,806 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,806 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:96.10 Median:95.00 stddev:16.36 (17.2%) stddev-sans-first:15.99 19:58:45 INFO - 2015-11-23 19:58:45,806 DEBUG : BROWSER_OUTPUT: Values: 78.0 77.0 109.0 102.0 113.0 112.0 111.0 77.0 78.0 104.0 19:58:45 INFO - 2015-11-23 19:58:45,806 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,806 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:88.50 stddev:5.63 (6.4%) stddev-sans-first:0.71 19:58:45 INFO - 2015-11-23 19:58:45,806 DEBUG : BROWSER_OUTPUT: Values: 106.0 89.0 88.0 88.0 89.0 88.0 89.0 89.0 87.0 88.0 19:58:45 INFO - 2015-11-23 19:58:45,806 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,807 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:116.10 Median:94.50 stddev:25.77 (27.3%) stddev-sans-first:24.05 19:58:45 INFO - 2015-11-23 19:58:45,807 DEBUG : BROWSER_OUTPUT: Values: 151.0 151.0 95.0 129.0 149.0 97.0 104.0 94.0 96.0 95.0 19:58:45 INFO - 2015-11-23 19:58:45,807 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,807 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:119.80 Median:119.00 stddev:26.26 (22.1%) stddev-sans-first:26.22 19:58:45 INFO - 2015-11-23 19:58:45,807 DEBUG : BROWSER_OUTPUT: Values: 145.0 126.0 148.0 87.0 151.0 137.0 128.0 91.0 94.0 91.0 19:58:45 INFO - 2015-11-23 19:58:45,807 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,807 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.60 Median:59.00 stddev:2.46 (4.2%) stddev-sans-first:2.60 19:58:45 INFO - 2015-11-23 19:58:45,807 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 59.0 59.0 58.0 60.0 61.0 66.0 58.0 58.0 19:58:45 INFO - 2015-11-23 19:58:45,807 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,807 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:67.00 stddev:1.95 (2.9%) stddev-sans-first:2.01 19:58:45 INFO - 2015-11-23 19:58:45,807 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 65.0 64.0 65.0 67.0 67.0 68.0 69.0 69.0 19:58:45 INFO - 2015-11-23 19:58:45,807 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,807 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:94.30 Median:83.50 stddev:13.30 (15.9%) stddev-sans-first:13.76 19:58:45 INFO - 2015-11-23 19:58:45,808 DEBUG : BROWSER_OUTPUT: Values: 86.0 84.0 85.0 84.0 83.0 105.0 111.0 114.0 108.0 83.0 19:58:45 INFO - 2015-11-23 19:58:45,808 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,808 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:131.40 Median:133.00 stddev:6.08 (4.6%) stddev-sans-first:6.12 19:58:45 INFO - 2015-11-23 19:58:45,808 DEBUG : BROWSER_OUTPUT: Values: 126.0 137.0 132.0 135.0 123.0 141.0 122.0 132.0 134.0 132.0 19:58:45 INFO - 2015-11-23 19:58:45,808 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,808 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.00 Median:140.50 stddev:3.20 (2.3%) stddev-sans-first:3.31 19:58:45 INFO - 2015-11-23 19:58:45,808 DEBUG : BROWSER_OUTPUT: Values: 138.0 138.0 144.0 137.0 146.0 140.0 137.0 137.0 141.0 142.0 19:58:45 INFO - 2015-11-23 19:58:45,808 DEBUG : BROWSER_OUTPUT: 19:58:45 INFO - 2015-11-23 19:58:45,808 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:66.00 stddev:2.04 (3.1%) stddev-sans-first:1.50 19:58:45 INFO - 2015-11-23 19:58:45,808 DEBUG : BROWSER_OUTPUT: Values: 61.0 64.0 67.0 66.0 64.0 65.0 66.0 68.0 67.0 64.0 19:58:45 INFO - 2015-11-23 19:58:45,808 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:58:45 INFO - 2015-11-23 19:58:45,808 DEBUG : BROWSER_OUTPUT: 19:58:46 INFO - 2015-11-23 19:58:46,446 INFO : Browser exited with error code: 0 19:58:46 INFO - 2015-11-23 19:58:46,494 INFO : Completed test kraken (00:00:57) 19:58:46 INFO - 2015-11-23 19:58:46,494 INFO : Starting test v8_7 19:58:46 INFO - 2015-11-23 19:58:46,494 DEBUG : operating with platform_type : mac_ 19:58:46 INFO - 2015-11-23 19:58:46,494 INFO : Initialising browser for v8_7 test... 19:58:46 INFO - 2015-11-23 19:58:46,507 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpPfp1Pb/profile http://localhost:56481/getInfo.html 19:58:49 INFO - 2015-11-23 19:58:49,314 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:58:49 INFO - 2015-11-23 19:58:49,314 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:58:49 INFO - 2015-11-23 19:58:49,314 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:58:49 INFO - 2015-11-23 19:58:49,314 DEBUG : BROWSER_OUTPUT: __metrics 19:58:50 INFO - 2015-11-23 19:58:50,029 INFO : Browser initialized. 19:58:50 INFO - 2015-11-23 19:58:50,029 INFO : Running cycle 1/1 for v8_7 test... 19:58:50 INFO - 2015-11-23 19:58:50,029 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpPfp1Pb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:59:02 INFO - 2015-11-23 19:59:02,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 238256128 19:59:02 INFO - 2015-11-23 19:59:02,076 DEBUG : BROWSER_OUTPUT: 19:59:23 INFO - 2015-11-23 19:59:23,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56481/tests/v8_7/run.html (next: http://localhost:56481/tests/v8_7/run.html) 19:59:23 INFO - 2015-11-23 19:59:23,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 248045568 19:59:23 INFO - 2015-11-23 19:59:23,780 DEBUG : BROWSER_OUTPUT: 19:59:23 INFO - 2015-11-23 19:59:23,780 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:59:23 INFO - 2015-11-23 19:59:23,780 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:59:23 INFO - 2015-11-23 19:59:23,780 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:59:23 INFO - 2015-11-23 19:59:23,780 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:59:23 INFO - 2015-11-23 19:59:23,780 DEBUG : BROWSER_OUTPUT: |0;Richards;176.92852087756546 19:59:23 INFO - 2015-11-23 19:59:23,780 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;157.85319652722967 19:59:23 INFO - 2015-11-23 19:59:23,780 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.4141069397042 19:59:23 INFO - 2015-11-23 19:59:23,780 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4901.9607843137255 19:59:23 INFO - 2015-11-23 19:59:23,780 DEBUG : BROWSER_OUTPUT: |4;RayTrace;937.207122774133 19:59:23 INFO - 2015-11-23 19:59:23,780 DEBUG : BROWSER_OUTPUT: |5;Earley;738.5524372230428 19:59:23 INFO - 2015-11-23 19:59:23,781 DEBUG : BROWSER_OUTPUT: |6;Boyer;13038.961038961039 19:59:23 INFO - 2015-11-23 19:59:23,781 DEBUG : BROWSER_OUTPUT: |7;RegExp;31500 19:59:23 INFO - 2015-11-23 19:59:23,781 DEBUG : BROWSER_OUTPUT: |8;Splay;684.1032608695652 19:59:23 INFO - 2015-11-23 19:59:23,781 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4545.454545454545 19:59:23 INFO - 2015-11-23 19:59:23,781 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:59:23 INFO - 2015-11-23 19:59:23,782 DEBUG : BROWSER_OUTPUT: __startTimestamp1448337563779__endTimestamp 19:59:23 INFO - 2015-11-23 19:59:23,782 DEBUG : BROWSER_OUTPUT: 19:59:23 INFO - 2015-11-23 19:59:23,782 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:59:23 INFO - 2015-11-23 19:59:23,782 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:59:23 INFO - 2015-11-23 19:59:23,782 DEBUG : BROWSER_OUTPUT: 19:59:23 INFO - 2015-11-23 19:59:23,782 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:176.93 Median:176.93 stddev:0.00 (0.0%) 19:59:23 INFO - 2015-11-23 19:59:23,783 DEBUG : BROWSER_OUTPUT: Values: 176.9 19:59:23 INFO - 2015-11-23 19:59:23,783 DEBUG : BROWSER_OUTPUT: 19:59:23 INFO - 2015-11-23 19:59:23,783 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:157.85 Median:157.85 stddev:0.00 (0.0%) 19:59:23 INFO - 2015-11-23 19:59:23,783 DEBUG : BROWSER_OUTPUT: Values: 157.9 19:59:23 INFO - 2015-11-23 19:59:23,783 DEBUG : BROWSER_OUTPUT: 19:59:23 INFO - 2015-11-23 19:59:23,783 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.41 Median:284.41 stddev:0.00 (0.0%) 19:59:23 INFO - 2015-11-23 19:59:23,783 DEBUG : BROWSER_OUTPUT: Values: 284.4 19:59:23 INFO - 2015-11-23 19:59:23,783 DEBUG : BROWSER_OUTPUT: 19:59:23 INFO - 2015-11-23 19:59:23,783 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4901.96 Median:4901.96 stddev:0.00 (0.0%) 19:59:23 INFO - 2015-11-23 19:59:23,783 DEBUG : BROWSER_OUTPUT: Values: 4902.0 19:59:23 INFO - 2015-11-23 19:59:23,783 DEBUG : BROWSER_OUTPUT: 19:59:23 INFO - 2015-11-23 19:59:23,783 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:937.21 Median:937.21 stddev:0.00 (0.0%) 19:59:23 INFO - 2015-11-23 19:59:23,783 DEBUG : BROWSER_OUTPUT: Values: 937.2 19:59:23 INFO - 2015-11-23 19:59:23,783 DEBUG : BROWSER_OUTPUT: 19:59:23 INFO - 2015-11-23 19:59:23,784 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:738.55 Median:738.55 stddev:0.00 (0.0%) 19:59:23 INFO - 2015-11-23 19:59:23,784 DEBUG : BROWSER_OUTPUT: Values: 738.6 19:59:23 INFO - 2015-11-23 19:59:23,784 DEBUG : BROWSER_OUTPUT: 19:59:23 INFO - 2015-11-23 19:59:23,784 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13038.96 Median:13038.96 stddev:0.00 (0.0%) 19:59:23 INFO - 2015-11-23 19:59:23,784 DEBUG : BROWSER_OUTPUT: Values: 13039.0 19:59:23 INFO - 2015-11-23 19:59:23,784 DEBUG : BROWSER_OUTPUT: 19:59:23 INFO - 2015-11-23 19:59:23,784 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31500.00 Median:31500.00 stddev:0.00 (0.0%) 19:59:23 INFO - 2015-11-23 19:59:23,784 DEBUG : BROWSER_OUTPUT: Values: 31500.0 19:59:23 INFO - 2015-11-23 19:59:23,784 DEBUG : BROWSER_OUTPUT: 19:59:23 INFO - 2015-11-23 19:59:23,784 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:684.10 Median:684.10 stddev:0.00 (0.0%) 19:59:23 INFO - 2015-11-23 19:59:23,784 DEBUG : BROWSER_OUTPUT: Values: 684.1 19:59:23 INFO - 2015-11-23 19:59:23,784 DEBUG : BROWSER_OUTPUT: 19:59:23 INFO - 2015-11-23 19:59:23,784 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4545.45 Median:4545.45 stddev:0.00 (0.0%) 19:59:23 INFO - 2015-11-23 19:59:23,785 DEBUG : BROWSER_OUTPUT: Values: 4545.5 19:59:23 INFO - 2015-11-23 19:59:23,785 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:59:23 INFO - 2015-11-23 19:59:23,785 DEBUG : BROWSER_OUTPUT: 19:59:24 INFO - 2015-11-23 19:59:24,378 INFO : Browser exited with error code: 0 19:59:24 INFO - 2015-11-23 19:59:24,396 INFO : Completed test v8_7 (00:00:37) 19:59:24 INFO - 2015-11-23 19:59:24,828 INFO : Completed test suite (00:20:06) 19:59:24 INFO - 2015-11-23 19:59:24,828 DEBUG : Working with test: dromaeo_css 19:59:24 INFO - 2015-11-23 19:59:24,828 DEBUG : Generating results file: dromaeo_css 19:59:24 INFO - 2015-11-23 19:59:24,829 DEBUG : Working with test: kraken 19:59:24 INFO - 2015-11-23 19:59:24,829 DEBUG : Generating results file: kraken 19:59:24 INFO - 2015-11-23 19:59:24,830 INFO : javascript benchmark 19:59:24 INFO - 2015-11-23 19:59:24,830 DEBUG : Working with test: v8_7 19:59:24 INFO - 2015-11-23 19:59:24,830 DEBUG : Generating results file: v8_7 19:59:24 INFO - 2015-11-23 19:59:24,830 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:59:25 INFO - 2015-11-23 19:59:25,224 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 19:59:25 INFO - 2015-11-23 19:59:25,224 DEBUG : process_Request line: dromaeo_css 7606.56 graph.html#tests=[[72,64,61]] 19:59:25 INFO - 2015-11-23 19:59:25,224 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:59:25 INFO - 2015-11-23 19:59:25,337 DEBUG : process_Request line: kraken 1530.30 graph.html#tests=[[232,64,61]] 19:59:25 INFO - 2015-11-23 19:59:25,337 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:59:25 INFO - 2015-11-23 19:59:25,368 DEBUG : process_Request line: v8_7 21187.40 graph.html#tests=[[230,64,61]] 19:59:25 INFO - 2015-11-23 19:59:25,369 INFO : javascript benchmark 19:59:25 INFO - 2015-11-23 19:59:25,371 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2921.5471601901704, 3503.5620547431586, 3510.648935106491, 3531.434970404734, 3550.573931128264, 5176.835212077285, 5497.39528651848, 5917.112433135032, 5924.229850119484, 5940.88118237635, 5658.377578466376, 5781.739821708023, 5819.214406055181, 5830.533557315415, 5842.591018628697, 5160.6903585784785, 5229.0, 5261.552768014713, 5357.919631205535, 5397.082495975694, 5357.598180136486, 5393.0, 5415.702136382517, 5433.673979561219, 5447.891042179154, 5098.770555325019, 5270.92093618596, 5421.322334708161, 5427.213054107152, 5502.284702988626, 5165.328507294028, 5267.710275934822, 5290.338707661543, 5309.814156504503, 5311.601629877775, 5287.9735601321745, 5290.55030322423, 5334.519893209591, 5360.0, 5369.81205657804, 5174.327337446146, 5576.609637325389, 5708.343540492855, 5863.58954873159, 5918.2306300181135, 6305.905411418832, 6312.526560507934, 6322.146510221107, 6335.176427064498, 6338.80983570489, 6359.968200159016, 6373.9681301593655, 6376.521760867953, 6394.552381333308, 6394.968025159845, 5861.677607731573, 6000.789972350947, 6031.185789918392, 6113.816585502442, 6163.445289923929, 6413.486921046305, 6464.385883341075, 6484.221893372825, 6497.252815926135, 6521.380468855451, 6252.656103914328, 6308.653024083627, 6309.558330916791, 6317.684115794192, 6320.304766475684, 6151.800398922167, 6220.284667263232, 6221.160143380676, 6315.431611154926, 6356.237251529754, 6273.247210334789, 6285.654289014056, 6299.338569450142, 6313.0, 6325.367463253638, 5234.2933703949475, 6283.560150789493, 6312.747490100436, 6313.652749098844, 6317.210348706411, 4902.191138462185, 5000.224965130338, 5052.747362631853, 5072.467390923974, 5113.53978141969, 4549.749763763025, 4556.84051058218, 4560.635149188057, 4588.197065513522, 4620.584147426748, 5811.854703632358, 5859.2382990211, 5903.0260007099205, 5957.672328022, 5997.490213331916, 6217.409346112112, 6316.873662526724, 6335.176427064452, 6336.0, 6359.872802544016, 5976.043832986788, 5992.940070599326, 6014.097885317237, 6015.30823955242, 6049.637021778707, 5366.758495867695, 5487.42382049887, 5497.285352904177, 5602.159676048625, 5646.745896434671, 5539.169124631257, 6431.517636177212, 6452.836214123136, 6490.253620833664, 6531.248906375733, 6364.809055728336, 6371.331010243857, 6388.105665206782, 6388.968055159695, 6411.711472983634, 5467.425920278313, 6243.406876346739, 6284.120223168668, 6350.809475715736, 6383.9361606383345, 6266.436020758154, 6296.0555916612875, 6306.527010474141, 6320.5891617044745, 6325.778597749057, 6274.498040156868, 6385.936140638534, 6423.100765892872, 6431.871362572816, 6437.163168788027, 6081.331053584191, 6127.080937859357, 6152.138700581832, 6167.290761562478, 6178.598391104564, 6153.230846144232, 6171.321154673072, 6173.59871608344, 6175.876482470415, 6196.845078873064, 5836.0, 5895.7052147393315, 5926.733297001731, 6113.0, 6184.0, 5492.835214943558, 6066.666333351708, 6134.834601026268, 6149.815505534841, 6255.624662520263, 6142.9078563820685, 6171.259448866164, 6191.9690401547705, 6208.844778880383, 6241.937580624136], "unit": "ms", "name": "dojo.html", "value": 5798.809662845411}, {"lowerIsBetter": false, "replicates": [561.9185218143369, 581.9272590926132, 592.7273454211064, 634.5304474688729, 672.2806596941268, 41504.96237594062, 41661.166776664446, 41823.372649410245, 41834.37248441272, 41930.79034604831, 43409.91475213121, 43917.902052448626, 44140.55859441405, 44251.89370265745, 44434.555654443444, 9768.804623907517, 9866.851997220047, 9920.206383489303, 9928.6524971626, 9948.801023979517, 9796.657117000907, 9815.754606134868, 9855.802883942317, 9861.161801246903, 9882.209423246159, 9794.902050979506, 9853.852192217122, 9871.407715537054, 9898.257630677728, 9931.205503559733, 9750.0, 9784.217262618973, 9786.5596048178, 9793.951030244838, 9836.90163098367, 9594.088561586708, 9687.370320929187, 9738.464384458852, 9758.268129890286, 9763.658271960518, 39994.60005399938, 40004.599954000376, 40104.596339128286, 40121.39817902734, 40296.395554066716, 2925.765938724897, 3042.7717921156, 3156.794808337451, 3168.477201261789, 3171.5242713592916, 28985.420291594262, 28988.855055724798, 29376.824927002894, 29556.0, 29675.0, 2755.1045910079306, 2780.304923769058, 2801.341684704093, 2941.617589713345, 2987.118799953997, 429473.0, 500282.0, 502732.0, 503703.0, 504433.0, 60955.0, 72444.0, 72531.0, 72734.90897636539, 72781.99999999894, 59086.704566476896, 81080.0, 81245.59377203195, 82240.58879705564, 83074.0, 16430.1784910754, 16441.83558164403, 16477.83522164787, 16609.920355176873, 16698.248578813982, 12393.256404615571, 12462.314572698408, 12463.0, 12532.934700550555, 12563.0, 21536.246231381825, 22039.228626998298, 22305.888470557544, 22627.88686056559, 22632.0, 8131.349492040623, 8179.550124743197, 8795.032546419889, 9035.277177825757, 9480.194183494343, 901.8737376767258, 945.9195968342631, 974.8147851908114, 1026.820306446384, 1113.1206346985953, 24149.637755433683, 29859.0, 30013.549796752628, 30598.84700576483, 30719.0, 962.3071388600197, 1111.7887601355878, 1179.5105031411867, 1195.9581414650445, 1226.748516554122, 11573.826392604118, 12981.870181298065, 13391.531296404579, 15448.768268475982, 15690.450834220748, 939676.0, 963343.0, 964739.0, 974139.0, 975527.0, 63194.36805631977, 63383.36616633867, 63720.68139659272, 64148.358516415174, 64205.678971604844, 1458.3291685824427, 1474.1376294867623, 1486.3385793321868, 1490.1059364381501, 1495.1477657735204, 31662.05013849588, 31680.366392671556, 32381.352372951937, 33217.0, 33804.3239135211, 47385.81535461503, 55374.0, 59293.70353148379, 59377.0, 60210.0, 480125.0, 481138.0, 484169.5791521161, 484889.0, 488268.0, 45703.0, 47387.52612473831, 47719.522804772896, 48692.0, 48815.0, 46734.53265467438, 47181.29228061513, 47422.525774741815, 47435.76282118567, 47496.05007899892, 38352.80823595864, 38786.4182037264, 39528.60471395249, 39819.0, 39892.0, 38703.0, 39024.02439939024, 39569.406458902566, 39632.21655025473, 39959.60040399559, 37309.06727331838, 38651.806740966116, 38739.41890871696, 38753.0, 38781.41827872528, 33335.166620833705, 33514.83242583869, 34425.139371515914, 34458.65541344655, 34467.4829877547, 21856.562868742854, 23899.880500597385, 24623.891924863066, 26216.34459138537, 26464.0], "unit": "ms", "name": "ext.html", "value": 21088.314638569424}, {"lowerIsBetter": false, "replicates": [314.00930065642905, 317.6569305150437, 361.6690727983893, 367.87124506422754, 370.7275152762719, 16266.0, 19202.23191072359, 19538.0, 20657.0, 21613.13547458104, 20005.399838004847, 20601.587968240627, 20757.065932033056, 20827.27104551341, 20969.16123355064, 5905.20279762232, 5908.261467316585, 6065.454109130177, 6069.0592958091565, 6091.390860913895, 3808.409696497047, 4440.178566965122, 5603.60774745768, 6365.663210725753, 6450.612963222198, 5876.44173803488, 6464.277151762161, 6530.6408147551865, 6535.509836762238, 6558.409743123118, 6510.739570417178, 6520.315366886503, 6523.7716679915975, 6543.541952063358, 6567.113439685677, 5497.862553436156, 5571.693556854371, 5615.157726341041, 5615.354234263071, 5650.124230744241, 24507.2844900857, 25039.12363067302, 25227.11705090313, 25364.746352536422, 25684.743152568422, 2057.5473395852887, 2071.7099606055162, 2142.914283428661, 2264.8074913632363, 2391.7847393734473, 8373.539455329954, 8976.730698079004, 9549.713508594683, 9550.37922535033, 9782.119609235131, 1738.8869723467933, 1755.7541944127831, 1779.030428416516, 1825.8813177143577, 1827.4883032750718, 85151.0, 100244.49877750638, 104471.0, 106905.0, 107063.3234169152, 8913.0, 10848.18638602108, 10964.780704385868, 11056.557737690564, 11072.169587280987, 13034.217946923214, 13046.347682615831, 13076.542321018718, 13112.0, 13212.273324967218, 7963.960180199062, 8154.5514996674565, 8196.057453392817, 8289.58552072394, 8291.58542072894, 8141.104478507359, 8227.341812654973, 8254.42219044673, 8326.750197494084, 8359.331253499828, 4213.157368526246, 4240.533541310453, 4246.978765106154, 4247.766372849461, 4287.892802679896, 1752.3341130370377, 1812.0939530234882, 1817.8363947244811, 1818.399928023749, 1864.412709996374, 397.0015411240732, 857.7812657772229, 968.934172410343, 995.1292618958412, 999.6857275407409, 10694.62568810088, 11101.389423581619, 11485.310881347146, 11684.415779211175, 11723.472443740053, 439.3804735323179, 440.33509400805013, 447.55691865053365, 452.19960669614596, 454.2686275097091, 5116.386033675983, 5992.790252341147, 6102.267727872595, 6103.298120716175, 6201.937980620136, 705623.0, 708180.0, 708403.0, 709331.0, 714689.0, 100571.0, 114869.4256528712, 124794.37602811928, 125214.0, 126912.36543817222, 418.3661752445048, 436.28667129243917, 479.4079312049686, 482.235656484476, 482.27176962786444, 11090.5563777448, 11100.833487497532, 11153.051990580892, 11156.0, 11175.664730058112, 46217.0, 46339.0, 46890.76554617205, 46912.0, 47459.05081898412, 69328.30671693219, 70061.64969175121, 70544.6472767633, 71623.28376716166, 71811.0, 8125.8374832504205, 9756.414615123116, 9965.750856228362, 9991.950040249752, 10030.348027378197, 12005.63983080509, 12013.099017573542, 14088.295585220492, 16036.438724644582, 18644.0, 8573.91426085756, 8984.921809382917, 15554.688906221585, 16083.517494475185, 16264.268107935408, 15485.303161357991, 15635.29641166173, 15942.123183225034, 16013.95909265894, 16290.10404427768, 14921.850781492047, 15261.008034478167, 16182.757258640895, 16195.514134575982, 17194.054327012134, 9603.135717785433, 9610.183134433652, 9771.169450596779, 9842.950785246028, 9851.113399793767, 10271.589136434459, 10290.742731431774, 11297.604583839526, 15894.761578576099, 16384.75422868682], "unit": "ms", "name": "jquery.html", "value": 8887.298899923107}, {"lowerIsBetter": false, "replicates": [1528.5032364481547, 1583.9287232074555, 1757.9296828126876, 1877.4836919847048, 1901.8098190180983, 7761.495502792314, 7915.564643944581, 8529.10444403338, 8755.3433492488, 8832.60253288602, 8270.172982701726, 8412.537310447922, 8505.44714593551, 8536.829263414727, 8562.571871406435, 2343.461003969084, 2369.845960012594, 2379.119725701484, 2382.1662418153683, 2389.7968672662846, 2366.550355432471, 2388.176079252664, 2402.3753824005707, 2421.4793819328843, 2423.866687332205, 2334.4280651240383, 2350.7061617297836, 2356.140008896749, 2369.798567121788, 2385.95228095438, 1883.0302394266964, 2159.438545978057, 2349.8707571083582, 2360.114956891166, 2367.7277113132036, 2405.374602603318, 2406.831521793475, 2429.4898071405028, 2434.793042591382, 2436.110819550869, 8541.530215838126, 8620.784480387978, 8622.870656940151, 8627.525486098262, 8632.65469381224, 5209.921851172197, 5232.633715639907, 5277.340332458442, 5297.814576489843, 5324.92012619811, 3478.4434490481653, 3511.9648803511895, 3537.5224344713392, 3553.6091029986683, 3563.251717139404, 893.4326702543866, 1044.5560636729435, 1048.638219814163, 1074.0655629602218, 1075.5536452372335, 11184.664460066211, 11198.216124871262, 11223.943880280547, 11263.380514071723, 11263.831042534368, 4279.914401712011, 4389.0, 4633.606143477775, 4693.55411235932, 4720.693154944917, 9535.2371810255, 9560.474173920502, 9728.659496917715, 9750.0, 9767.755806104904, 5243.344581927259, 5257.185136303879, 5262.7631756571045, 5289.841304760864, 5315.3090098286975, 3612.476190952297, 4362.8036738346855, 4738.3840100787365, 4779.259214821708, 4807.134715751198, 3899.083715326896, 3903.921921561553, 3905.0, 3937.858021173885, 3954.347532657137, 1163.4066626020622, 1307.6207899708977, 1317.413750880868, 1320.6368248731483, 1328.4885319152197, 1312.0422091872986, 1334.0, 1334.5529247701934, 1377.3182274774051, 1383.5365152673967, 6974.337437943387, 7822.022247219098, 7920.4455688102435, 7998.960005200053, 8019.7995050123045, 501.6237821633775, 509.45233873586045, 509.8597885581495, 510.5583670125315, 513.9717315547606, 6034.559676411966, 6077.75688972445, 6132.601380910227, 6171.876562468726, 6177.660228687376, 10160.237982151368, 10266.127379172705, 10327.896721032845, 10337.534810933526, 10391.220658450646, 8652.956735216283, 9869.309148359545, 10037.548310325907, 10145.543450544743, 10387.584496620051, 7943.046834379911, 7968.282854543119, 7995.520268783892, 8017.559034253055, 8047.879281810778, 7502.924970750222, 7568.356689681439, 7597.050368703912, 7602.50583712057, 7613.695452182073, 8884.37809353339, 9000.189982901571, 9172.724818255463, 9182.67860624875, 9235.1688348049, 9290.16388525036, 9328.253739700673, 9341.953290233778, 9448.007959164188, 9506.667266645634, 5641.915371269516, 6667.899981500378, 6814.522983391314, 7383.224761399975, 7385.0, 8057.355411567178, 8081.87877181831, 8087.231712987257, 8089.635966381645, 8100.71647492335, 7424.406047516078, 7571.091469023752, 7577.696892124253, 7673.731419400294, 7763.262490063435, 7238.565686058853, 7544.358729508053, 7559.659815308214, 7668.769936901902, 7675.462717609714, 6567.802965911031, 7658.540487570541, 7665.463417560717, 7700.114486834086, 7734.806629834074, 6882.896756548756, 6997.545159564612, 7005.54463959841, 7025.964870175821, 7031.542949708252, 7100.893486597808, 7121.750738724327, 7128.786136415916, 7132.679029443584, 7196.388306993964], "unit": "ms", "name": "mootools.html", "value": 4710.511244027015}, {"lowerIsBetter": false, "replicates": [287.552855309993, 299.30411792582254, 331.6087017319565, 333.26847569584754, 335.5235565496993, 6878.140232470942, 6950.65246737663, 6951.548149370287, 7119.288071192878, 7153.995321964774, 6784.966075169617, 6923.896141557881, 6934.549254298467, 6948.339907708772, 7013.649317534128, 4307.590778876001, 5000.449950505442, 5046.091703493379, 5051.368578927634, 5068.847934561969, 4859.902801943959, 5047.68760122369, 5060.54455099041, 5066.847994560169, 5098.235264710286, 4442.911141777178, 4603.378543896564, 4963.305137280783, 4980.27785971034, 5009.0, 4091.89770255743, 4937.012597480482, 4959.156943319645, 4985.775640096204, 4991.7504124793795, 4058.6753059755147, 4170.91658166838, 4175.10235299409, 4217.313074770086, 4252.362145678142, 5828.388019257959, 6216.03651434024, 6644.136262285921, 6669.633170175638, 6695.497837662146, 5093.312402825608, 5916.544633976894, 5963.105534169866, 5970.6716130612795, 5993.0710739835395, 6070.8785824283705, 7210.963945180293, 7349.926500735031, 7445.590492522909, 7501.512401693873, 3930.5872883347124, 4720.976395118037, 4763.095011947754, 4767.070421267854, 4770.809167633291, 6859.348361905561, 7512.248775122444, 7856.371490280764, 7967.482113662593, 7985.201479852027, 4676.672632915664, 4809.591184749335, 4812.7968007998, 4821.059893320768, 4830.903381932341, 4220.746755194698, 4773.639512738922, 4881.145799485076, 4903.705777653352, 4927.113119638428, 5925.40745925404, 5944.048952167633, 5945.0785128304315, 5955.40445955401, 5993.0710739835395, 7584.165741768401, 7602.0, 7604.060964454029, 7613.581253031137, 7616.04799400075, 1417.5463851567606, 1432.8065711129072, 1662.0, 1698.1763844535637, 1721.2942693495606, 998.5007496251874, 1068.983965240522, 1089.7874914391775, 1092.1099304067159, 1103.5585765693786, 6902.758403455855, 6910.412614927687, 6938.687759050855, 6941.375276225063, 6968.338007889242, 6560.8359791005605, 6659.801235777607, 7642.0, 7732.884006739903, 7738.303552680286, 6838.350356716203, 6888.450098727846, 6899.793006209822, 6924.0, 7116.5018448709125, 3433.8454769535433, 4052.3313653247474, 4101.405296232089, 4154.189932963043, 4166.354215096665, 6610.2398224204835, 8175.345972322319, 8185.590720464072, 8238.382121340923, 8248.46384984986, 7996.720114795954, 8181.79545511367, 8226.424150309422, 8231.917680823235, 8274.917250827535, 8176.550289734122, 8187.71343002992, 8217.753467395987, 8225.218604232588, 8225.917740822515, 7872.937153484207, 7891.053073631201, 7926.048874135141, 7931.36549076061, 7937.880931786143, 7594.8860767089645, 7772.533647981139, 7791.0650721913735, 7806.4925779824125, 7827.0, 6583.868322633616, 6583.934160658524, 8174.754757357289, 8176.877346839921, 8202.753917382488, 4780.378550788375, 4808.677613656272, 4810.302506136521, 4819.831305904277, 4833.613310935187, 7616.23837616234, 7788.143304236416, 7801.0, 7820.960895195488, 7848.646810893638, 6136.570440069331, 7512.0, 7541.849163016818, 7545.886811697938, 7551.848963020599, 6365.331640177715, 7277.9272207277245, 7391.669499490144, 7505.549667019996, 7553.244675532403, 7305.634718264172, 7310.488265821342, 7339.247782081719, 7342.926570734225, 7343.632818359168, 7501.174870764103, 7520.924790752022, 7527.322540971339, 7530.811729706801, 7554.508956917783, 5884.411558844081, 5927.792527261698, 6172.0, 6853.451723861979, 7309.707611695472], "unit": "ms", "name": "prototype.html", "value": 5324.48180169316}, {"lowerIsBetter": false, "replicates": [736.4108713029575, 744.147950596567, 764.5374548398219, 775.4339332287431, 856.0070318430621, 14849.925750371247, 15268.923655381735, 15565.29956151973, 15590.220488975563, 15627.765583516242, 10818.459077046136, 12766.80849787254, 13992.950528710362, 14023.649408764786, 14040.859591404083, 762.4586543554083, 776.3595034096865, 959.4387283439196, 985.3939827006375, 986.5461887531744, 949.9667511637094, 960.231814548362, 969.0551712080735, 969.7478655549537, 984.394597322645, 1026.6765968719828, 1037.2842738510442, 1047.1988928469727, 1050.789842031593, 1051.7002654243543, 1014.518103900645, 1015.1168483419399, 1017.6692574913109, 1032.3960483117385, 1033.7105610429055, 630.4798541203479, 752.7365422102275, 755.2447552447552, 765.9770206893802, 771.8456308738275, 14820.555383338517, 14934.402623895032, 14999.32503037355, 15042.172680502568, 15249.560070388796, 12738.426770795337, 12739.171953823065, 12767.0, 13054.86945130546, 13095.541656042087, 8357.749267521924, 10018.448985305806, 10326.793464130675, 10559.26085174038, 10891.400972946485, 3509.6314886937016, 3561.7684850484634, 3630.6187850275605, 3668.394714872043, 3723.255348930225, 81662.59168704179, 82242.58878705629, 82335.0, 83850.32299353978, 84359.99999999939, 9505.524723763785, 9865.0, 9980.001999800108, 10032.448215348226, 10366.533505992249, 21623.783762162493, 21895.01472433744, 22149.44626384321, 22403.327900162694, 22482.662760058283, 7340.0457940467395, 7487.625618719151, 7631.313181813553, 7678.424118191158, 7710.498817576951, 3460.2387474755515, 4052.169305292408, 4055.6755459563165, 4066.8576599819457, 4077.001134722012, 3413.3343997920665, 3419.9658003420145, 3437.05480992729, 3456.980190843707, 3458.8097654629237, 602.2532060245264, 615.4522474997256, 621.1490258346095, 635.291649810458, 635.3011687144104, 507.5508175264917, 533.2960492150324, 581.0, 583.2971269620098, 590.1266126133347, 8659.307255419551, 8710.869336959951, 8713.477191368538, 8725.520096394632, 8931.464112153291, 495.5812338573899, 521.8434469659087, 544.9509544140967, 553.4327314502667, 596.4870211618005, 3410.658934106619, 4042.818073186655, 4209.726367786084, 4265.253580623378, 4286.8499602514385, 96680.03319966851, 97788.0, 99605.0, 99863.0, 100237.0, 84113.73829392563, 84502.0, 84503.5774821122, 84507.5774621123, 88395.11604883868, 69856.60286794236, 74437.0, 74553.25446745571, 75725.62137189279, 77367.22632773712, 8942.239909607757, 9001.324900632348, 9079.68221112258, 9229.723108306762, 9315.86026209621, 49196.0, 50080.99838003292, 54738.45261547333, 55822.88354232811, 55871.44128558825, 69133.65433172802, 69477.65261173662, 75053.0, 75057.62471187828, 77208.61395693211, 10707.57169713234, 11011.889881101086, 11381.54473821038, 11400.94299528497, 11915.52337906474, 12185.51257949672, 12517.374131293216, 12553.058520611174, 12635.873641263837, 12683.731626837243, 11162.38606876597, 11420.31478111316, 11567.479463423997, 11615.303081815118, 12362.44369003379, 11374.601888933848, 11811.704707382385, 11890.34603096838, 11936.940315298369, 12270.386480676108, 11079.72300692489, 11595.652130436101, 11706.473208705798, 11713.590024349107, 12261.38693065361, 9355.298352623717, 9643.0, 9929.950350248202, 10423.53094110782, 10513.684589462327, 8943.195112439911, 9311.953440233026, 9930.900690993287, 9948.722049518776, 10030.047145521165], "unit": "ms", "name": "yui.html", "value": 7105.528553915348}], "name": "dromaeo_css", "value": 7606.557614266765}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 115.0, 114.0, 114.0, 126.0, 113.0, 119.0, 162.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 119.8}, {"lowerIsBetter": true, "replicates": [146.0, 122.0, 160.0, 148.0, 124.0, 139.0, 122.0, 162.0, 146.0, 118.0], "unit": "ms", "name": "audio-beat-detection", "value": 138.7}, {"lowerIsBetter": true, "replicates": [245.0, 278.0, 195.0, 190.0, 202.0, 222.0, 219.0, 204.0, 201.0, 199.0], "unit": "ms", "name": "audio-dft", "value": 215.5}, {"lowerIsBetter": true, "replicates": [55.0, 63.0, 63.0, 64.0, 120.0, 87.0, 82.0, 69.0, 60.0, 111.0], "unit": "ms", "name": "audio-fft", "value": 77.4}, {"lowerIsBetter": true, "replicates": [78.0, 77.0, 109.0, 102.0, 113.0, 112.0, 111.0, 77.0, 78.0, 104.0], "unit": "ms", "name": "audio-oscillator", "value": 96.1}, {"lowerIsBetter": true, "replicates": [106.0, 89.0, 88.0, 88.0, 89.0, 88.0, 89.0, 89.0, 87.0, 88.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 90.1}, {"lowerIsBetter": true, "replicates": [151.0, 151.0, 95.0, 129.0, 149.0, 97.0, 104.0, 94.0, 96.0, 95.0], "unit": "ms", "name": "imaging-darkroom", "value": 116.1}, {"lowerIsBetter": true, "replicates": [145.0, 126.0, 148.0, 87.0, 151.0, 137.0, 128.0, 91.0, 94.0, 91.0], "unit": "ms", "name": "imaging-desaturate", "value": 119.8}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 59.0, 59.0, 58.0, 60.0, 61.0, 66.0, 58.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 67.0, 67.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.3}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 85.0, 84.0, 83.0, 105.0, 111.0, 114.0, 108.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 94.3}, {"lowerIsBetter": true, "replicates": [126.0, 137.0, 132.0, 135.0, 123.0, 141.0, 122.0, 132.0, 134.0, 132.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 131.4}, {"lowerIsBetter": true, "replicates": [138.0, 138.0, 144.0, 137.0, 146.0, 140.0, 137.0, 137.0, 141.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.0}, {"lowerIsBetter": true, "replicates": [61.0, 64.0, 67.0, 66.0, 64.0, 65.0, 66.0, 68.0, 67.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.2}], "name": "kraken", "value": 1530.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [176.92852087756546], "unit": "score", "name": "Richards", "value": 199.52690399999992}, {"lowerIsBetter": false, "replicates": [157.85319652722967], "unit": "score", "name": "DeltaBlue", "value": 418.85753000000017}, {"lowerIsBetter": false, "replicates": [284.4141069397042], "unit": "score", "name": "Encrypt", "value": 935.8923959999998}, {"lowerIsBetter": false, "replicates": [4901.9607843137255], "unit": "score", "name": "Decrypt", "value": 54.30092399999998}, {"lowerIsBetter": false, "replicates": [937.207122774133], "unit": "score", "name": "RayTrace", "value": 789.568263}, {"lowerIsBetter": false, "replicates": [738.5524372230428], "unit": "score", "name": "Earley", "value": 902.3909019999996}, {"lowerIsBetter": false, "replicates": [13038.961038961039], "unit": "score", "name": "Boyer", "value": 51.11319820717133}, {"lowerIsBetter": false, "replicates": [31500.0], "unit": "score", "name": "RegExp", "value": 28.920158730158732}, {"lowerIsBetter": false, "replicates": [684.1032608695652], "unit": "score", "name": "Splay", "value": 119.12090566037733}, {"lowerIsBetter": false, "replicates": [4545.454545454545], "unit": "score", "name": "NavierStokes", "value": 326.4799999999998}], "name": "v8_7", "value": 21187.402827173144}]} 19:59:25 INFO - RETURN: dromaeo_css: 7606.56 19:59:25 INFO - RETURN: kraken: 1530.30 19:59:25 INFO - RETURN: v8_7: 21187.40 19:59:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "21187.40"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1530.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7606.56"}}} 19:59:25 INFO - Return code: 0 19:59:25 INFO - # TBPL SUCCESS # 19:59:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:59:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:59:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:59:25 INFO - 2015-11-23 19:59:25.462 screenresolution[2258:25259] starting screenresolution argv=screenresolution get 19:59:25 INFO - 2015-11-23 19:59:25.465 screenresolution[2258:25259] Display 0: 1600x1200x32@60 19:59:25 INFO - 2015-11-23 19:59:25.471 screenresolution[2259:25262] starting screenresolution argv=screenresolution list 19:59:25 INFO - Available Modes on Display 0 19:59:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:59:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:59:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:59:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:59:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:59:25 INFO - Intel Iris: 19:59:25 INFO - Chipset Model: Intel Iris 19:59:25 INFO - Type: GPU 19:59:25 INFO - Bus: Built-In 19:59:25 INFO - VRAM (Dynamic, Max): 1536 MB 19:59:25 INFO - Vendor: Intel (0x8086) 19:59:25 INFO - Device ID: 0x0a2e 19:59:25 INFO - Revision ID: 0x0009 19:59:25 INFO - Displays: 19:59:25 INFO - Display: 19:59:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:59:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:59:25 INFO - Display Serial Number: 1600x1200 60 19:59:25 INFO - Main Display: Yes 19:59:25 INFO - Mirror: Off 19:59:25 INFO - Online: Yes 19:59:25 INFO - Rotation: Supported 19:59:25 INFO - Return code: 0 19:59:25 INFO - Running post-action listener: _resource_record_post_action 19:59:25 INFO - Running post-run listener: _resource_record_post_run 19:59:26 INFO - Total resource usage - Wall time: 1238s; CPU: 54.0%; Read bytes: 45056; Write bytes: 691156480; Read time: 2; Write time: 2131 19:59:26 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 335884800; Write bytes: 336467968; Read time: 26268; Write time: 636 19:59:26 INFO - run-tests - Wall time: 1208s; CPU: 54.0%; Read bytes: 45056; Write bytes: 344260096; Read time: 2; Write time: 1461 19:59:26 INFO - Running post-run listener: _upload_blobber_files 19:59:26 INFO - Blob upload gear active. 19:59:26 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:59:26 INFO - Copying logs to upload dir... 19:59:26 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.398716 ========= master_lag: 1.82 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-23 19:59:28.604787) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 19:59:28.608743) ========= 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.AFLL732OwT/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.QkLkLbfOl2/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009640 build_url: 'https://queue.taskcluster.net/v1/task/momZT28yRByYFspXVC-SiQ/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-23 19:59:28.633581) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:59:28.633891) ========= 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.AFLL732OwT/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.QkLkLbfOl2/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/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.004651 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:59:28.684029) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 19:59:28.684556) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 19:59:28.685192) ========= ========= Total master_lag: 2.15 =========