builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0058 starttime: 1448336192.73 results: success (0) buildid: 20151123185257 builduid: 3994e6afd70e4d1dabe715cb9217aa69 revision: befb8e2645ef77775bbd5ef7eb866fd51b376458 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 19:36:32.734882) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 19:36:32.735496) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 19:36:32.735809) ========= 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.DwLVMHSAeK/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.Xg8IkWeqxZ/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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.005549 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 19:36:32.757962) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 19:36:32.758265) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 19:36:32.773995) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:36:32.774300) ========= 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.DwLVMHSAeK/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.Xg8IkWeqxZ/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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.005214 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:36:32.824349) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 19:36:32.824687) ========= 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:36:32.825558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:36:32.825840) ========= 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.DwLVMHSAeK/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.Xg8IkWeqxZ/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:36:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 7.33M=0.002s 2015-11-23 19:36:33 (7.33 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.300792 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:36:33.141104) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:36:33.141473) ========= 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.DwLVMHSAeK/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.Xg8IkWeqxZ/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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.025802 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:36:33.190387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-23 19:36:33.190775) ========= 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.DwLVMHSAeK/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.Xg8IkWeqxZ/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:36:33,268 truncating revision to first 12 chars 2015-11-23 19:36:33,268 Setting DEBUG logging. 2015-11-23 19:36:33,268 attempt 1/10 2015-11-23 19:36:33,268 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:36:35,088 unpacking tar archive at: fx-team-befb8e2645ef/testing/mozharness/ program finished with exit code 0 elapsedTime=2.056748 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-23 19:36:35.264418) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 19:36:35.264935) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 19:36:35.278032) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 19:36:35.278431) ========= 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:36:35.278958) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2015-11-23 19:36:35.279255) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.DwLVMHSAeK/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.Xg8IkWeqxZ/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:36:35 INFO - MultiFileLogger online at 20151123 19:36:35 in /builds/slave/test 19:36:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:36:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:36:35 INFO - {'append_to_log': False, 19:36:35 INFO - 'base_work_dir': '/builds/slave/test', 19:36:35 INFO - 'blob_upload_branch': 'Fx-Team', 19:36:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:36:35 INFO - 'branch': 'Fx-Team', 19:36:35 INFO - 'buildbot_json_path': 'buildprops.json', 19:36:35 INFO - 'config_files': ('talos/mac_config.py',), 19:36:35 INFO - 'default_actions': ('clobber', 19:36:35 INFO - 'read-buildbot-config', 19:36:35 INFO - 'download-and-extract', 19:36:35 INFO - 'populate-webroot', 19:36:35 INFO - 'create-virtualenv', 19:36:35 INFO - 'install', 19:36:35 INFO - 'run-tests'), 19:36:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:36:35 INFO - 'download_minidump_stackwalk': True, 19:36:35 INFO - 'download_symbols': 'ondemand', 19:36:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:36:35 INFO - 'tooltool.py': '/tools/tooltool.py', 19:36:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:36:35 INFO - '/tools/misc-python/virtualenv.py')}, 19:36:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:36:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:36:35 INFO - 'installer_path': 'installer.exe', 19:36:35 INFO - 'log_level': 'info', 19:36:35 INFO - 'log_name': 'talos', 19:36:35 INFO - 'log_to_console': True, 19:36:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:36:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:36:35 INFO - 'opt_config_files': (), 19:36:35 INFO - 'pip_index': False, 19:36:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:36:35 INFO - 'cmd': ('bash', 19:36:35 INFO - '-c', 19:36:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:36:35 INFO - 'enabled': True, 19:36:35 INFO - 'halt_on_failure': False, 19:36:35 INFO - 'name': 'check_screen_resolution'},), 19:36:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:36:35 INFO - 'cmd': ('bash', 19:36:35 INFO - '-c', 19:36:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:36:35 INFO - 'enabled': True, 19:36:35 INFO - 'halt_on_failure': False, 19:36:35 INFO - 'name': 'check_screen_resolution'},), 19:36:35 INFO - 'run_cmd_checks_enabled': True, 19:36:35 INFO - 'sps_profile': False, 19:36:35 INFO - 'sps_profile_interval': 0, 19:36:35 INFO - 'suite': 'dromaeojs', 19:36:35 INFO - 'system_bits': '64', 19:36:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:36:35 INFO - 'title': 't-yosemite-r7-0058', 19:36:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:36:35 INFO - 'use_talos_json': True, 19:36:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:36:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:36:35 INFO - 'work_dir': 'build'} 19:36:35 INFO - ##### 19:36:35 INFO - ##### Running clobber step. 19:36:35 INFO - ##### 19:36:35 INFO - Running pre-action listener: _resource_record_pre_action 19:36:35 INFO - Running main action method: clobber 19:36:35 INFO - rmtree: /builds/slave/test/build 19:36:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:36:36 INFO - Running post-action listener: _resource_record_post_action 19:36:36 INFO - ##### 19:36:36 INFO - ##### Running read-buildbot-config step. 19:36:36 INFO - ##### 19:36:36 INFO - Running pre-action listener: _resource_record_pre_action 19:36:36 INFO - Running main action method: read_buildbot_config 19:36:36 INFO - Using buildbot properties: 19:36:36 INFO - { 19:36:36 INFO - "properties": { 19:36:36 INFO - "buildnumber": 15, 19:36:36 INFO - "product": "firefox", 19:36:36 INFO - "script_repo_revision": "production", 19:36:36 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 19:36:36 INFO - "repository": "", 19:36:36 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 19:36:36 INFO - "buildid": "20151123185257", 19:36:36 INFO - "slavename": "t-yosemite-r7-0058", 19:36:36 INFO - "pgo_build": "False", 19:36:36 INFO - "basedir": "/builds/slave/test", 19:36:36 INFO - "project": "", 19:36:36 INFO - "platform": "yosemite_r7", 19:36:36 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:36:36 INFO - "slavebuilddir": "test", 19:36:36 INFO - "scheduler": "tests-fx-team-macosx64-talos", 19:36:36 INFO - "branch": "fx-team", 19:36:36 INFO - "repo_path": "integration/fx-team", 19:36:36 INFO - "stage_platform": "macosx64", 19:36:36 INFO - "builduid": "3994e6afd70e4d1dabe715cb9217aa69", 19:36:36 INFO - "revision": "befb8e2645ef77775bbd5ef7eb866fd51b376458" 19:36:36 INFO - }, 19:36:36 INFO - "sourcestamp": { 19:36:36 INFO - "repository": "", 19:36:36 INFO - "hasPatch": false, 19:36:36 INFO - "project": "", 19:36:36 INFO - "branch": "fx-team-macosx64-talos", 19:36:36 INFO - "changes": [ 19:36:36 INFO - { 19:36:36 INFO - "category": null, 19:36:36 INFO - "files": [ 19:36:36 INFO - { 19:36:36 INFO - "url": null, 19:36:36 INFO - "name": "https://queue.taskcluster.net/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 19:36:36 INFO - } 19:36:36 INFO - ], 19:36:36 INFO - "repository": "", 19:36:36 INFO - "rev": "befb8e2645ef77775bbd5ef7eb866fd51b376458", 19:36:36 INFO - "who": "xquan@mozilla.com", 19:36:36 INFO - "when": 1448336165, 19:36:36 INFO - "number": 6698724, 19:36:36 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:36:36 INFO - "project": "", 19:36:36 INFO - "at": "Mon 23 Nov 2015 19:36:05", 19:36:36 INFO - "branch": "fx-team-macosx64-talos", 19:36:36 INFO - "revlink": "", 19:36:36 INFO - "properties": [ 19:36:36 INFO - [ 19:36:36 INFO - "buildid", 19:36:36 INFO - "20151123185257", 19:36:36 INFO - "Change" 19:36:36 INFO - ], 19:36:36 INFO - [ 19:36:36 INFO - "builduid", 19:36:36 INFO - "3994e6afd70e4d1dabe715cb9217aa69", 19:36:36 INFO - "Change" 19:36:36 INFO - ], 19:36:36 INFO - [ 19:36:36 INFO - "pgo_build", 19:36:36 INFO - "False", 19:36:36 INFO - "Change" 19:36:36 INFO - ] 19:36:36 INFO - ], 19:36:36 INFO - "revision": "befb8e2645ef77775bbd5ef7eb866fd51b376458" 19:36:36 INFO - } 19:36:36 INFO - ], 19:36:36 INFO - "revision": "befb8e2645ef77775bbd5ef7eb866fd51b376458" 19:36:36 INFO - } 19:36:36 INFO - } 19:36:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 19:36:36 INFO - Running post-action listener: _resource_record_post_action 19:36:36 INFO - ##### 19:36:36 INFO - ##### Running download-and-extract step. 19:36:36 INFO - ##### 19:36:36 INFO - Running pre-action listener: _resource_record_pre_action 19:36:36 INFO - Running main action method: download_and_extract 19:36:36 INFO - mkdir: /builds/slave/test/build/tests 19:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:36 INFO - https://queue.taskcluster.net/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:36:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/test_packages.json 19:36:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/test_packages.json 19:36:37 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:36:37 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:36:39 INFO - Downloaded 1149 bytes. 19:36:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:36:39 INFO - Using the following test package requirements: 19:36:39 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:36:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:36:39 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 19:36:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:36:39 INFO - u'jsshell-mac.zip'], 19:36:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:36:39 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 19:36:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:36:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:36:39 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 19:36:39 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:36:39 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 19:36:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:36:39 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 19:36:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:36:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:36:39 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 19:36:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:39 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:36:39 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:36:39 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:36:39 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:36:39 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:36:42 INFO - Downloaded 17526935 bytes. 19:36:42 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:36:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:36:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:36:45 INFO - Return code: 0 19:36:45 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:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:45 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:36:45 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:36:45 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:36:45 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:36:45 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:36:46 INFO - Downloaded 17526935 bytes. 19:36:46 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:36:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:36:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:36:50 INFO - Return code: 0 19:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:50 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:36:51 INFO - Downloaded 11130997 bytes. 19:36:51 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:36:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:36:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 19:36:51 INFO - Return code: 0 19:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:51 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:36:51 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:36:51 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:36:51 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:36:51 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:36:57 INFO - Downloaded 109907772 bytes. 19:36:57 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:36:57 INFO - mkdir: /builds/slave/test/properties 19:36:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:36:57 INFO - Writing to file /builds/slave/test/properties/build_url 19:36:57 INFO - Contents: 19:36:57 INFO - build_url:https://queue.taskcluster.net/v1/task/momZT28yRByYFspXVC-SiQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:36:57 INFO - Running post-action listener: _resource_record_post_action 19:36:57 INFO - Running post-action listener: set_extra_try_arguments 19:36:57 INFO - ##### 19:36:57 INFO - ##### Running populate-webroot step. 19:36:57 INFO - ##### 19:36:57 INFO - Running pre-action listener: _resource_record_pre_action 19:36:57 INFO - Running main action method: populate_webroot 19:36:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:36:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:36:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:36:57 INFO - '../fennec_ids.txt'], 19:36:57 INFO - 'tests': ['tcheck2']}, 19:36:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:36:57 INFO - '--tppagecycles', 19:36:57 INFO - '7'], 19:36:57 INFO - 'tests': ['tsvgm']}}, 19:36:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:36:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:36:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:36:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:36:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:36:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:36:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:57 INFO - 'talos_options': ['--e10s'], 19:36:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:57 INFO - 'tests': ['damp', 'tps']}, 19:36:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:57 INFO - 'talos_options': ['--e10s'], 19:36:57 INFO - 'tests': ['damp', 'tps']}, 19:36:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:36:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:36:57 INFO - 'other': {'tests': ['a11yr', 19:36:57 INFO - 'ts_paint', 19:36:57 INFO - 'tpaint', 19:36:57 INFO - 'sessionrestore', 19:36:57 INFO - 'sessionrestore_no_auto_restore']}, 19:36:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:36:57 INFO - 'tests': ['a11yr', 19:36:57 INFO - 'ts_paint', 19:36:57 INFO - 'tpaint', 19:36:57 INFO - 'sessionrestore', 19:36:57 INFO - 'sessionrestore_no_auto_restore']}, 19:36:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:36:57 INFO - 'tests': ['a11yr', 19:36:57 INFO - 'ts_paint', 19:36:57 INFO - 'tpaint', 19:36:57 INFO - 'sessionrestore', 19:36:57 INFO - 'sessionrestore_no_auto_restore']}, 19:36:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:36:57 INFO - 'tests': ['a11yr', 19:36:57 INFO - 'ts_paint', 19:36:57 INFO - 'tpaint', 19:36:57 INFO - 'sessionrestore', 19:36:57 INFO - 'sessionrestore_no_auto_restore']}, 19:36:57 INFO - 'other_l64': {'tests': ['a11yr', 19:36:57 INFO - 'ts_paint', 19:36:57 INFO - 'tpaint', 19:36:57 INFO - 'sessionrestore', 19:36:57 INFO - 'sessionrestore_no_auto_restore']}, 19:36:57 INFO - 'other_nol64': {'tests': ['a11yr', 19:36:57 INFO - 'ts_paint', 19:36:57 INFO - 'tpaint', 19:36:57 INFO - 'sessionrestore', 19:36:57 INFO - 'sessionrestore_no_auto_restore']}, 19:36:57 INFO - 'svgr': {'tests': ['tsvgx', 19:36:57 INFO - 'tsvgr_opacity', 19:36:57 INFO - 'tart', 19:36:57 INFO - 'tscrollx', 19:36:57 INFO - 'cart']}, 19:36:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:36:57 INFO - 'tests': ['tsvgx', 19:36:57 INFO - 'tsvgr_opacity', 19:36:57 INFO - 'tart', 19:36:57 INFO - 'tscrollx', 19:36:57 INFO - 'cart']}, 19:36:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:57 INFO - 'tests': ['tp5o']}, 19:36:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:57 INFO - 'talos_options': ['--e10s'], 19:36:57 INFO - 'tests': ['tp5o']}, 19:36:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:57 INFO - 'talos_options': ['--xperf_path', 19:36:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:57 INFO - 'tests': ['tp5n']}, 19:36:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:57 INFO - 'talos_options': ['--e10s', 19:36:57 INFO - '--xperf_path', 19:36:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:57 INFO - 'tests': ['tp5n']}}, 19:36:57 INFO - 'talos.zip': {'path': '', 19:36:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:36:57 INFO - Running post-action listener: _resource_record_post_action 19:36:57 INFO - ##### 19:36:57 INFO - ##### Running create-virtualenv step. 19:36:57 INFO - ##### 19:36:57 INFO - Running pre-action listener: _resource_record_pre_action 19:36:57 INFO - Running main action method: create_virtualenv 19:36:57 INFO - Creating virtualenv /builds/slave/test/build/venv 19:36:57 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:36:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:36:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:36:57 INFO - Using real prefix '/tools/python27' 19:36:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:36:58 INFO - Installing distribute.............................................................................................................................................................................................done. 19:37:01 INFO - Installing pip.................done. 19:37:01 INFO - Return code: 0 19:37:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:37:01 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:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:01 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:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:01 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 0x10bc2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0eada0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb519f0>, '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 0x10b8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb448c8>, '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.DwLVMHSAeK/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.Xg8IkWeqxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:37:01 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:37:01 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:37:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DwLVMHSAeK/Render', 19:37:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:01 INFO - 'HOME': '/Users/cltbld', 19:37:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:01 INFO - 'LOGNAME': 'cltbld', 19:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:01 INFO - 'MOZ_NO_REMOTE': '1', 19:37:01 INFO - 'NO_EM_RESTART': '1', 19:37:01 INFO - 'PAGER': '/bin/cat', 19:37:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:01 INFO - 'PWD': '/builds/slave/test', 19:37:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:01 INFO - 'SHELL': '/bin/bash', 19:37:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xg8IkWeqxZ/Listeners', 19:37:01 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 19:37:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:01 INFO - 'USER': 'cltbld', 19:37:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:01 INFO - 'XPC_FLAGS': '0x0', 19:37:01 INFO - 'XPC_SERVICE_NAME': '0', 19:37:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:01 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:37:01 INFO - Cleaning up... 19:37:01 INFO - Return code: 0 19:37:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:37:01 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:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:01 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:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:01 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 0x10bc2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0eada0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb519f0>, '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 0x10b8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb448c8>, '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.DwLVMHSAeK/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.Xg8IkWeqxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:37:01 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:37:01 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:37:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DwLVMHSAeK/Render', 19:37:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:01 INFO - 'HOME': '/Users/cltbld', 19:37:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:01 INFO - 'LOGNAME': 'cltbld', 19:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:01 INFO - 'MOZ_NO_REMOTE': '1', 19:37:01 INFO - 'NO_EM_RESTART': '1', 19:37:01 INFO - 'PAGER': '/bin/cat', 19:37:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:01 INFO - 'PWD': '/builds/slave/test', 19:37:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:01 INFO - 'SHELL': '/bin/bash', 19:37:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xg8IkWeqxZ/Listeners', 19:37:01 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 19:37:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:01 INFO - 'USER': 'cltbld', 19:37:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:01 INFO - 'XPC_FLAGS': '0x0', 19:37:01 INFO - 'XPC_SERVICE_NAME': '0', 19:37:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:02 INFO - Downloading/unpacking psutil>=0.7.1 19:37:02 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:37:02 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:37:02 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:37:02 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:37:02 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:37:02 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:37:04 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:37:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:37:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:37:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:37:05 INFO - Installing collected packages: psutil 19:37:05 INFO - Running setup.py install for psutil 19:37:05 INFO - building 'psutil._psutil_osx' extension 19:37:05 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:37:05 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:37:05 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:37:05 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:37:06 INFO - building 'psutil._psutil_posix' extension 19:37:06 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:37:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:37:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:37:06 INFO - ^ 19:37:06 INFO - 1 warning generated. 19:37:06 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:37:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:37:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:37:06 INFO - Successfully installed psutil 19:37:06 INFO - Cleaning up... 19:37:06 INFO - Return code: 0 19:37:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:06 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 0x10bc2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0eada0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb519f0>, '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 0x10b8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb448c8>, '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.DwLVMHSAeK/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.Xg8IkWeqxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:37:06 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:37:06 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:37:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DwLVMHSAeK/Render', 19:37:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:06 INFO - 'HOME': '/Users/cltbld', 19:37:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:06 INFO - 'LOGNAME': 'cltbld', 19:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:06 INFO - 'MOZ_NO_REMOTE': '1', 19:37:06 INFO - 'NO_EM_RESTART': '1', 19:37:06 INFO - 'PAGER': '/bin/cat', 19:37:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:06 INFO - 'PWD': '/builds/slave/test', 19:37:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:06 INFO - 'SHELL': '/bin/bash', 19:37:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xg8IkWeqxZ/Listeners', 19:37:06 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 19:37:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:06 INFO - 'USER': 'cltbld', 19:37:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:06 INFO - 'XPC_FLAGS': '0x0', 19:37:06 INFO - 'XPC_SERVICE_NAME': '0', 19:37:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:37:06 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:37:06 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:37:06 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:37:06 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:37:06 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:37:06 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:37:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:37:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:37:08 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:37:08 INFO - Installing collected packages: mozsystemmonitor 19:37:08 INFO - Running setup.py install for mozsystemmonitor 19:37:08 INFO - Successfully installed mozsystemmonitor 19:37:08 INFO - Cleaning up... 19:37:09 INFO - Return code: 0 19:37:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10bc2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0eada0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb519f0>, '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 0x10b8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb448c8>, '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.DwLVMHSAeK/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.Xg8IkWeqxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:37:09 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:37:09 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:37:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DwLVMHSAeK/Render', 19:37:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:09 INFO - 'HOME': '/Users/cltbld', 19:37:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:09 INFO - 'LOGNAME': 'cltbld', 19:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:09 INFO - 'MOZ_NO_REMOTE': '1', 19:37:09 INFO - 'NO_EM_RESTART': '1', 19:37:09 INFO - 'PAGER': '/bin/cat', 19:37:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:09 INFO - 'PWD': '/builds/slave/test', 19:37:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:09 INFO - 'SHELL': '/bin/bash', 19:37:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xg8IkWeqxZ/Listeners', 19:37:09 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 19:37:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:09 INFO - 'USER': 'cltbld', 19:37:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:09 INFO - 'XPC_FLAGS': '0x0', 19:37:09 INFO - 'XPC_SERVICE_NAME': '0', 19:37:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:09 INFO - Downloading/unpacking blobuploader==1.2.4 19:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:11 INFO - Downloading blobuploader-1.2.4.tar.gz 19:37:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:37:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:37:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:37:11 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:37:11 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:37:11 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:37:11 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:37:11 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:37:11 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:37:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:37:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:37:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:37:12 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:37:12 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:37:12 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:37:12 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:37:12 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:37:12 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:37:12 INFO - Downloading docopt-0.6.1.tar.gz 19:37:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:37:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:37:12 INFO - Installing collected packages: blobuploader, requests, docopt 19:37:12 INFO - Running setup.py install for blobuploader 19:37:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:37:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:37:12 INFO - Running setup.py install for requests 19:37:13 INFO - Running setup.py install for docopt 19:37:13 INFO - Successfully installed blobuploader requests docopt 19:37:13 INFO - Cleaning up... 19:37:13 INFO - Return code: 0 19:37:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:13 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 0x10bc2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0eada0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb519f0>, '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 0x10b8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb448c8>, '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.DwLVMHSAeK/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.Xg8IkWeqxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:37:13 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:37:13 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:37:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DwLVMHSAeK/Render', 19:37:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:13 INFO - 'HOME': '/Users/cltbld', 19:37:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:13 INFO - 'LOGNAME': 'cltbld', 19:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:13 INFO - 'MOZ_NO_REMOTE': '1', 19:37:13 INFO - 'NO_EM_RESTART': '1', 19:37:13 INFO - 'PAGER': '/bin/cat', 19:37:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:13 INFO - 'PWD': '/builds/slave/test', 19:37:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:13 INFO - 'SHELL': '/bin/bash', 19:37:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xg8IkWeqxZ/Listeners', 19:37:13 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 19:37:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:13 INFO - 'USER': 'cltbld', 19:37:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:13 INFO - 'XPC_FLAGS': '0x0', 19:37:13 INFO - 'XPC_SERVICE_NAME': '0', 19:37:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:37:13 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-WRl9UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:37:13 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-k86EeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:37:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:37:13 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-fRQZTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:37:14 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-wnQjbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:37:14 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-RsnDpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:37:14 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-rCNjwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:37:14 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-JfZW_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:37:14 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-frevyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:37:14 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-wvFweZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:37:14 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-uwGnzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:37:14 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-ZSiKs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:37:14 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-fVB_mK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:37:15 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-Uli1IE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:37:15 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-c7_iqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:15 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-w2Zvvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:37:15 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-v8Ao6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:37:15 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-9swWe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:37:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:37:15 INFO - Running setup.py install for manifestparser 19:37:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:37:15 INFO - Running setup.py install for mozcrash 19:37:15 INFO - Running setup.py install for mozdebug 19:37:15 INFO - Running setup.py install for mozdevice 19:37:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:37:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:37:16 INFO - Running setup.py install for mozfile 19:37:16 INFO - Running setup.py install for mozhttpd 19:37:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:37:16 INFO - Running setup.py install for mozinfo 19:37:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:37:16 INFO - Running setup.py install for mozInstall 19:37:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:37:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:37:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:37:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:37:16 INFO - Running setup.py install for mozleak 19:37:16 INFO - Running setup.py install for mozlog 19:37:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:37:17 INFO - Running setup.py install for moznetwork 19:37:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:37:17 INFO - Running setup.py install for mozprocess 19:37:17 INFO - Running setup.py install for mozprofile 19:37:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:37:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:37:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:37:17 INFO - Running setup.py install for mozrunner 19:37:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:37:17 INFO - Running setup.py install for mozscreenshot 19:37:17 INFO - Running setup.py install for moztest 19:37:18 INFO - Running setup.py install for mozversion 19:37:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:37:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:37:18 INFO - Cleaning up... 19:37:18 INFO - Return code: 0 19:37:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:37: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:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37: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:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10bc2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0eada0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb519f0>, '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 0x10b8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb448c8>, '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.DwLVMHSAeK/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.Xg8IkWeqxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:37:18 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:37:18 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:37:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DwLVMHSAeK/Render', 19:37:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:18 INFO - 'HOME': '/Users/cltbld', 19:37:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:18 INFO - 'LOGNAME': 'cltbld', 19:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:18 INFO - 'MOZ_NO_REMOTE': '1', 19:37:18 INFO - 'NO_EM_RESTART': '1', 19:37:18 INFO - 'PAGER': '/bin/cat', 19:37:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:18 INFO - 'PWD': '/builds/slave/test', 19:37:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:18 INFO - 'SHELL': '/bin/bash', 19:37:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xg8IkWeqxZ/Listeners', 19:37:18 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 19:37:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:18 INFO - 'USER': 'cltbld', 19:37:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:18 INFO - 'XPC_FLAGS': '0x0', 19:37:18 INFO - 'XPC_SERVICE_NAME': '0', 19:37:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:37:18 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-bmXyY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:37:18 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:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:37:18 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-A99fbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:37:18 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:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:37:18 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-jHXFAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:37:18 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:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:37:18 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-RcXm1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:37:18 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:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:37:18 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-tt18i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:37:18 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:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:37:18 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-3rv7yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:37:19 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:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:37:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-7bwi_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:37:19 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:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:37:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-UbAF5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:37:19 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:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:37:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-wTAMNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:37:19 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:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:37:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-AO8XrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:37:19 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:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:37:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-bNGN8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:37:19 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:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:37:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-e6wyEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:37:19 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:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:37:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-3Rv4f7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:37:19 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:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:37:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-RtvFPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:37:19 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:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:19 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-kSDOdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:20 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:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:37:20 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-H4Uyl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:37:20 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:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:37:20 INFO - Running setup.py (path:/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/pip-abQSH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:37:20 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:37:20 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:37:20 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:37:20 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:37:20 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:37:20 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:37:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:37:20 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:37:20 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:37:20 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:37:20 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:37:20 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:37:20 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:37:22 INFO - Downloading blessings-1.5.1.tar.gz 19:37:22 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:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:37:22 INFO - Installing collected packages: blessings 19:37:22 INFO - Running setup.py install for blessings 19:37:22 INFO - Successfully installed blessings 19:37:22 INFO - Cleaning up... 19:37:22 INFO - Return code: 0 19:37:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:37:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:37:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:37:22 INFO - Reading from file tmpfile_stdout 19:37:22 INFO - Current package versions: 19:37:22 INFO - blessings == 1.5.1 19:37:22 INFO - blobuploader == 1.2.4 19:37:22 INFO - docopt == 0.6.1 19:37:22 INFO - manifestparser == 1.1 19:37:22 INFO - mozInstall == 1.12 19:37:22 INFO - mozcrash == 0.16 19:37:22 INFO - mozdebug == 0.1 19:37:22 INFO - mozdevice == 0.47 19:37:22 INFO - mozfile == 1.2 19:37:22 INFO - mozhttpd == 0.7 19:37:22 INFO - mozinfo == 0.9 19:37:22 INFO - mozleak == 0.1 19:37:22 INFO - mozlog == 3.1 19:37:22 INFO - moznetwork == 0.27 19:37:22 INFO - mozprocess == 0.22 19:37:22 INFO - mozprofile == 0.27 19:37:22 INFO - mozrunner == 6.11 19:37:22 INFO - mozscreenshot == 0.1 19:37:22 INFO - mozsystemmonitor == 0.0 19:37:22 INFO - moztest == 0.7 19:37:22 INFO - mozversion == 1.4 19:37:22 INFO - psutil == 3.1.1 19:37:22 INFO - requests == 1.2.3 19:37:22 INFO - wsgiref == 0.1.2 19:37:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10bc2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc0a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0eada0d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb519f0>, '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 0x10b8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb448c8>, '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.DwLVMHSAeK/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.Xg8IkWeqxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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:37:22 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:37:22 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:37:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DwLVMHSAeK/Render', 19:37:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:22 INFO - 'HOME': '/Users/cltbld', 19:37:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:22 INFO - 'LOGNAME': 'cltbld', 19:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:22 INFO - 'MOZ_NO_REMOTE': '1', 19:37:22 INFO - 'NO_EM_RESTART': '1', 19:37:22 INFO - 'PAGER': '/bin/cat', 19:37:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:22 INFO - 'PWD': '/builds/slave/test', 19:37:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:22 INFO - 'SHELL': '/bin/bash', 19:37:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xg8IkWeqxZ/Listeners', 19:37:22 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 19:37:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:22 INFO - 'USER': 'cltbld', 19:37:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:22 INFO - 'XPC_FLAGS': '0x0', 19:37:22 INFO - 'XPC_SERVICE_NAME': '0', 19:37:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:23 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:37:23 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:37:23 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:37:23 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:37:23 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:37:23 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:37:23 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:37:23 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:37:23 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:37:23 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:37:23 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:37:23 INFO - Cleaning up... 19:37:23 INFO - Return code: 0 19:37:23 INFO - Running post-action listener: _resource_record_post_action 19:37:23 INFO - Running post-action listener: _start_resource_monitoring 19:37:23 INFO - Starting resource monitoring. 19:37:23 INFO - ##### 19:37:23 INFO - ##### Running install step. 19:37:23 INFO - ##### 19:37:23 INFO - Running pre-action listener: _resource_record_pre_action 19:37:23 INFO - Running main action method: install 19:37:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:37:23 INFO - Reading from file tmpfile_stdout 19:37:23 INFO - Detecting whether we're running mozinstall >=1.0... 19:37:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:37:23 INFO - Reading from file tmpfile_stdout 19:37:23 INFO - Output received: 19:37:23 INFO - Usage: mozinstall [options] installer 19:37:23 INFO - Options: 19:37:23 INFO - -h, --help show this help message and exit 19:37:23 INFO - -d DEST, --destination=DEST 19:37:23 INFO - Directory to install application into. [default: 19:37:23 INFO - "/builds/slave/test"] 19:37:23 INFO - --app=APP Application being installed. [default: firefox] 19:37:23 INFO - mkdir: /builds/slave/test/build/application 19:37:23 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:37:23 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:37:54 INFO - Reading from file tmpfile_stdout 19:37:54 INFO - Output received: 19:37:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:37:54 INFO - Running post-action listener: _resource_record_post_action 19:37:54 INFO - ##### 19:37:54 INFO - ##### Running run-tests step. 19:37:54 INFO - ##### 19:37:54 INFO - Running pre-action listener: _resource_record_pre_action 19:37:54 INFO - Running main action method: run_tests 19:37:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:37:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:37:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:37:54 INFO - 2015-11-23 19:37:54.767 screenresolution[1645:7710] starting screenresolution argv=screenresolution get 19:37:54 INFO - 2015-11-23 19:37:54.770 screenresolution[1645:7710] Display 0: 1600x1200x32@60 19:37:54 INFO - 2015-11-23 19:37:54.776 screenresolution[1646:7712] starting screenresolution argv=screenresolution list 19:37:54 INFO - Available Modes on Display 0 19:37:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:37:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:37:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:37:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:37:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:37:55 INFO - Intel Iris: 19:37:55 INFO - Chipset Model: Intel Iris 19:37:55 INFO - Type: GPU 19:37:55 INFO - Bus: Built-In 19:37:55 INFO - VRAM (Dynamic, Max): 1536 MB 19:37:55 INFO - Vendor: Intel (0x8086) 19:37:55 INFO - Device ID: 0x0a2e 19:37:55 INFO - Revision ID: 0x0009 19:37:55 INFO - Displays: 19:37:55 INFO - Display: 19:37:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:37:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:37:55 INFO - Display Serial Number: 1600x1200 60 19:37:55 INFO - Main Display: Yes 19:37:55 INFO - Mirror: Off 19:37:55 INFO - Online: Yes 19:37:55 INFO - Rotation: Supported 19:37:55 INFO - Return code: 0 19:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:37:55 INFO - Python 2.7.3 19:37:55 INFO - Return code: 0 19:37:55 INFO - grabbing minidump binary from tooltool 19:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:55 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 0x10bb519f0>, '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 0x10b8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bb448c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:37:55 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:37:55 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:37:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:37:55 INFO - Return code: 0 19:37:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:37:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:37:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:37:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:37:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:37:55 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', '--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-0058', '--webServer', 'localhost'] in /builds/slave/test/build 19:37:55 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 --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-0058 --webServer localhost 19:37:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DwLVMHSAeK/Render', 19:37:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:55 INFO - 'HOME': '/Users/cltbld', 19:37:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:55 INFO - 'LOGNAME': 'cltbld', 19:37:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:37:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:55 INFO - 'MOZ_NO_REMOTE': '1', 19:37:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:37:55 INFO - 'NO_EM_RESTART': '1', 19:37:55 INFO - 'PAGER': '/bin/cat', 19:37:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:55 INFO - 'PWD': '/builds/slave/test', 19:37:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:37:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:55 INFO - 'SHELL': '/bin/bash', 19:37:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xg8IkWeqxZ/Listeners', 19:37:55 INFO - 'TMPDIR': '/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/', 19:37:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:55 INFO - 'USER': 'cltbld', 19:37:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:55 INFO - 'XPC_FLAGS': '0x0', 19:37:55 INFO - 'XPC_SERVICE_NAME': '0', 19:37:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:55 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', '--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-0058', '--webServer', 'localhost'] with output_timeout 3600 19:37:55 INFO - mozversion INFO | application_buildid: 20151123185257 19:37:55 INFO - mozversion INFO | application_changeset: befb8e2645ef77775bbd5ef7eb866fd51b376458 19:37:55 INFO - mozversion INFO | application_display_name: Nightly 19:37:55 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:37:55 INFO - mozversion INFO | application_name: Firefox 19:37:55 INFO - mozversion INFO | application_remotingname: firefox 19:37:55 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:37:55 INFO - mozversion INFO | application_vendor: Mozilla 19:37:55 INFO - mozversion INFO | application_version: 45.0a1 19:37:55 INFO - mozversion INFO | platform_buildid: 20151123185257 19:37:55 INFO - mozversion INFO | platform_changeset: befb8e2645ef77775bbd5ef7eb866fd51b376458 19:37:55 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:37:55 INFO - mozversion INFO | platform_version: 45.0a1 19:37:55 INFO - 2015-11-23 19:37:55,322 DEBUG : using testdate: 1448336275 19:37:55 INFO - 2015-11-23 19:37:55,322 DEBUG : actual date: 1448336275 19:37:55 INFO - 2015-11-23 19:37:55,669 INFO : starting webserver on 'localhost:49271' 19:37:55 INFO - 2015-11-23 19:37:55,670 INFO : Starting test suite t-yosemite-r7-0058 19:37:55 INFO - 2015-11-23 19:37:55,670 INFO : Starting test dromaeo_css 19:37:55 INFO - 2015-11-23 19:37:55,670 DEBUG : operating with platform_type : mac_ 19:37:55 INFO - 2015-11-23 19:37:55,671 INFO : Initialising browser for dromaeo_css test... 19:37:55 INFO - 2015-11-23 19:37:55,683 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/tmpxOwhy7/profile http://localhost:49271/getInfo.html 19:37:57 INFO - 2015-11-23 19:37:57,914 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:37:57 INFO - 2015-11-23 19:37:57,915 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:37:57 INFO - 2015-11-23 19:37:57,915 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:37:57 INFO - 2015-11-23 19:37:57,915 DEBUG : BROWSER_OUTPUT: __metrics 19:37:57 INFO - 2015-11-23 19:37:57,931 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:37:58 INFO - 2015-11-23 19:37:58,566 INFO : Browser initialized. 19:37:58 INFO - 2015-11-23 19:37:58,567 INFO : Running cycle 1/1 for dromaeo_css test... 19:37:58 INFO - 2015-11-23 19:37:58,567 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/tmpxOwhy7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:38:10 INFO - 2015-11-23 19:38:10,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 226189312 19:38:10 INFO - 2015-11-23 19:38:10,473 DEBUG : BROWSER_OUTPUT: 19:39:01 INFO - 2015-11-23 19:39:01,408 DEBUG : BROWSER_OUTPUT: 1448336341405 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:41:13 INFO - 2015-11-23 19:41:13,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 19:41:14 INFO - 2015-11-23 19:41:14,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 417021952 19:41:14 INFO - 2015-11-23 19:41:14,927 DEBUG : BROWSER_OUTPUT: 19:44:17 INFO - 2015-11-23 19:44:17,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 19:44:18 INFO - 2015-11-23 19:44:18,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 359768064 19:44:18 INFO - 2015-11-23 19:44:18,311 DEBUG : BROWSER_OUTPUT: 19:47:20 INFO - 2015-11-23 19:47:20,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 19:47:20 INFO - 2015-11-23 19:47:20,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 337465344 19:47:20 INFO - 2015-11-23 19:47:20,985 DEBUG : BROWSER_OUTPUT: 19:50:23 INFO - 2015-11-23 19:50:23,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 19:50:23 INFO - 2015-11-23 19:50:23,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 323354624 19:50:23 INFO - 2015-11-23 19:50:23,696 DEBUG : BROWSER_OUTPUT: 19:53:26 INFO - 2015-11-23 19:53:26,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 19:53:27 INFO - 2015-11-23 19:53:27,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 319995904 19:53:27 INFO - 2015-11-23 19:53:27,472 DEBUG : BROWSER_OUTPUT: 19:56:29 INFO - 2015-11-23 19:56:29,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 19:56:30 INFO - 2015-11-23 19:56:30,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 366891008 19:56:30 INFO - 2015-11-23 19:56:30,228 DEBUG : BROWSER_OUTPUT: 19:56:30 INFO - 2015-11-23 19:56:30,228 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:56:30 INFO - 2015-11-23 19:56:30,228 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:56:30 INFO - 2015-11-23 19:56:30,228 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:56:30 INFO - 2015-11-23 19:56:30,228 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:56:30 INFO - 2015-11-23 19:56:30,228 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3414.061133188374;3499.650034996499;3539.2213712983153;3552.6447355264477;3556.6087730349664;5677.943220567793;5745.224394706714;5804.680742559158;5840.678762668052;5889.85275368116;5699.287589051369;5846.415358464152;5854.20968169297;5855.560832937525;5859.384764599719;4373.453318335208;5214.7653355598895;5262.894742105155;5275.340582427197;5327.573794096463;5326.174442961347;5328.360596728378;5331.6534425262425;5331.866703332409;5340.839774806743;5320.388155362144;5325.147976323789;5331.493508116722;5332.040232758102;5333.066713325172;5308.124159513656;5324.041672498949;5326.334208223972;5335.1197052486295;5335.759890804884;5158.664686795346;5235.55497782689;5292.232626269208;5312.256284120226;5335.0663633863915;5748.913766293509;5866.70666466675;5950.642961422329;5981.192539007222;5993.61041532299;5279.340082489689;6300.495960323163;6305.527085468608;6306.274778400497;6312.463440607508;6165.260168779775;6210;6287.119803227506;6308.369163083701;6312.147860038882;5981.192539007222;6050.806008883618;6060.151578778975;6074.028155495143;6087.026075827846;6328.905066424008;6393.520485963571;6413.262474815456;6430.7106180222;6430.742770289136;6090.695465226721;6119.258838874149;6157.753689852445;6158.568900177034;6261.436470717566;6319.747210111636;6368.77709280173;6369.71336289868;6375.23497180332;6377.489800815923;6256.124142620037;6312.0531920211415;6315.463185629181;6335;6336.20797400325;6104.041878991925;6107.226802228232;6247.187865577446;6248.0003199487865;6270.7491700331475;4967.105920934194;4988.351514303117;5065.316182315414;5066.82266120684;5069.986002799455;4541.841035563805;4546.954530454719;4555.544445555418;4569.54304569547;4577.702449340849;5659.349174844946;5731.799387021434;5757.395473475309;5760.913586296209;5891.499222566044;6167.722452489649;6270.59241149333;6294.213223347082;6301.558890877594;6307.5269354798575;5830.7959221427045;5878.559108066912;5915.515483496942;5952.375000624958;5980.55145864062;5334.039872822929;5465.316835395575;5524.8066317679495;5535.169724541271;5539.833804985777;6299.496040316763;6359.77740779089;6360.6501642409185;6370.936290637034;6372.6495042773095;6226.40849119333;6287.685615719104;6316.936830631818;6320.367963203643;6323.20959880015;5465.836024919259;6367.204099487564;6417.294097649348;6427.83930401725;6466.805995820133;6103.572749907464;6287.308396076336;6293.496520278275;6327.746890124344;6349.523785716182;6273.968630157003;6275.529335299962;6277.18396608438;6281.403266689657;6282.403171698864;6086.965215913394;6138.447539721446;6146.016637338004;6151.200343955257;6218.689065546614;6098.400566736114;6253.37466253371;6262.968685156545;6268.435840774352;6270.2475702915945;5400.783968641211;6123.020316749299;6134.04922237054;6134.447899689049;6160.229971253593;5185.299984502195;6070.089486577049;6095;6114.7248373822395;6116.944513560587;6122.540809439399;6125.673500107169;6133.785317514044;6136.478399336106;6144.38556144382 19:56:30 INFO - 2015-11-23 19:56:30,230 DEBUG : BROWSER_OUTPUT: |1;ext.html;528.105581631797;583.7402355951598;611.1566038866365;630.9557682036228;645.1999520594461;31657.366852662934;32253.51619725706;32331.51502727458;32340.514892276635;32398.838005809997;33423;33865.32269354611;33891.99999999994;34131.82934085326;42219.577804221946;8507.78730531737;9966.750831229241;9968.102870741632;9977.90022099777;9990.400575965428;9032.729018129467;9405.294602904776;9687.128158465737;9850.113489785917;9887.752806179868;8941.418807777474;9062.682806101788;9127.543622818832;9863.852042219372;9966.90033099667;8832.8675069874;8907.242884354806;10389.324693894949;12051.819222711667;12264.81602775959;11776.470058847372;11939.044876409866;11957.402129893471;11967.581134660331;11974.700632484171;32116.03651890447;41388.37917431241;41625.791871040754;41701.582984170076;41774.74675759732;2722.2377734234447;2911.7670586353042;3066.9079927602206;3224.3712476067176;3540.7344449166417;29117.85441072802;29432;29508.852455737582;29818;29982.55026174609;2782.9304267393477;2786.3312804926672;2861.2846788302923;2888.133559932012;2948.3955789063407;473735;474882;475517;477077.6146119282;477296;59034.40965590375;60759.39240607537;60770.69614651898;66318.6736265272;66955;68898.24407023763;68941;69027.65486172537;69801.65099174471;70106;15629;15812.446564370191;15826.525204243891;15837;15846.12846293465;12050.216735912138;12115.030797536176;12125.818112728317;12153.027757779357;12169;19834.90908000045;20270.986450677407;20302.492437689176;20309.79690203079;20365.49086272855;7799.220077992155;8928.241099506486;9116.39902238612;9151.470022338852;9152.947411047682;954.2938225712923;963.9759006024765;971.3293135806401;973.756560859785;1010.6361709784471;29782.55326170109;29798;30111.94608188703;30182.547261790653;31316;1067.1836045425257;1080.1089101491302;1096.8903109688968;1186.1756079524648;1207;12918.741625167444;13002.544910928262;14629.902757293246;14949.551513454613;15049.126042255268;440125;445423;445652;447200;447679;57369.42630573641;57494.42505574974;57540.71229643909;57650.13524797132;57731;1315.5921664284103;1359.6940688345044;1363.8431580368185;1485.6731519065788;1624.976264953072;33252.50121248232;33529.66470335265;33597;33793.324133517686;34313.828430857684;57157.14264285956;57801;57810.13284800816;58001;58085.41914580969;343200.28399857844;351286;365911;373751;390117;28427.573586396633;28878.855605722678;34095.97712068642;34218.14454638654;34506.82746586251;44189.55810441983;45464.77267613641;45482.54517454783;45523.317150243434;46914;35904.8204758985;38855.80572097235;39586.2082758349;39917.80041099892;40046.799766000986;37801.81765464553;38354.42468363033;38844.223115536966;38844.223115536966;39163.41254881122;37443.62556374401;38657.2268554633;38846.61153388543;38887.222255555294;39061.804690976365;32032.039038828872;34375.484367734;34442;34807;34892.65107348894;26034.869825650752;27292.59061114045;27315.59026614642;27371.86314068417;27453.76458059432 19:56:30 INFO - 2015-11-23 19:56:30,234 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.1937102776699;355.97508174427793;360.18597968591007;360.398135114359;362.3821384539361;15586.688266234669;15675.216239188052;19680.704789428153;19730.112144953477;20292.492687682814;19541.41375758726;19594.902025489853;19954;20047.699284510745;20069.397918062445;6551.344865513458;6725.361090696376;6729.966350168267;6739.764108256212;6744.190697116328;4764.309175169598;4902.044101400211;4919.597914594341;6627.204735431731;7473.663685134155;7377.852442951138;7476.6261686915705;7643.579603121826;7646.694132234704;7662.923370766277;7504.4371672124535;7514.887276690854;7516.624168791594;7530.849383012363;7533.886991695129;6980.685869135901;7200.207977122513;7202.279772022808;7206.351428371419;7224.6026468544205;21114.261000864895;21116;22182.00180991843;26779.866100669566;26935.787889545016;1981.128303546435;2084.9166033358647;2148.2803260907613;2149.5163588192686;2152.1714140056033;15344;15523;15533.766993495106;15609;15726.663233625155;1792.5429015601069;1813.9233567548738;1835.8164183581669;1846.769153855768;1863.3664554051688;70944;84665.73001404923;96611.51694241555;99328.51007234897;100281;18424;18494.630107397777;18681.90659046723;18694.34569790078;18705.53236169107;27248;27248.318792030357;27273.727262727516;27292.31769205746;27357.452850943268;10139.493025348851;10147.594096236215;10195.286329956833;10243.539040743184;10261.435621040915;8083;8092;8169.060558035783;8178.795530111675;8292.460990035628;6785.977859778598;7173.748918787817;8544.333854898236;8615.181557752003;8754.69358572447;1718.776559047316;1779.332750218668;1788.928442862271;1822.5808064145322;1830.7986121526621;782.7456076775071;894.7852515396258;980.3333733061444;985.8324084905584;988.5353883674661;16593.66812663764;18868.96220707874;19691.310804121786;19804.70292945607;19864.808111513354;847.1201895319422;927.7634203278121;940.7742141885898;952.5094576293214;959.1271942532262;10599.470026498644;10622.575096996188;10682.252242342962;10754.56981720738;10938.617148399928;732872;744042;760360;762070;763246;108329;109262;110522.44738776254;113018.86981130083;117911.8208817918;1198;1202.296656455983;1208.0818577880698;1236.1223531292883;1261.4323554400557;17792.02143882099;17913.910430447766;17935.73096403581;17994.820051799314;17997;50622.2406663893;50780.238296424846;51078.23382649189;51153;51331.48668513267;69728.95406569006;70618;70840.2075771675;70947.64526177336;72166.27833721806;9370.297227707813;9391.342606017513;9555;9641.710748677551;9692.22462203008;13334.799978000532;19001.144948477075;19213.423597291545;19394.2242310306;19514.21943122259;14193.787093193403;15226;15304.464343748361;15623.765643515584;15716.764248536052;15417.84582154209;15589.76615350748;15624.765628515808;15839.287232074816;15928.92035539815;14998.325075371853;15711.135887526296;16062.598435039217;16445.506634800975;16556.75164872504;9590.376625519319;9802.460864652512;9840.901590983998;9924.40453572788;9976.301658883809;11660.242084264495;15312.464063757716;15620.453284135001;15654.843451565339;15692.058476491447 19:56:30 INFO - 2015-11-23 19:56:30,234 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1356.5387768158823;1614.3139165854514;1933.9556639414716;1938.6316599846027;1998.9500262493445;6465.676716164191;7976.68093276269;8014.398920080996;8224.177582241788;8580.91419085809;8303.211194936486;8432.15678432158;8432.198941100585;8441.957790211056;8454.070052294242;2136.69017992391;2371.1345358944036;2391.282615215437;2393.3179043972473;2393.85636861788;2085.14509051289;2212.203606701586;2219.3120132758895;2434.221049264236;2435.6833611630464;2199.318211354477;2206.7572567017696;2366.680498132756;2386.5942789725786;2394.9760502395015;2138.764735879052;2201.8348623853117;2362.4684445999596;2392.8803559822027;2400.531896280226;2203.4050806282376;2349.1777877742825;2413.5776239158076;2418.903243870243;2425.260295609838;7118.750843720445;8317.916820831835;8328.875066874001;8330.708425205088;8353.289970352527;5093.236014597803;5176.016556854186;5181.093308670967;5196.9740151299;5203.297554830126;3485.8779942701885;3501.562304711911;3562.340966921128;3577.8926632200814;3587.1032241939515;1043.9217058720626;1076.34343050739;1078.0620859851902;1084.073117484555;1644.8026236851535;11053.115750739922;11162.609308674238;11169.944150279196;11173.162012849069;11182.32906025641;4646.279826626878;4736.834210802605;4773.95226047742;4789.042191561632;4796.616270698336;9748.220142388593;9754.707358779247;9772.462514561767;9785;9787.755306117404;5212.3223980883;5212.661177023481;5217.530422261939;5247.790088396421;5248.055350036953;4720.669553131248;4726.432828060586;4761.166795810719;4771.093492236464;4774.973380723091;3712.480252764615;3758.511393518825;3767.1900541383734;3791.2227993261317;3825.1775868187915;1188.2157775867886;1189.3636904256182;1193.91045671575;1197.6826141072622;1199.6281152842473;1065.1851333729703;1103.475848971732;1105.5743538737645;1268.9365531723377;1389.6317475868902;7646.617669116633;7777.144514103444;7839.804004899923;7867.842643147105;7892.4869883457395;1208.6011616166643;1210.878912108782;1217.0628615965657;1224.2103843021202;1240.683625675447;5854.941450585525;5984.581079324405;5999.700014999233;6092.817215483454;6165.907511387333;9428.858567121499;9436.716898493056;9645.662401815904;9679.177269931994;9735.367201132045;9490.383125096985;9626.326157169071;9649.372790768577;9652.90347096534;9656.855147172799;5784.82645520635;7570.205128461543;7670.42471814605;7759.883601745978;7761.379089672812;7845.333146682596;7852.057753069668;7856.607169641609;7857.528548286892;7862.567558784322;8831.779205519913;8939.150780675825;8974;8981.101889810967;9080.909190908007;9089.272858171462;9199.908000919904;9352.719418417459;9443.716688499357;9454.905450945678;6832.111825462658;6954.687039083152;6955.965220173866;6964.616946068015;6978.685959131953;7920.920790792018;7991.520508769492;7996.56018918965;7997.640106195351;8000.959995199987;7262.34638882482;7376.18861925177;7431.702731890664;7542;7628.160902300631;7200.963995179991;7284.817879553054;7405.740799072007;7430.665620047219;7448.553086814808;7421;7456.067991501062;7477.738279160203;7478.551286922802;7478.738244161428;6748.628825414649;6775.119234499483;6776.7628133015105;6822.215445223665;6834.8633027340165;6307.621542707268;6863.794086177422;6876.69054892521;6888.793336199922;6894.689738961659 19:56:30 INFO - 2015-11-23 19:56:30,237 DEBUG : BROWSER_OUTPUT: |4;prototype.html;274.969753327134;289.26815157651134;326.960764708235;327.5741536003195;334.6853957280158;6782.423494003009;6843.452523798097;6934.994425808261;6942.826429339269;6947.687354069067;5132.384113906336;6621.6027038377615;6788.490863185256;6791.626460544668;6925.653717314127;4785.875319299962;4856.854294371165;4994.1260279451135;5010.173321401964;5010.498950104997;4394.802233899466;4398.318260669601;4643.744594047343;5010.849674509771;5011.373578302712;4694.507076756942;4708.411448568929;4955.950440495585;4960.479149689285;4987.675801072936;4723.126221648989;4905.386826646652;4917.631177661689;4980.327655766461;4998.40019197695;4260.169266992907;4262.126264115849;4267.957320426818;4284.764337961411;4288.16380805743;6148.862460444832;6575.868482630369;6578.901316480256;6587.110740050128;6597.60414375139;5274.841754747364;5732.8853422931725;5932.822015339547;5987.1019347097845;6000;7364.77905662831;7372.741954031583;7373.926260737431;7379.963100184518;7386.519876208029;4723.126221649006;4726.432828060655;4726.503717109688;4730.905381892378;4752.42970843501;7514.0607424071995;7704.26809453101;7804.492707973906;7826.452148349618;7828.373730101578;4748.145333839942;4753.310769938409;4753.83361582343;4758.214894542361;4764.380630518011;4808.990112076433;4828.565429111397;4836.226203807444;4837.274408838703;4839.516048395132;5854;5876.559258055663;5880.941190588125;5890.14592884038;5894.764209431574;6046.606970546901;7134.215236324;7392.039034925425;7411.444141689287;7435.628218589049;1659.8795812826536;1681.184625456677;1681.2098313792499;1684.62938153606;1686.8397502237267;997.2249396074998;1021.6424251511911;1050.7058023753361;1057.0011339284456;1077.2943721862193;6668.499862510331;6785.762498312535;6887.965560172167;6907.412869906014;6912.135983002125;6766.086578311963;7641.159472458025;7794.376449884109;7801.4929029612895;7801.765947021599;6620.702068406837;6691.029800678874;6933.479989000845;6952.339527744856;6958.199807022156;4026.295398305285;4078.408630748525;4079.286124928126;4087.243859885871;4088.7546747195265;8032.706590297949;8053.838923221503;8060.435769496196;8078;8090.797730056795;7741;8035.919640803634;8056.355491560661;8082.19178082187;8087.514749115072;8030.156833532512;8049.919500805151;8057.395695322757;8079.070906845671;8082.070561885341;7561.584112873625;7766.805829854073;7785.299323060952;7794.610269486389;7820.804479888048;7594.468387213063;7611.505252158813;7614.048243969504;7620.504667196615;7629.3133617974645;5792.102224155263;6872.484563657846;7967.00412448444;8048.597570121354;8050.798730031796;4818.590419814355;4923.852284431473;4954.20732682769;4981.078500477423;4996.050750357421;6900.93099069023;7655.464117511943;7658.655360508679;7673.117591476828;7675.884861726967;6204.317525072148;7133.251008644225;7328.853422931618;7343.70625174987;7350.338469537767;5843.065109582446;7347.412207023533;7348.301911318416;7356.889646655198;7360.4479664026485;5787.565932554991;6910.723571057101;7104.11198600175;7113.181984071898;7177.425805935408;7235.167955685163;7271.381932535794;7284.235155308616;7325.4505912057875;7363.484556081237;7258.056452661121;7269.527480713737;7280.235575264521;7285.744998925013;7290.817729556804 19:56:30 INFO - 2015-11-23 19:56:30,238 DEBUG : BROWSER_OUTPUT: |5;yui.html;720.7837648705389;759.6847308367027;799.224751990569;817.5299202958297;838.9077201507837;14944;15280.235988200573;15299.464518741846;15304.928654994155;15311.234438278098;14217.502387416442;14442.711145777104;14460.710785784278;14461;14466.927665361685;753.7022875963991;765.2768134113265;765.4909485192368;766.1993217088128;936.255676736994;743.3569961982873;756.5838788666239;944.8110377924409;964.8263312603729;974.0697633759743;999.6501224571379;1001.9198464122853;1014.4471263161595;1016.7864748402807;1016.8017236638858;792.694812497187;998.1266391907081;1007.5868893753562;1007.8740157480315;1009.4094954451618;593.5696619950545;593.652713162796;738.582700774061;751.7857410637996;753.2881427051439;15076.698466030617;15153.242337883172;15212.619684507865;15215.391384344613;15220.923895380563;10946.781064378747;12613.243205407705;12686.302253376061;12796.104272700915;13162;10147.415488107948;10245.641402550875;10257.128144107759;10351.223658225663;10757.515911783988;3480.773749706261;3529.9294014119573;3531.1525233943926;3531.5585551806025;3544;70272.648636757;70943;71609.64195179043;72174.91737623939;82794.58602707008;9469.89345995768;9526.428414295164;9536.66621668252;9548.522573871278;9570.61717531305;21189.046492907855;21239;21280;21292.78707212939;21295.68056479154;7268.636568171676;7334.119905611254;7492.063492063492;7516.849663006709;7632;3968.1865217630316;4053.0880551875593;4100;4106.917861642751;4185.267578173807;3607.332643460968;3638.290533345972;3643.8360273787744;3647;3652.7443078984747;654.7479220500046;663.4791688524485;665.3313420012953;672.3041651890368;673.8416472129046;496.14415133893743;508.9083964886356;515.2786099460785;518.9896202075937;542.7530473634487;7878.487898286593;8214.178582141858;8432;8549.273311768446;8629.741107766777;517.503196930943;529.3706536339733;584.1471451680509;601.7893737192036;620.5097972601594;3853.6917046636204;4104.794760261975;4132.607402296777;4181.60274773896;4224.070704445017;97563;99750;100379.49810251048;100569.49715251377;100633.49683251683;82608;84442.15557844465;85079.14920850712;85195.5740221295;87985;73155.17112072134;73570.63214683892;73968;73971.26028739751;74628;8059.791031345345;8230.21812927771;8280.171982801672;8299.377546683902;8334.249917507212;40793;50978.74510627423;51375.743121284155;51928.48071519237;52763.20855187099;71410.64294678494;71556;71658;73132.53734925378;77892.61053694696;10873.836892446461;11073.83389249178;11420.600278990196;11443.599474018702;11675.241109327866;11975.880241197825;12122.757544848877;12128.393580321124;12156.635300940987;12479.812802807783;11622.82565761531;11681.474333654836;11704.882951170379;11734.530618775154;11766.058715302584;11625.709357266136;11628.825567616323;11646.417679116179;11689.941550292195;11712.238704484182;11464.197506174487;11479.713007174554;11495.137864660352;11497.965183133558;11501.194916355775;9810.901890980998;10247.128994035591;10275.486225688535;10325.690229293134;10346.482675866026;9563.952180239054;9817.754556136153;10124.493775311352;10137.138343240907;10139.493025348556 19:56:30 INFO - 2015-11-23 19:56:30,239 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:56:30 INFO - 2015-11-23 19:56:30,239 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:56:30 INFO - 2015-11-23 19:56:30,239 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1701 19:56:30 INFO - 2015-11-23 19:56:30,239 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:56:30 INFO - 2015-11-23 19:56:30,239 DEBUG : BROWSER_OUTPUT: __startTimestamp1448337390224__endTimestamp 19:56:30 INFO - 2015-11-23 19:56:30,239 DEBUG : BROWSER_OUTPUT: 19:56:30 INFO - 2015-11-23 19:56:30,239 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:56:30 INFO - 2015-11-23 19:56:30,239 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:56:30 INFO - 2015-11-23 19:56:30,239 DEBUG : BROWSER_OUTPUT: 19:56:30 INFO - 2015-11-23 19:56:30,239 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5820.24 Median:6095.00 stddev:632.74 (10.4%) stddev-sans-first:605.88 19:56:30 INFO - 2015-11-23 19:56:30,241 DEBUG : BROWSER_OUTPUT: Values: 3414.1 3499.7 3539.2 3552.6 3556.6 5677.9 5745.2 5804.7 5840.7 5889.9 5699.3 5846.4 5854.2 5855.6 5859.4 4373.5 5214.8 5262.9 5275.3 5327.6 5326.2 5328.4 5331.7 5331.9 5340.8 5320.4 5325.1 5331.5 5332.0 5333.1 5308.1 5324.0 5326.3 5335.1 5335.8 5158.7 5235.6 5292.2 5312.3 5335.1 5748.9 5866.7 5950.6 5981.2 5993.6 5279.3 6300.5 6305.5 6306.3 6312.5 6165.3 6210.0 6287.1 6308.4 6312.1 5981.2 6050.8 6060.2 6074.0 6087.0 6328.9 6393.5 6413.3 6430.7 6430.7 6090.7 6119.3 6157.8 6158.6 6261.4 6319.7 6368.8 6369.7 6375.2 6377.5 6256.1 6312.1 6315.5 6335.0 6336.2 6104.0 6107.2 6247.2 6248.0 6270.7 4967.1 4988.4 5065.3 5066.8 5070.0 4541.8 4547.0 4555.5 4569.5 4577.7 5659.3 5731.8 5757.4 5760.9 5891.5 6167.7 6270.6 6294.2 6301.6 6307.5 5830.8 5878.6 5915.5 5952.4 5980.6 5334.0 5465.3 5524.8 5535.2 5539.8 6299.5 6359.8 6360.7 6370.9 6372.6 6226.4 6287.7 6316.9 6320.4 6323.2 5465.8 6367.2 6417.3 6427.8 6466.8 6103.6 6287.3 6293.5 6327.7 6349.5 6274.0 6275.5 6277.2 6281.4 6282.4 6087.0 6138.4 6146.0 6151.2 6218.7 6098.4 6253.4 6263.0 6268.4 6270.2 5400.8 6123.0 6134.0 6134.4 6160.2 5185.3 6070.1 6095.0 6114.7 6116.9 6122.5 6125.7 6133.8 6136.5 6144.4 19:56:30 INFO - 2015-11-23 19:56:30,241 DEBUG : BROWSER_OUTPUT: 19:56:30 INFO - 2015-11-23 19:56:30,241 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:58920.75 Median:19722.78 stddev:114127.48 (578.7%) stddev-sans-first:114363.42 19:56:30 INFO - 2015-11-23 19:56:30,241 DEBUG : BROWSER_OUTPUT: Values: 528.1 583.7 611.2 631.0 645.2 31657.4 32253.5 32331.5 32340.5 32398.8 33423.0 33865.3 33892.0 34131.8 42219.6 8507.8 9966.8 9968.1 9977.9 9990.4 9032.7 9405.3 9687.1 9850.1 9887.8 8941.4 9062.7 9127.5 9863.9 9966.9 8832.9 8907.2 10389.3 12051.8 12264.8 11776.5 11939.0 11957.4 11967.6 11974.7 32116.0 41388.4 41625.8 41701.6 41774.7 2722.2 2911.8 3066.9 3224.4 3540.7 29117.9 29432.0 29508.9 29818.0 29982.6 2782.9 2786.3 2861.3 2888.1 2948.4 473735.0 474882.0 475517.0 477077.6 477296.0 59034.4 60759.4 60770.7 66318.7 66955.0 68898.2 68941.0 69027.7 69801.7 70106.0 15629.0 15812.4 15826.5 15837.0 15846.1 12050.2 12115.0 12125.8 12153.0 12169.0 19834.9 20271.0 20302.5 20309.8 20365.5 7799.2 8928.2 9116.4 9151.5 9152.9 954.3 964.0 971.3 973.8 1010.6 29782.6 29798.0 30111.9 30182.5 31316.0 1067.2 1080.1 1096.9 1186.2 1207.0 12918.7 13002.5 14629.9 14949.6 15049.1 440125.0 445423.0 445652.0 447200.0 447679.0 57369.4 57494.4 57540.7 57650.1 57731.0 1315.6 1359.7 1363.8 1485.7 1625.0 33252.5 33529.7 33597.0 33793.3 34313.8 57157.1 57801.0 57810.1 58001.0 58085.4 343200.3 351286.0 365911.0 373751.0 390117.0 28427.6 28878.9 34096.0 34218.1 34506.8 44189.6 45464.8 45482.5 45523.3 46914.0 35904.8 38855.8 39586.2 39917.8 40046.8 37801.8 38354.4 38844.2 38844.2 39163.4 37443.6 38657.2 38846.6 38887.2 39061.8 32032.0 34375.5 34442.0 34807.0 34892.7 26034.9 27292.6 27315.6 27371.9 27453.8 19:56:30 INFO - 2015-11-23 19:56:30,241 DEBUG : BROWSER_OUTPUT: 19:56:30 INFO - 2015-11-23 19:56:30,241 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39347.28 Median:2148.90 stddev:123328.04 (5739.1%) stddev-sans-first:123639.25 19:56:30 INFO - 2015-11-23 19:56:30,243 DEBUG : BROWSER_OUTPUT: Values: 355.2 356.0 360.2 360.4 362.4 15586.7 15675.2 19680.7 19730.1 20292.5 19541.4 19594.9 19954.0 20047.7 20069.4 6551.3 6725.4 6730.0 6739.8 6744.2 4764.3 4902.0 4919.6 6627.2 7473.7 7377.9 7476.6 7643.6 7646.7 7662.9 7504.4 7514.9 7516.6 7530.8 7533.9 6980.7 7200.2 7202.3 7206.4 7224.6 21114.3 21116.0 22182.0 26779.9 26935.8 1981.1 2084.9 2148.3 2149.5 2152.2 15344.0 15523.0 15533.8 15609.0 15726.7 1792.5 1813.9 1835.8 1846.8 1863.4 70944.0 84665.7 96611.5 99328.5 100281.0 18424.0 18494.6 18681.9 18694.3 18705.5 27248.0 27248.3 27273.7 27292.3 27357.5 10139.5 10147.6 10195.3 10243.5 10261.4 8083.0 8092.0 8169.1 8178.8 8292.5 6786.0 7173.7 8544.3 8615.2 8754.7 1718.8 1779.3 1788.9 1822.6 1830.8 782.7 894.8 980.3 985.8 988.5 16593.7 18869.0 19691.3 19804.7 19864.8 847.1 927.8 940.8 952.5 959.1 10599.5 10622.6 10682.3 10754.6 10938.6 732872.0 744042.0 760360.0 762070.0 763246.0 108329.0 109262.0 110522.4 113018.9 117911.8 1198.0 1202.3 1208.1 1236.1 1261.4 17792.0 17913.9 17935.7 17994.8 17997.0 50622.2 50780.2 51078.2 51153.0 51331.5 69729.0 70618.0 70840.2 70947.6 72166.3 9370.3 9391.3 9555.0 9641.7 9692.2 13334.8 19001.1 19213.4 19394.2 19514.2 14193.8 15226.0 15304.5 15623.8 15716.8 15417.8 15589.8 15624.8 15839.3 15928.9 14998.3 15711.1 16062.6 16445.5 16556.8 9590.4 9802.5 9840.9 9924.4 9976.3 11660.2 15312.5 15620.5 15654.8 15692.1 19:56:30 INFO - 2015-11-23 19:56:30,243 DEBUG : BROWSER_OUTPUT: 19:56:30 INFO - 2015-11-23 19:56:30,243 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5772.91 Median:6236.76 stddev:2960.37 (47.5%) stddev-sans-first:2950.05 19:56:30 INFO - 2015-11-23 19:56:30,244 DEBUG : BROWSER_OUTPUT: Values: 1356.5 1614.3 1934.0 1938.6 1999.0 6465.7 7976.7 8014.4 8224.2 8580.9 8303.2 8432.2 8432.2 8442.0 8454.1 2136.7 2371.1 2391.3 2393.3 2393.9 2085.1 2212.2 2219.3 2434.2 2435.7 2199.3 2206.8 2366.7 2386.6 2395.0 2138.8 2201.8 2362.5 2392.9 2400.5 2203.4 2349.2 2413.6 2418.9 2425.3 7118.8 8317.9 8328.9 8330.7 8353.3 5093.2 5176.0 5181.1 5197.0 5203.3 3485.9 3501.6 3562.3 3577.9 3587.1 1043.9 1076.3 1078.1 1084.1 1644.8 11053.1 11162.6 11169.9 11173.2 11182.3 4646.3 4736.8 4774.0 4789.0 4796.6 9748.2 9754.7 9772.5 9785.0 9787.8 5212.3 5212.7 5217.5 5247.8 5248.1 4720.7 4726.4 4761.2 4771.1 4775.0 3712.5 3758.5 3767.2 3791.2 3825.2 1188.2 1189.4 1193.9 1197.7 1199.6 1065.2 1103.5 1105.6 1268.9 1389.6 7646.6 7777.1 7839.8 7867.8 7892.5 1208.6 1210.9 1217.1 1224.2 1240.7 5854.9 5984.6 5999.7 6092.8 6165.9 9428.9 9436.7 9645.7 9679.2 9735.4 9490.4 9626.3 9649.4 9652.9 9656.9 5784.8 7570.2 7670.4 7759.9 7761.4 7845.3 7852.1 7856.6 7857.5 7862.6 8831.8 8939.2 8974.0 8981.1 9080.9 9089.3 9199.9 9352.7 9443.7 9454.9 6832.1 6954.7 6956.0 6964.6 6978.7 7920.9 7991.5 7996.6 7997.6 8001.0 7262.3 7376.2 7431.7 7542.0 7628.2 7201.0 7284.8 7405.7 7430.7 7448.6 7421.0 7456.1 7477.7 7478.6 7478.7 6748.6 6775.1 6776.8 6822.2 6834.9 6307.6 6863.8 6876.7 6888.8 6894.7 19:56:30 INFO - 2015-11-23 19:56:30,244 DEBUG : BROWSER_OUTPUT: 19:56:30 INFO - 2015-11-23 19:56:30,244 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5966.62 Median:6784.09 stddev:1948.48 (28.7%) stddev-sans-first:1906.54 19:56:30 INFO - 2015-11-23 19:56:30,246 DEBUG : BROWSER_OUTPUT: Values: 275.0 289.3 327.0 327.6 334.7 6782.4 6843.5 6935.0 6942.8 6947.7 5132.4 6621.6 6788.5 6791.6 6925.7 4785.9 4856.9 4994.1 5010.2 5010.5 4394.8 4398.3 4643.7 5010.8 5011.4 4694.5 4708.4 4956.0 4960.5 4987.7 4723.1 4905.4 4917.6 4980.3 4998.4 4260.2 4262.1 4268.0 4284.8 4288.2 6148.9 6575.9 6578.9 6587.1 6597.6 5274.8 5732.9 5932.8 5987.1 6000.0 7364.8 7372.7 7373.9 7380.0 7386.5 4723.1 4726.4 4726.5 4730.9 4752.4 7514.1 7704.3 7804.5 7826.5 7828.4 4748.1 4753.3 4753.8 4758.2 4764.4 4809.0 4828.6 4836.2 4837.3 4839.5 5854.0 5876.6 5880.9 5890.1 5894.8 6046.6 7134.2 7392.0 7411.4 7435.6 1659.9 1681.2 1681.2 1684.6 1686.8 997.2 1021.6 1050.7 1057.0 1077.3 6668.5 6785.8 6888.0 6907.4 6912.1 6766.1 7641.2 7794.4 7801.5 7801.8 6620.7 6691.0 6933.5 6952.3 6958.2 4026.3 4078.4 4079.3 4087.2 4088.8 8032.7 8053.8 8060.4 8078.0 8090.8 7741.0 8035.9 8056.4 8082.2 8087.5 8030.2 8049.9 8057.4 8079.1 8082.1 7561.6 7766.8 7785.3 7794.6 7820.8 7594.5 7611.5 7614.0 7620.5 7629.3 5792.1 6872.5 7967.0 8048.6 8050.8 4818.6 4923.9 4954.2 4981.1 4996.1 6900.9 7655.5 7658.7 7673.1 7675.9 6204.3 7133.3 7328.9 7343.7 7350.3 5843.1 7347.4 7348.3 7356.9 7360.4 5787.6 6910.7 7104.1 7113.2 7177.4 7235.2 7271.4 7284.2 7325.5 7363.5 7258.1 7269.5 7280.2 7285.7 7290.8 19:56:30 INFO - 2015-11-23 19:56:30,246 DEBUG : BROWSER_OUTPUT: 19:56:30 INFO - 2015-11-23 19:56:30,246 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18835.49 Median:4183.44 stddev:26824.20 (641.2%) stddev-sans-first:26864.96 19:56:30 INFO - 2015-11-23 19:56:30,247 DEBUG : BROWSER_OUTPUT: Values: 720.8 759.7 799.2 817.5 838.9 14944.0 15280.2 15299.5 15304.9 15311.2 14217.5 14442.7 14460.7 14461.0 14466.9 753.7 765.3 765.5 766.2 936.3 743.4 756.6 944.8 964.8 974.1 999.7 1001.9 1014.4 1016.8 1016.8 792.7 998.1 1007.6 1007.9 1009.4 593.6 593.7 738.6 751.8 753.3 15076.7 15153.2 15212.6 15215.4 15220.9 10946.8 12613.2 12686.3 12796.1 13162.0 10147.4 10245.6 10257.1 10351.2 10757.5 3480.8 3529.9 3531.2 3531.6 3544.0 70272.6 70943.0 71609.6 72174.9 82794.6 9469.9 9526.4 9536.7 9548.5 9570.6 21189.0 21239.0 21280.0 21292.8 21295.7 7268.6 7334.1 7492.1 7516.8 7632.0 3968.2 4053.1 4100.0 4106.9 4185.3 3607.3 3638.3 3643.8 3647.0 3652.7 654.7 663.5 665.3 672.3 673.8 496.1 508.9 515.3 519.0 542.8 7878.5 8214.2 8432.0 8549.3 8629.7 517.5 529.4 584.1 601.8 620.5 3853.7 4104.8 4132.6 4181.6 4224.1 97563.0 99750.0 100379.5 100569.5 100633.5 82608.0 84442.2 85079.1 85195.6 87985.0 73155.2 73570.6 73968.0 73971.3 74628.0 8059.8 8230.2 8280.2 8299.4 8334.2 40793.0 50978.7 51375.7 51928.5 52763.2 71410.6 71556.0 71658.0 73132.5 77892.6 10873.8 11073.8 11420.6 11443.6 11675.2 11975.9 12122.8 12128.4 12156.6 12479.8 11622.8 11681.5 11704.9 11734.5 11766.1 11625.7 11628.8 11646.4 11689.9 11712.2 11464.2 11479.7 11495.1 11498.0 11501.2 9810.9 10247.1 10275.5 10325.7 10346.5 9564.0 9817.8 10124.5 10137.1 10139.5 19:56:30 INFO - 2015-11-23 19:56:30,247 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:56:30 INFO - 2015-11-23 19:56:30,247 DEBUG : BROWSER_OUTPUT: 19:56:30 INFO - 2015-11-23 19:56:30,699 INFO : Browser exited with error code: 0 19:56:30 INFO - 2015-11-23 19:56:30,724 INFO : Completed test dromaeo_css (00:18:35) 19:56:30 INFO - 2015-11-23 19:56:30,724 INFO : Starting test kraken 19:56:30 INFO - 2015-11-23 19:56:30,724 DEBUG : operating with platform_type : mac_ 19:56:30 INFO - 2015-11-23 19:56:30,724 INFO : Initialising browser for kraken test... 19:56:30 INFO - 2015-11-23 19:56:30,736 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/tmpOMjXjH/profile http://localhost:49271/getInfo.html 19:56:32 INFO - 2015-11-23 19:56:32,747 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:56:32 INFO - 2015-11-23 19:56:32,747 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:56:32 INFO - 2015-11-23 19:56:32,747 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:56:32 INFO - 2015-11-23 19:56:32,747 DEBUG : BROWSER_OUTPUT: __metrics 19:56:32 INFO - 2015-11-23 19:56:32,764 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:56:33 INFO - 2015-11-23 19:56:33,401 INFO : Browser initialized. 19:56:33 INFO - 2015-11-23 19:56:33,402 INFO : Running cycle 1/1 for kraken test... 19:56:33 INFO - 2015-11-23 19:56:33,402 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/tmpOMjXjH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:56:45 INFO - 2015-11-23 19:56:45,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 226140160 19:56:45 INFO - 2015-11-23 19:56:45,248 DEBUG : BROWSER_OUTPUT: 19:56:47 INFO - 2015-11-23 19:56:47,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 19:56:48 INFO - 2015-11-23 19:56:48,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 276549632 19:56:48 INFO - 2015-11-23 19:56:48,352 DEBUG : BROWSER_OUTPUT: 19:56:50 INFO - 2015-11-23 19:56:50,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 19:56:51 INFO - 2015-11-23 19:56:51,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 291061760 19:56:51 INFO - 2015-11-23 19:56:51,482 DEBUG : BROWSER_OUTPUT: 19:56:54 INFO - 2015-11-23 19:56:54,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 19:56:55 INFO - 2015-11-23 19:56:55,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 277532672 19:56:55 INFO - 2015-11-23 19:56:55,335 DEBUG : BROWSER_OUTPUT: 19:56:57 INFO - 2015-11-23 19:56:57,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 19:56:57 INFO - 2015-11-23 19:56:57,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 278417408 19:56:57 INFO - 2015-11-23 19:56:57,774 DEBUG : BROWSER_OUTPUT: 19:56:59 INFO - 2015-11-23 19:56:59,794 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:57:00 INFO - 2015-11-23 19:57:00,368 DEBUG : BROWSER_OUTPUT: RSS: Main: 281559040 19:57:00 INFO - 2015-11-23 19:57:00,368 DEBUG : BROWSER_OUTPUT: 19:57:03 INFO - 2015-11-23 19:57:03,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 19:57:03 INFO - 2015-11-23 19:57:03,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 280854528 19:57:03 INFO - 2015-11-23 19:57:03,665 DEBUG : BROWSER_OUTPUT: 19:57:06 INFO - 2015-11-23 19:57:06,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 19:57:07 INFO - 2015-11-23 19:57:07,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 280899584 19:57:07 INFO - 2015-11-23 19:57:07,068 DEBUG : BROWSER_OUTPUT: 19:57:09 INFO - 2015-11-23 19:57:09,727 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 19:57:10 INFO - 2015-11-23 19:57:10,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 282591232 19:57:10 INFO - 2015-11-23 19:57:10,322 DEBUG : BROWSER_OUTPUT: 19:57:11 INFO - 2015-11-23 19:57:11,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:57:12 INFO - 2015-11-23 19:57:12,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 316928000 19:57:12 INFO - 2015-11-23 19:57:12,400 DEBUG : BROWSER_OUTPUT: 19:57:14 INFO - 2015-11-23 19:57:14,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:57:14 INFO - 2015-11-23 19:57:14,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 318607360 19:57:14 INFO - 2015-11-23 19:57:14,786 DEBUG : BROWSER_OUTPUT: 19:57:16 INFO - 2015-11-23 19:57:16,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:57:17 INFO - 2015-11-23 19:57:17,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 325599232 19:57:17 INFO - 2015-11-23 19:57:17,400 DEBUG : BROWSER_OUTPUT: 19:57:19 INFO - 2015-11-23 19:57:19,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:57:20 INFO - 2015-11-23 19:57:20,507 DEBUG : BROWSER_OUTPUT: RSS: Main: 326840320 19:57:20 INFO - 2015-11-23 19:57:20,507 DEBUG : BROWSER_OUTPUT: 19:57:22 INFO - 2015-11-23 19:57:22,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:57:23 INFO - 2015-11-23 19:57:23,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 325541888 19:57:23 INFO - 2015-11-23 19:57:23,530 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 19:57:25 INFO - 2015-11-23 19:57:25,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 384741376 19:57:25 INFO - 2015-11-23 19:57:25,478 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,478 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:57:25 INFO - 2015-11-23 19:57:25,478 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:57:25 INFO - 2015-11-23 19:57:25,478 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:57:25 INFO - 2015-11-23 19:57:25,479 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:57:25 INFO - 2015-11-23 19:57:25,479 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;104;110;111;111;98;110;110;103 19:57:25 INFO - 2015-11-23 19:57:25,479 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;118;143;155;114;141;142;115;157;116 19:57:25 INFO - 2015-11-23 19:57:25,479 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;182;213;229;186;184;183;183;183;182 19:57:25 INFO - 2015-11-23 19:57:25,479 DEBUG : BROWSER_OUTPUT: |3;audio-fft;61;70;76;72;56;57;55;72;72;56 19:57:25 INFO - 2015-11-23 19:57:25,479 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;84;83;117;75;75;75;113;77;74;109 19:57:25 INFO - 2015-11-23 19:57:25,479 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;89;90;88;90;89;89;89;90;89;90 19:57:25 INFO - 2015-11-23 19:57:25,479 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;130;96;96;96;96;96;94;96;95;96 19:57:25 INFO - 2015-11-23 19:57:25,479 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;84;86;85;85;85;86;84;84;85;85 19:57:25 INFO - 2015-11-23 19:57:25,479 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;54;53;54;53;53;55;64;52;52 19:57:25 INFO - 2015-11-23 19:57:25,480 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;63;63;63;64;67;66;67;68;68 19:57:25 INFO - 2015-11-23 19:57:25,480 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;84;81;82;81;81;81;83;82;84 19:57:25 INFO - 2015-11-23 19:57:25,480 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;130;132;121;130;119;120;128;121;120 19:57:25 INFO - 2015-11-23 19:57:25,480 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;136;136;133;135;124;134;135;134;129 19:57:25 INFO - 2015-11-23 19:57:25,480 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;57;86;99;63;65;63;65;64;63;64 19:57:25 INFO - 2015-11-23 19:57:25,480 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:57:25 INFO - 2015-11-23 19:57:25,480 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:57:25 INFO - 2015-11-23 19:57:25,480 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1061 19:57:25 INFO - 2015-11-23 19:57:25,482 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:57:25 INFO - 2015-11-23 19:57:25,482 DEBUG : BROWSER_OUTPUT: __startTimestamp1448337445477__endTimestamp 19:57:25 INFO - 2015-11-23 19:57:25,482 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,482 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:57:25 INFO - 2015-11-23 19:57:25,482 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:57:25 INFO - 2015-11-23 19:57:25,483 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,483 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.60 Median:110.50 stddev:4.45 (4.0%) stddev-sans-first:4.72 19:57:25 INFO - 2015-11-23 19:57:25,483 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 104.0 110.0 111.0 111.0 98.0 110.0 110.0 103.0 19:57:25 INFO - 2015-11-23 19:57:25,483 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,483 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:135.00 Median:142.50 stddev:17.38 (12.2%) stddev-sans-first:17.69 19:57:25 INFO - 2015-11-23 19:57:25,483 DEBUG : BROWSER_OUTPUT: Values: 149.0 118.0 143.0 155.0 114.0 141.0 142.0 115.0 157.0 116.0 19:57:25 INFO - 2015-11-23 19:57:25,483 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,483 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:190.80 Median:183.50 stddev:16.40 (8.9%) stddev-sans-first:17.15 19:57:25 INFO - 2015-11-23 19:57:25,483 DEBUG : BROWSER_OUTPUT: Values: 183.0 182.0 213.0 229.0 186.0 184.0 183.0 183.0 183.0 182.0 19:57:25 INFO - 2015-11-23 19:57:25,483 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,483 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:64.70 Median:71.00 stddev:8.39 (11.8%) stddev-sans-first:8.80 19:57:25 INFO - 2015-11-23 19:57:25,484 DEBUG : BROWSER_OUTPUT: Values: 61.0 70.0 76.0 72.0 56.0 57.0 55.0 72.0 72.0 56.0 19:57:25 INFO - 2015-11-23 19:57:25,484 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,484 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.20 Median:75.00 stddev:17.55 (23.4%) stddev-sans-first:18.55 19:57:25 INFO - 2015-11-23 19:57:25,484 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 117.0 75.0 75.0 75.0 113.0 77.0 74.0 109.0 19:57:25 INFO - 2015-11-23 19:57:25,484 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,485 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:89.30 Median:89.50 stddev:0.67 (0.8%) stddev-sans-first:0.71 19:57:25 INFO - 2015-11-23 19:57:25,485 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 88.0 90.0 89.0 89.0 89.0 90.0 89.0 90.0 19:57:25 INFO - 2015-11-23 19:57:25,486 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,486 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:99.10 Median:96.00 stddev:10.88 (11.3%) stddev-sans-first:0.71 19:57:25 INFO - 2015-11-23 19:57:25,486 DEBUG : BROWSER_OUTPUT: Values: 130.0 96.0 96.0 96.0 96.0 96.0 94.0 96.0 95.0 96.0 19:57:25 INFO - 2015-11-23 19:57:25,486 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,486 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.74 (0.9%) stddev-sans-first:0.71 19:57:25 INFO - 2015-11-23 19:57:25,486 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 85.0 85.0 85.0 86.0 84.0 84.0 85.0 85.0 19:57:25 INFO - 2015-11-23 19:57:25,486 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,486 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.00 stddev:3.53 (6.5%) stddev-sans-first:3.71 19:57:25 INFO - 2015-11-23 19:57:25,486 DEBUG : BROWSER_OUTPUT: Values: 56.0 54.0 53.0 54.0 53.0 53.0 55.0 64.0 52.0 52.0 19:57:25 INFO - 2015-11-23 19:57:25,486 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,486 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:66.50 stddev:2.33 (3.5%) stddev-sans-first:2.19 19:57:25 INFO - 2015-11-23 19:57:25,486 DEBUG : BROWSER_OUTPUT: Values: 62.0 63.0 63.0 63.0 64.0 67.0 66.0 67.0 68.0 68.0 19:57:25 INFO - 2015-11-23 19:57:25,486 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,487 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:1.25 (1.5%) stddev-sans-first:1.27 19:57:25 INFO - 2015-11-23 19:57:25,487 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 81.0 82.0 81.0 81.0 81.0 83.0 82.0 84.0 19:57:25 INFO - 2015-11-23 19:57:25,487 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,487 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:125.00 stddev:5.06 (4.0%) stddev-sans-first:5.29 19:57:25 INFO - 2015-11-23 19:57:25,487 DEBUG : BROWSER_OUTPUT: Values: 122.0 130.0 132.0 121.0 130.0 119.0 120.0 128.0 121.0 120.0 19:57:25 INFO - 2015-11-23 19:57:25,487 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,487 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.00 Median:134.50 stddev:3.74 (2.8%) stddev-sans-first:3.95 19:57:25 INFO - 2015-11-23 19:57:25,487 DEBUG : BROWSER_OUTPUT: Values: 134.0 136.0 136.0 133.0 135.0 124.0 134.0 135.0 134.0 129.0 19:57:25 INFO - 2015-11-23 19:57:25,487 DEBUG : BROWSER_OUTPUT: 19:57:25 INFO - 2015-11-23 19:57:25,487 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:64.50 stddev:13.01 (20.2%) stddev-sans-first:13.07 19:57:25 INFO - 2015-11-23 19:57:25,487 DEBUG : BROWSER_OUTPUT: Values: 57.0 86.0 99.0 63.0 65.0 63.0 65.0 64.0 63.0 64.0 19:57:25 INFO - 2015-11-23 19:57:25,487 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:57:25 INFO - 2015-11-23 19:57:25,487 DEBUG : BROWSER_OUTPUT: 19:57:26 INFO - 2015-11-23 19:57:26,076 INFO : Browser exited with error code: 0 19:57:26 INFO - 2015-11-23 19:57:26,121 INFO : Completed test kraken (00:00:55) 19:57:26 INFO - 2015-11-23 19:57:26,121 INFO : Starting test v8_7 19:57:26 INFO - 2015-11-23 19:57:26,121 DEBUG : operating with platform_type : mac_ 19:57:26 INFO - 2015-11-23 19:57:26,122 INFO : Initialising browser for v8_7 test... 19:57:26 INFO - 2015-11-23 19:57:26,134 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/tmptF4rbL/profile http://localhost:49271/getInfo.html 19:57:28 INFO - 2015-11-23 19:57:28,289 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:57:28 INFO - 2015-11-23 19:57:28,289 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:57:28 INFO - 2015-11-23 19:57:28,289 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:57:28 INFO - 2015-11-23 19:57:28,290 DEBUG : BROWSER_OUTPUT: __metrics 19:57:28 INFO - 2015-11-23 19:57:28,306 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:57:28 INFO - 2015-11-23 19:57:28,959 INFO : Browser initialized. 19:57:28 INFO - 2015-11-23 19:57:28,960 INFO : Running cycle 1/1 for v8_7 test... 19:57:28 INFO - 2015-11-23 19:57:28,960 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/T/tmptF4rbL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:57:40 INFO - 2015-11-23 19:57:40,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 225435648 19:57:40 INFO - 2015-11-23 19:57:40,740 DEBUG : BROWSER_OUTPUT: 19:58:02 INFO - 2015-11-23 19:58:02,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/v8_7/run.html (next: http://localhost:49271/tests/v8_7/run.html) 19:58:02 INFO - 2015-11-23 19:58:02,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 631107584 19:58:02 INFO - 2015-11-23 19:58:02,377 DEBUG : BROWSER_OUTPUT: 19:58:02 INFO - 2015-11-23 19:58:02,377 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:58:02 INFO - 2015-11-23 19:58:02,377 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:58:02 INFO - 2015-11-23 19:58:02,378 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:58:02 INFO - 2015-11-23 19:58:02,378 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:58:02 INFO - 2015-11-23 19:58:02,378 DEBUG : BROWSER_OUTPUT: |0;Richards;175.0393838613688 19:58:02 INFO - 2015-11-23 19:58:02,378 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;160.2820964898221 19:58:02 INFO - 2015-11-23 19:58:02,378 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.2466836014677 19:58:02 INFO - 2015-11-23 19:58:02,378 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4739.336492890995 19:58:02 INFO - 2015-11-23 19:58:02,378 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1740.8695652173913 19:58:02 INFO - 2015-11-23 19:58:02,378 DEBUG : BROWSER_OUTPUT: |5;Earley;827.129859387924 19:58:02 INFO - 2015-11-23 19:58:02,378 DEBUG : BROWSER_OUTPUT: |6;Boyer;12084.33734939759 19:58:02 INFO - 2015-11-23 19:58:02,378 DEBUG : BROWSER_OUTPUT: |7;RegExp;28055.555555555555 19:58:02 INFO - 2015-11-23 19:58:02,378 DEBUG : BROWSER_OUTPUT: |8;Splay;749.0636704119851 19:58:02 INFO - 2015-11-23 19:58:02,378 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4605.504587155963 19:58:02 INFO - 2015-11-23 19:58:02,378 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:58:02 INFO - 2015-11-23 19:58:02,378 DEBUG : BROWSER_OUTPUT: __startTimestamp1448337482373__endTimestamp 19:58:02 INFO - 2015-11-23 19:58:02,379 DEBUG : BROWSER_OUTPUT: 19:58:02 INFO - 2015-11-23 19:58:02,379 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:58:02 INFO - 2015-11-23 19:58:02,379 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:58:02 INFO - 2015-11-23 19:58:02,379 DEBUG : BROWSER_OUTPUT: 19:58:02 INFO - 2015-11-23 19:58:02,379 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:175.04 Median:175.04 stddev:0.00 (0.0%) 19:58:02 INFO - 2015-11-23 19:58:02,379 DEBUG : BROWSER_OUTPUT: Values: 175.0 19:58:02 INFO - 2015-11-23 19:58:02,379 DEBUG : BROWSER_OUTPUT: 19:58:02 INFO - 2015-11-23 19:58:02,379 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:160.28 Median:160.28 stddev:0.00 (0.0%) 19:58:02 INFO - 2015-11-23 19:58:02,379 DEBUG : BROWSER_OUTPUT: Values: 160.3 19:58:02 INFO - 2015-11-23 19:58:02,379 DEBUG : BROWSER_OUTPUT: 19:58:02 INFO - 2015-11-23 19:58:02,379 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.25 Median:282.25 stddev:0.00 (0.0%) 19:58:02 INFO - 2015-11-23 19:58:02,379 DEBUG : BROWSER_OUTPUT: Values: 282.2 19:58:02 INFO - 2015-11-23 19:58:02,379 DEBUG : BROWSER_OUTPUT: 19:58:02 INFO - 2015-11-23 19:58:02,380 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4739.34 Median:4739.34 stddev:0.00 (0.0%) 19:58:02 INFO - 2015-11-23 19:58:02,380 DEBUG : BROWSER_OUTPUT: Values: 4739.3 19:58:02 INFO - 2015-11-23 19:58:02,380 DEBUG : BROWSER_OUTPUT: 19:58:02 INFO - 2015-11-23 19:58:02,380 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1740.87 Median:1740.87 stddev:0.00 (0.0%) 19:58:02 INFO - 2015-11-23 19:58:02,380 DEBUG : BROWSER_OUTPUT: Values: 1740.9 19:58:02 INFO - 2015-11-23 19:58:02,380 DEBUG : BROWSER_OUTPUT: 19:58:02 INFO - 2015-11-23 19:58:02,380 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:827.13 Median:827.13 stddev:0.00 (0.0%) 19:58:02 INFO - 2015-11-23 19:58:02,380 DEBUG : BROWSER_OUTPUT: Values: 827.1 19:58:02 INFO - 2015-11-23 19:58:02,380 DEBUG : BROWSER_OUTPUT: 19:58:02 INFO - 2015-11-23 19:58:02,380 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12084.34 Median:12084.34 stddev:0.00 (0.0%) 19:58:02 INFO - 2015-11-23 19:58:02,380 DEBUG : BROWSER_OUTPUT: Values: 12084.3 19:58:02 INFO - 2015-11-23 19:58:02,380 DEBUG : BROWSER_OUTPUT: 19:58:02 INFO - 2015-11-23 19:58:02,380 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28055.56 Median:28055.56 stddev:0.00 (0.0%) 19:58:02 INFO - 2015-11-23 19:58:02,381 DEBUG : BROWSER_OUTPUT: Values: 28055.6 19:58:02 INFO - 2015-11-23 19:58:02,381 DEBUG : BROWSER_OUTPUT: 19:58:02 INFO - 2015-11-23 19:58:02,381 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:749.06 Median:749.06 stddev:0.00 (0.0%) 19:58:02 INFO - 2015-11-23 19:58:02,381 DEBUG : BROWSER_OUTPUT: Values: 749.1 19:58:02 INFO - 2015-11-23 19:58:02,381 DEBUG : BROWSER_OUTPUT: 19:58:02 INFO - 2015-11-23 19:58:02,381 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4605.50 Median:4605.50 stddev:0.00 (0.0%) 19:58:02 INFO - 2015-11-23 19:58:02,381 DEBUG : BROWSER_OUTPUT: Values: 4605.5 19:58:02 INFO - 2015-11-23 19:58:02,381 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:58:02 INFO - 2015-11-23 19:58:02,381 DEBUG : BROWSER_OUTPUT: 19:58:02 INFO - 2015-11-23 19:58:02,996 INFO : Browser exited with error code: 0 19:58:03 INFO - 2015-11-23 19:58:03,014 INFO : Completed test v8_7 (00:00:36) 19:58:03 INFO - 2015-11-23 19:58:03,474 INFO : Completed test suite (00:20:07) 19:58:03 INFO - 2015-11-23 19:58:03,474 DEBUG : Working with test: dromaeo_css 19:58:03 INFO - 2015-11-23 19:58:03,474 DEBUG : Generating results file: dromaeo_css 19:58:03 INFO - 2015-11-23 19:58:03,475 DEBUG : Working with test: kraken 19:58:03 INFO - 2015-11-23 19:58:03,475 DEBUG : Generating results file: kraken 19:58:03 INFO - 2015-11-23 19:58:03,475 INFO : javascript benchmark 19:58:03 INFO - 2015-11-23 19:58:03,475 DEBUG : Working with test: v8_7 19:58:03 INFO - 2015-11-23 19:58:03,475 DEBUG : Generating results file: v8_7 19:58:03 INFO - 2015-11-23 19:58:03,476 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:58:03 INFO - 2015-11-23 19:58:03,856 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 19:58:03 INFO - 2015-11-23 19:58:03,856 DEBUG : process_Request line: dromaeo_css 7765.31 graph.html#tests=[[72,64,59]] 19:58:03 INFO - 2015-11-23 19:58:03,856 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:58:03 INFO - 2015-11-23 19:58:03,972 DEBUG : process_Request line: kraken 1387.50 graph.html#tests=[[232,64,59]] 19:58:03 INFO - 2015-11-23 19:58:03,972 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:58:04 INFO - 2015-11-23 19:58:04,097 DEBUG : process_Request line: v8_7 19925.07 graph.html#tests=[[230,64,59]] 19:58:04 INFO - 2015-11-23 19:58:04,098 INFO : javascript benchmark 19:58:04 INFO - 2015-11-23 19:58:04,100 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3414.061133188374, 3499.650034996499, 3539.2213712983153, 3552.6447355264477, 3556.6087730349664, 5677.943220567793, 5745.224394706714, 5804.680742559158, 5840.678762668052, 5889.85275368116, 5699.287589051369, 5846.415358464152, 5854.20968169297, 5855.560832937525, 5859.384764599719, 4373.453318335208, 5214.7653355598895, 5262.894742105155, 5275.340582427197, 5327.573794096463, 5326.174442961347, 5328.360596728378, 5331.6534425262425, 5331.866703332409, 5340.839774806743, 5320.388155362144, 5325.147976323789, 5331.493508116722, 5332.040232758102, 5333.066713325172, 5308.124159513656, 5324.041672498949, 5326.334208223972, 5335.1197052486295, 5335.759890804884, 5158.664686795346, 5235.55497782689, 5292.232626269208, 5312.256284120226, 5335.0663633863915, 5748.913766293509, 5866.70666466675, 5950.642961422329, 5981.192539007222, 5993.61041532299, 5279.340082489689, 6300.495960323163, 6305.527085468608, 6306.274778400497, 6312.463440607508, 6165.260168779775, 6210.0, 6287.119803227506, 6308.369163083701, 6312.147860038882, 5981.192539007222, 6050.806008883618, 6060.151578778975, 6074.028155495143, 6087.026075827846, 6328.905066424008, 6393.520485963571, 6413.262474815456, 6430.7106180222, 6430.742770289136, 6090.695465226721, 6119.258838874149, 6157.753689852445, 6158.568900177034, 6261.436470717566, 6319.747210111636, 6368.77709280173, 6369.71336289868, 6375.23497180332, 6377.489800815923, 6256.124142620037, 6312.0531920211415, 6315.463185629181, 6335.0, 6336.20797400325, 6104.041878991925, 6107.226802228232, 6247.187865577446, 6248.0003199487865, 6270.7491700331475, 4967.105920934194, 4988.351514303117, 5065.316182315414, 5066.82266120684, 5069.986002799455, 4541.841035563805, 4546.954530454719, 4555.544445555418, 4569.54304569547, 4577.702449340849, 5659.349174844946, 5731.799387021434, 5757.395473475309, 5760.913586296209, 5891.499222566044, 6167.722452489649, 6270.59241149333, 6294.213223347082, 6301.558890877594, 6307.5269354798575, 5830.7959221427045, 5878.559108066912, 5915.515483496942, 5952.375000624958, 5980.55145864062, 5334.039872822929, 5465.316835395575, 5524.8066317679495, 5535.169724541271, 5539.833804985777, 6299.496040316763, 6359.77740779089, 6360.6501642409185, 6370.936290637034, 6372.6495042773095, 6226.40849119333, 6287.685615719104, 6316.936830631818, 6320.367963203643, 6323.20959880015, 5465.836024919259, 6367.204099487564, 6417.294097649348, 6427.83930401725, 6466.805995820133, 6103.572749907464, 6287.308396076336, 6293.496520278275, 6327.746890124344, 6349.523785716182, 6273.968630157003, 6275.529335299962, 6277.18396608438, 6281.403266689657, 6282.403171698864, 6086.965215913394, 6138.447539721446, 6146.016637338004, 6151.200343955257, 6218.689065546614, 6098.400566736114, 6253.37466253371, 6262.968685156545, 6268.435840774352, 6270.2475702915945, 5400.783968641211, 6123.020316749299, 6134.04922237054, 6134.447899689049, 6160.229971253593, 5185.299984502195, 6070.089486577049, 6095.0, 6114.7248373822395, 6116.944513560587, 6122.540809439399, 6125.673500107169, 6133.785317514044, 6136.478399336106, 6144.38556144382], "unit": "ms", "name": "dojo.html", "value": 5782.055117772991}, {"lowerIsBetter": false, "replicates": [528.105581631797, 583.7402355951598, 611.1566038866365, 630.9557682036228, 645.1999520594461, 31657.366852662934, 32253.51619725706, 32331.51502727458, 32340.514892276635, 32398.838005809997, 33423.0, 33865.32269354611, 33891.99999999994, 34131.82934085326, 42219.577804221946, 8507.78730531737, 9966.750831229241, 9968.102870741632, 9977.90022099777, 9990.400575965428, 9032.729018129467, 9405.294602904776, 9687.128158465737, 9850.113489785917, 9887.752806179868, 8941.418807777474, 9062.682806101788, 9127.543622818832, 9863.852042219372, 9966.90033099667, 8832.8675069874, 8907.242884354806, 10389.324693894949, 12051.819222711667, 12264.81602775959, 11776.470058847372, 11939.044876409866, 11957.402129893471, 11967.581134660331, 11974.700632484171, 32116.03651890447, 41388.37917431241, 41625.791871040754, 41701.582984170076, 41774.74675759732, 2722.2377734234447, 2911.7670586353042, 3066.9079927602206, 3224.3712476067176, 3540.7344449166417, 29117.85441072802, 29432.0, 29508.852455737582, 29818.0, 29982.55026174609, 2782.9304267393477, 2786.3312804926672, 2861.2846788302923, 2888.133559932012, 2948.3955789063407, 473735.0, 474882.0, 475517.0, 477077.6146119282, 477296.0, 59034.40965590375, 60759.39240607537, 60770.69614651898, 66318.6736265272, 66955.0, 68898.24407023763, 68941.0, 69027.65486172537, 69801.65099174471, 70106.0, 15629.0, 15812.446564370191, 15826.525204243891, 15837.0, 15846.12846293465, 12050.216735912138, 12115.030797536176, 12125.818112728317, 12153.027757779357, 12169.0, 19834.90908000045, 20270.986450677407, 20302.492437689176, 20309.79690203079, 20365.49086272855, 7799.220077992155, 8928.241099506486, 9116.39902238612, 9151.470022338852, 9152.947411047682, 954.2938225712923, 963.9759006024765, 971.3293135806401, 973.756560859785, 1010.6361709784471, 29782.55326170109, 29798.0, 30111.94608188703, 30182.547261790653, 31316.0, 1067.1836045425257, 1080.1089101491302, 1096.8903109688968, 1186.1756079524648, 1207.0, 12918.741625167444, 13002.544910928262, 14629.902757293246, 14949.551513454613, 15049.126042255268, 440125.0, 445423.0, 445652.0, 447200.0, 447679.0, 57369.42630573641, 57494.42505574974, 57540.71229643909, 57650.13524797132, 57731.0, 1315.5921664284103, 1359.6940688345044, 1363.8431580368185, 1485.6731519065788, 1624.976264953072, 33252.50121248232, 33529.66470335265, 33597.0, 33793.324133517686, 34313.828430857684, 57157.14264285956, 57801.0, 57810.13284800816, 58001.0, 58085.41914580969, 343200.28399857844, 351286.0, 365911.0, 373751.0, 390117.0, 28427.573586396633, 28878.855605722678, 34095.97712068642, 34218.14454638654, 34506.82746586251, 44189.55810441983, 45464.77267613641, 45482.54517454783, 45523.317150243434, 46914.0, 35904.8204758985, 38855.80572097235, 39586.2082758349, 39917.80041099892, 40046.799766000986, 37801.81765464553, 38354.42468363033, 38844.223115536966, 38844.223115536966, 39163.41254881122, 37443.62556374401, 38657.2268554633, 38846.61153388543, 38887.222255555294, 39061.804690976365, 32032.039038828872, 34375.484367734, 34442.0, 34807.0, 34892.65107348894, 26034.869825650752, 27292.59061114045, 27315.59026614642, 27371.86314068417, 27453.76458059432], "unit": "ms", "name": "ext.html", "value": 19849.338588641665}, {"lowerIsBetter": false, "replicates": [355.1937102776699, 355.97508174427793, 360.18597968591007, 360.398135114359, 362.3821384539361, 15586.688266234669, 15675.216239188052, 19680.704789428153, 19730.112144953477, 20292.492687682814, 19541.41375758726, 19594.902025489853, 19954.0, 20047.699284510745, 20069.397918062445, 6551.344865513458, 6725.361090696376, 6729.966350168267, 6739.764108256212, 6744.190697116328, 4764.309175169598, 4902.044101400211, 4919.597914594341, 6627.204735431731, 7473.663685134155, 7377.852442951138, 7476.6261686915705, 7643.579603121826, 7646.694132234704, 7662.923370766277, 7504.4371672124535, 7514.887276690854, 7516.624168791594, 7530.849383012363, 7533.886991695129, 6980.685869135901, 7200.207977122513, 7202.279772022808, 7206.351428371419, 7224.6026468544205, 21114.261000864895, 21116.0, 22182.00180991843, 26779.866100669566, 26935.787889545016, 1981.128303546435, 2084.9166033358647, 2148.2803260907613, 2149.5163588192686, 2152.1714140056033, 15344.0, 15523.0, 15533.766993495106, 15609.0, 15726.663233625155, 1792.5429015601069, 1813.9233567548738, 1835.8164183581669, 1846.769153855768, 1863.3664554051688, 70944.0, 84665.73001404923, 96611.51694241555, 99328.51007234897, 100281.0, 18424.0, 18494.630107397777, 18681.90659046723, 18694.34569790078, 18705.53236169107, 27248.0, 27248.318792030357, 27273.727262727516, 27292.31769205746, 27357.452850943268, 10139.493025348851, 10147.594096236215, 10195.286329956833, 10243.539040743184, 10261.435621040915, 8083.0, 8092.0, 8169.060558035783, 8178.795530111675, 8292.460990035628, 6785.977859778598, 7173.748918787817, 8544.333854898236, 8615.181557752003, 8754.69358572447, 1718.776559047316, 1779.332750218668, 1788.928442862271, 1822.5808064145322, 1830.7986121526621, 782.7456076775071, 894.7852515396258, 980.3333733061444, 985.8324084905584, 988.5353883674661, 16593.66812663764, 18868.96220707874, 19691.310804121786, 19804.70292945607, 19864.808111513354, 847.1201895319422, 927.7634203278121, 940.7742141885898, 952.5094576293214, 959.1271942532262, 10599.470026498644, 10622.575096996188, 10682.252242342962, 10754.56981720738, 10938.617148399928, 732872.0, 744042.0, 760360.0, 762070.0, 763246.0, 108329.0, 109262.0, 110522.44738776254, 113018.86981130083, 117911.8208817918, 1198.0, 1202.296656455983, 1208.0818577880698, 1236.1223531292883, 1261.4323554400557, 17792.02143882099, 17913.910430447766, 17935.73096403581, 17994.820051799314, 17997.0, 50622.2406663893, 50780.238296424846, 51078.23382649189, 51153.0, 51331.48668513267, 69728.95406569006, 70618.0, 70840.2075771675, 70947.64526177336, 72166.27833721806, 9370.297227707813, 9391.342606017513, 9555.0, 9641.710748677551, 9692.22462203008, 13334.799978000532, 19001.144948477075, 19213.423597291545, 19394.2242310306, 19514.21943122259, 14193.787093193403, 15226.0, 15304.464343748361, 15623.765643515584, 15716.764248536052, 15417.84582154209, 15589.76615350748, 15624.765628515808, 15839.287232074816, 15928.92035539815, 14998.325075371853, 15711.135887526296, 16062.598435039217, 16445.506634800975, 16556.75164872504, 9590.376625519319, 9802.460864652512, 9840.901590983998, 9924.40453572788, 9976.301658883809, 11660.242084264495, 15312.464063757716, 15620.453284135001, 15654.843451565339, 15692.058476491447], "unit": "ms", "name": "jquery.html", "value": 10825.29966437332}, {"lowerIsBetter": false, "replicates": [1356.5387768158823, 1614.3139165854514, 1933.9556639414716, 1938.6316599846027, 1998.9500262493445, 6465.676716164191, 7976.68093276269, 8014.398920080996, 8224.177582241788, 8580.91419085809, 8303.211194936486, 8432.15678432158, 8432.198941100585, 8441.957790211056, 8454.070052294242, 2136.69017992391, 2371.1345358944036, 2391.282615215437, 2393.3179043972473, 2393.85636861788, 2085.14509051289, 2212.203606701586, 2219.3120132758895, 2434.221049264236, 2435.6833611630464, 2199.318211354477, 2206.7572567017696, 2366.680498132756, 2386.5942789725786, 2394.9760502395015, 2138.764735879052, 2201.8348623853117, 2362.4684445999596, 2392.8803559822027, 2400.531896280226, 2203.4050806282376, 2349.1777877742825, 2413.5776239158076, 2418.903243870243, 2425.260295609838, 7118.750843720445, 8317.916820831835, 8328.875066874001, 8330.708425205088, 8353.289970352527, 5093.236014597803, 5176.016556854186, 5181.093308670967, 5196.9740151299, 5203.297554830126, 3485.8779942701885, 3501.562304711911, 3562.340966921128, 3577.8926632200814, 3587.1032241939515, 1043.9217058720626, 1076.34343050739, 1078.0620859851902, 1084.073117484555, 1644.8026236851535, 11053.115750739922, 11162.609308674238, 11169.944150279196, 11173.162012849069, 11182.32906025641, 4646.279826626878, 4736.834210802605, 4773.95226047742, 4789.042191561632, 4796.616270698336, 9748.220142388593, 9754.707358779247, 9772.462514561767, 9785.0, 9787.755306117404, 5212.3223980883, 5212.661177023481, 5217.530422261939, 5247.790088396421, 5248.055350036953, 4720.669553131248, 4726.432828060586, 4761.166795810719, 4771.093492236464, 4774.973380723091, 3712.480252764615, 3758.511393518825, 3767.1900541383734, 3791.2227993261317, 3825.1775868187915, 1188.2157775867886, 1189.3636904256182, 1193.91045671575, 1197.6826141072622, 1199.6281152842473, 1065.1851333729703, 1103.475848971732, 1105.5743538737645, 1268.9365531723377, 1389.6317475868902, 7646.617669116633, 7777.144514103444, 7839.804004899923, 7867.842643147105, 7892.4869883457395, 1208.6011616166643, 1210.878912108782, 1217.0628615965657, 1224.2103843021202, 1240.683625675447, 5854.941450585525, 5984.581079324405, 5999.700014999233, 6092.817215483454, 6165.907511387333, 9428.858567121499, 9436.716898493056, 9645.662401815904, 9679.177269931994, 9735.367201132045, 9490.383125096985, 9626.326157169071, 9649.372790768577, 9652.90347096534, 9656.855147172799, 5784.82645520635, 7570.205128461543, 7670.42471814605, 7759.883601745978, 7761.379089672812, 7845.333146682596, 7852.057753069668, 7856.607169641609, 7857.528548286892, 7862.567558784322, 8831.779205519913, 8939.150780675825, 8974.0, 8981.101889810967, 9080.909190908007, 9089.272858171462, 9199.908000919904, 9352.719418417459, 9443.716688499357, 9454.905450945678, 6832.111825462658, 6954.687039083152, 6955.965220173866, 6964.616946068015, 6978.685959131953, 7920.920790792018, 7991.520508769492, 7996.56018918965, 7997.640106195351, 8000.959995199987, 7262.34638882482, 7376.18861925177, 7431.702731890664, 7542.0, 7628.160902300631, 7200.963995179991, 7284.817879553054, 7405.740799072007, 7430.665620047219, 7448.553086814808, 7421.0, 7456.067991501062, 7477.738279160203, 7478.551286922802, 7478.738244161428, 6748.628825414649, 6775.119234499483, 6776.7628133015105, 6822.215445223665, 6834.8633027340165, 6307.621542707268, 6863.794086177422, 6876.69054892521, 6888.793336199922, 6894.689738961659], "unit": "ms", "name": "mootools.html", "value": 4760.24966580264}, {"lowerIsBetter": false, "replicates": [274.969753327134, 289.26815157651134, 326.960764708235, 327.5741536003195, 334.6853957280158, 6782.423494003009, 6843.452523798097, 6934.994425808261, 6942.826429339269, 6947.687354069067, 5132.384113906336, 6621.6027038377615, 6788.490863185256, 6791.626460544668, 6925.653717314127, 4785.875319299962, 4856.854294371165, 4994.1260279451135, 5010.173321401964, 5010.498950104997, 4394.802233899466, 4398.318260669601, 4643.744594047343, 5010.849674509771, 5011.373578302712, 4694.507076756942, 4708.411448568929, 4955.950440495585, 4960.479149689285, 4987.675801072936, 4723.126221648989, 4905.386826646652, 4917.631177661689, 4980.327655766461, 4998.40019197695, 4260.169266992907, 4262.126264115849, 4267.957320426818, 4284.764337961411, 4288.16380805743, 6148.862460444832, 6575.868482630369, 6578.901316480256, 6587.110740050128, 6597.60414375139, 5274.841754747364, 5732.8853422931725, 5932.822015339547, 5987.1019347097845, 6000.0, 7364.77905662831, 7372.741954031583, 7373.926260737431, 7379.963100184518, 7386.519876208029, 4723.126221649006, 4726.432828060655, 4726.503717109688, 4730.905381892378, 4752.42970843501, 7514.0607424071995, 7704.26809453101, 7804.492707973906, 7826.452148349618, 7828.373730101578, 4748.145333839942, 4753.310769938409, 4753.83361582343, 4758.214894542361, 4764.380630518011, 4808.990112076433, 4828.565429111397, 4836.226203807444, 4837.274408838703, 4839.516048395132, 5854.0, 5876.559258055663, 5880.941190588125, 5890.14592884038, 5894.764209431574, 6046.606970546901, 7134.215236324, 7392.039034925425, 7411.444141689287, 7435.628218589049, 1659.8795812826536, 1681.184625456677, 1681.2098313792499, 1684.62938153606, 1686.8397502237267, 997.2249396074998, 1021.6424251511911, 1050.7058023753361, 1057.0011339284456, 1077.2943721862193, 6668.499862510331, 6785.762498312535, 6887.965560172167, 6907.412869906014, 6912.135983002125, 6766.086578311963, 7641.159472458025, 7794.376449884109, 7801.4929029612895, 7801.765947021599, 6620.702068406837, 6691.029800678874, 6933.479989000845, 6952.339527744856, 6958.199807022156, 4026.295398305285, 4078.408630748525, 4079.286124928126, 4087.243859885871, 4088.7546747195265, 8032.706590297949, 8053.838923221503, 8060.435769496196, 8078.0, 8090.797730056795, 7741.0, 8035.919640803634, 8056.355491560661, 8082.19178082187, 8087.514749115072, 8030.156833532512, 8049.919500805151, 8057.395695322757, 8079.070906845671, 8082.070561885341, 7561.584112873625, 7766.805829854073, 7785.299323060952, 7794.610269486389, 7820.804479888048, 7594.468387213063, 7611.505252158813, 7614.048243969504, 7620.504667196615, 7629.3133617974645, 5792.102224155263, 6872.484563657846, 7967.00412448444, 8048.597570121354, 8050.798730031796, 4818.590419814355, 4923.852284431473, 4954.20732682769, 4981.078500477423, 4996.050750357421, 6900.93099069023, 7655.464117511943, 7658.655360508679, 7673.117591476828, 7675.884861726967, 6204.317525072148, 7133.251008644225, 7328.853422931618, 7343.70625174987, 7350.338469537767, 5843.065109582446, 7347.412207023533, 7348.301911318416, 7356.889646655198, 7360.4479664026485, 5787.565932554991, 6910.723571057101, 7104.11198600175, 7113.181984071898, 7177.425805935408, 7235.167955685163, 7271.381932535794, 7284.235155308616, 7325.4505912057875, 7363.484556081237, 7258.056452661121, 7269.527480713737, 7280.235575264521, 7285.744998925013, 7290.817729556804], "unit": "ms", "name": "prototype.html", "value": 5301.852178368125}, {"lowerIsBetter": false, "replicates": [720.7837648705389, 759.6847308367027, 799.224751990569, 817.5299202958297, 838.9077201507837, 14944.0, 15280.235988200573, 15299.464518741846, 15304.928654994155, 15311.234438278098, 14217.502387416442, 14442.711145777104, 14460.710785784278, 14461.0, 14466.927665361685, 753.7022875963991, 765.2768134113265, 765.4909485192368, 766.1993217088128, 936.255676736994, 743.3569961982873, 756.5838788666239, 944.8110377924409, 964.8263312603729, 974.0697633759743, 999.6501224571379, 1001.9198464122853, 1014.4471263161595, 1016.7864748402807, 1016.8017236638858, 792.694812497187, 998.1266391907081, 1007.5868893753562, 1007.8740157480315, 1009.4094954451618, 593.5696619950545, 593.652713162796, 738.582700774061, 751.7857410637996, 753.2881427051439, 15076.698466030617, 15153.242337883172, 15212.619684507865, 15215.391384344613, 15220.923895380563, 10946.781064378747, 12613.243205407705, 12686.302253376061, 12796.104272700915, 13162.0, 10147.415488107948, 10245.641402550875, 10257.128144107759, 10351.223658225663, 10757.515911783988, 3480.773749706261, 3529.9294014119573, 3531.1525233943926, 3531.5585551806025, 3544.0, 70272.648636757, 70943.0, 71609.64195179043, 72174.91737623939, 82794.58602707008, 9469.89345995768, 9526.428414295164, 9536.66621668252, 9548.522573871278, 9570.61717531305, 21189.046492907855, 21239.0, 21280.0, 21292.78707212939, 21295.68056479154, 7268.636568171676, 7334.119905611254, 7492.063492063492, 7516.849663006709, 7632.0, 3968.1865217630316, 4053.0880551875593, 4100.0, 4106.917861642751, 4185.267578173807, 3607.332643460968, 3638.290533345972, 3643.8360273787744, 3647.0, 3652.7443078984747, 654.7479220500046, 663.4791688524485, 665.3313420012953, 672.3041651890368, 673.8416472129046, 496.14415133893743, 508.9083964886356, 515.2786099460785, 518.9896202075937, 542.7530473634487, 7878.487898286593, 8214.178582141858, 8432.0, 8549.273311768446, 8629.741107766777, 517.503196930943, 529.3706536339733, 584.1471451680509, 601.7893737192036, 620.5097972601594, 3853.6917046636204, 4104.794760261975, 4132.607402296777, 4181.60274773896, 4224.070704445017, 97563.0, 99750.0, 100379.49810251048, 100569.49715251377, 100633.49683251683, 82608.0, 84442.15557844465, 85079.14920850712, 85195.5740221295, 87985.0, 73155.17112072134, 73570.63214683892, 73968.0, 73971.26028739751, 74628.0, 8059.791031345345, 8230.21812927771, 8280.171982801672, 8299.377546683902, 8334.249917507212, 40793.0, 50978.74510627423, 51375.743121284155, 51928.48071519237, 52763.20855187099, 71410.64294678494, 71556.0, 71658.0, 73132.53734925378, 77892.61053694696, 10873.836892446461, 11073.83389249178, 11420.600278990196, 11443.599474018702, 11675.241109327866, 11975.880241197825, 12122.757544848877, 12128.393580321124, 12156.635300940987, 12479.812802807783, 11622.82565761531, 11681.474333654836, 11704.882951170379, 11734.530618775154, 11766.058715302584, 11625.709357266136, 11628.825567616323, 11646.417679116179, 11689.941550292195, 11712.238704484182, 11464.197506174487, 11479.713007174554, 11495.137864660352, 11497.965183133558, 11501.194916355775, 9810.901890980998, 10247.128994035591, 10275.486225688535, 10325.690229293134, 10346.482675866026, 9563.952180239054, 9817.754556136153, 10124.493775311352, 10137.138343240907, 10139.493025348556], "unit": "ms", "name": "yui.html", "value": 6991.837823961009}], "name": "dromaeo_css", "value": 7765.312669629709}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 104.0, 110.0, 111.0, 111.0, 98.0, 110.0, 110.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [149.0, 118.0, 143.0, 155.0, 114.0, 141.0, 142.0, 115.0, 157.0, 116.0], "unit": "ms", "name": "audio-beat-detection", "value": 135.0}, {"lowerIsBetter": true, "replicates": [183.0, 182.0, 213.0, 229.0, 186.0, 184.0, 183.0, 183.0, 183.0, 182.0], "unit": "ms", "name": "audio-dft", "value": 190.8}, {"lowerIsBetter": true, "replicates": [61.0, 70.0, 76.0, 72.0, 56.0, 57.0, 55.0, 72.0, 72.0, 56.0], "unit": "ms", "name": "audio-fft", "value": 64.7}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 117.0, 75.0, 75.0, 75.0, 113.0, 77.0, 74.0, 109.0], "unit": "ms", "name": "audio-oscillator", "value": 88.2}, {"lowerIsBetter": true, "replicates": [89.0, 90.0, 88.0, 90.0, 89.0, 89.0, 89.0, 90.0, 89.0, 90.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 89.3}, {"lowerIsBetter": true, "replicates": [130.0, 96.0, 96.0, 96.0, 96.0, 96.0, 94.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-darkroom", "value": 99.1}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 85.0, 85.0, 85.0, 86.0, 84.0, 84.0, 85.0, 85.0], "unit": "ms", "name": "imaging-desaturate", "value": 84.9}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 53.0, 54.0, 53.0, 53.0, 55.0, 64.0, 52.0, 52.0], "unit": "ms", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 63.0, 63.0, 64.0, 67.0, 66.0, 67.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 81.0, 82.0, 81.0, 81.0, 81.0, 83.0, 82.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [122.0, 130.0, 132.0, 121.0, 130.0, 119.0, 120.0, 128.0, 121.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [134.0, 136.0, 136.0, 133.0, 135.0, 124.0, 134.0, 135.0, 134.0, 129.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 133.0}, {"lowerIsBetter": true, "replicates": [57.0, 86.0, 99.0, 63.0, 65.0, 63.0, 65.0, 64.0, 63.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1387.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [175.0393838613688], "unit": "score", "name": "Richards", "value": 201.68032599999995}, {"lowerIsBetter": false, "replicates": [160.2820964898221], "unit": "score", "name": "DeltaBlue", "value": 412.5102019999999}, {"lowerIsBetter": false, "replicates": [282.2466836014677], "unit": "score", "name": "Encrypt", "value": 943.0792829999996}, {"lowerIsBetter": false, "replicates": [4739.336492890995], "unit": "score", "name": "Decrypt", "value": 56.16419099999998}, {"lowerIsBetter": false, "replicates": [1740.8695652173913], "unit": "score", "name": "RayTrace", "value": 425.0686063936064}, {"lowerIsBetter": false, "replicates": [827.129859387924], "unit": "score", "name": "Earley", "value": 805.7537670000002}, {"lowerIsBetter": false, "replicates": [12084.33734939759], "unit": "score", "name": "Boyer", "value": 55.150976071784655}, {"lowerIsBetter": false, "replicates": [28055.555555555555], "unit": "score", "name": "RegExp", "value": 32.470752475247544}, {"lowerIsBetter": false, "replicates": [749.0636704119851], "unit": "score", "name": "Splay", "value": 108.79048499999999}, {"lowerIsBetter": false, "replicates": [4605.504587155963], "unit": "score", "name": "NavierStokes", "value": 322.223107569721}], "name": "v8_7", "value": 19925.071622810312}]} 19:58:04 INFO - RETURN: dromaeo_css: 7765.31 19:58:04 INFO - RETURN: kraken: 1387.50 19:58:04 INFO - RETURN: v8_7: 19925.07 19:58:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "19925.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1387.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7765.31"}}} 19:58:04 INFO - Return code: 0 19:58:04 INFO - # TBPL SUCCESS # 19:58:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:58:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:58:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:58:04 INFO - 2015-11-23 19:58:04.178 screenresolution[1673:10190] starting screenresolution argv=screenresolution get 19:58:04 INFO - 2015-11-23 19:58:04.181 screenresolution[1673:10190] Display 0: 1600x1200x32@60 19:58:04 INFO - 2015-11-23 19:58:04.186 screenresolution[1674:10193] starting screenresolution argv=screenresolution list 19:58:04 INFO - Available Modes on Display 0 19:58:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:58:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:58:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:58:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:58:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:58:04 INFO - Intel Iris: 19:58:04 INFO - Chipset Model: Intel Iris 19:58:04 INFO - Type: GPU 19:58:04 INFO - Bus: Built-In 19:58:04 INFO - VRAM (Dynamic, Max): 1536 MB 19:58:04 INFO - Vendor: Intel (0x8086) 19:58:04 INFO - Device ID: 0x0a2e 19:58:04 INFO - Revision ID: 0x0009 19:58:04 INFO - Displays: 19:58:04 INFO - Display: 19:58:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:58:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:58:04 INFO - Display Serial Number: 1600x1200 60 19:58:04 INFO - Main Display: Yes 19:58:04 INFO - Mirror: Off 19:58:04 INFO - Online: Yes 19:58:04 INFO - Rotation: Supported 19:58:04 INFO - Return code: 0 19:58:04 INFO - Running post-action listener: _resource_record_post_action 19:58:04 INFO - Running post-run listener: _resource_record_post_run 19:58:05 INFO - Total resource usage - Wall time: 1240s; CPU: 53.0%; Read bytes: 38983168; Write bytes: 689719808; Read time: 421; Write time: 2080 19:58:05 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 345254400; Write bytes: 337380864; Read time: 27005; Write time: 615 19:58:05 INFO - run-tests - Wall time: 1210s; CPU: 52.0%; Read bytes: 31686144; Write bytes: 340984832; Read time: 330; Write time: 1431 19:58:05 INFO - Running post-run listener: _upload_blobber_files 19:58:05 INFO - Blob upload gear active. 19:58:05 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:58:05 INFO - Copying logs to upload dir... 19:58:05 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1290.221074 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2015-11-23 19:58:05.531761) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 19:58:05.536060) ========= 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.DwLVMHSAeK/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.Xg8IkWeqxZ/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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.009303 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:58:05.560658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:58:05.560975) ========= 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.DwLVMHSAeK/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.Xg8IkWeqxZ/Listeners TMPDIR=/var/folders/r7/fvdp6_8944ngrts9c1mfmcsc00000w/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.005026 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:58:05.609503) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 19:58:05.609879) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 19:58:05.610286) ========= ========= Total master_lag: 0.21 =========