builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0018 starttime: 1447880514.55 results: success (0) buildid: 20151118095124 builduid: 44abfd8021434a6cb5d9398df0cdf265 revision: 5cb637976cf157ccbe39795017eba8f937aae9d5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.551157) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.551938) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.552510) ========= 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.0vxrc8f6f8/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.6MaNLqnVpu/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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.005758 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.574324) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.574891) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.590497) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.590893) ========= 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.0vxrc8f6f8/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.6MaNLqnVpu/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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.005101 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.639631) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.640004) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.640429) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.640749) ========= 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.0vxrc8f6f8/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.6MaNLqnVpu/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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-18 13:01:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-18 13:01:54 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181384 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.836574) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.836940) ========= 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.0vxrc8f6f8/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.6MaNLqnVpu/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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.019896 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.886841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:54.887252) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5cb637976cf157ccbe39795017eba8f937aae9d5 --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 5cb637976cf157ccbe39795017eba8f937aae9d5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0vxrc8f6f8/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.6MaNLqnVpu/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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-18 13:01:54,963 truncating revision to first 12 chars 2015-11-18 13:01:54,963 Setting DEBUG logging. 2015-11-18 13:01:54,963 attempt 1/10 2015-11-18 13:01:54,963 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5cb637976cf1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 13:01:55,238 unpacking tar archive at: fx-team-5cb637976cf1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.517077 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:55.419313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:55.419685) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:55.432034) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:55.432436) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 13:01:55.432918) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-18 13:01:55.433255) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0vxrc8f6f8/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.6MaNLqnVpu/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 13:01:55 INFO - MultiFileLogger online at 20151118 13:01:55 in /builds/slave/test 13:01:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:01:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:01:55 INFO - {'append_to_log': False, 13:01:55 INFO - 'base_work_dir': '/builds/slave/test', 13:01:55 INFO - 'blob_upload_branch': 'Fx-Team', 13:01:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:01:55 INFO - 'branch': 'Fx-Team', 13:01:55 INFO - 'buildbot_json_path': 'buildprops.json', 13:01:55 INFO - 'config_files': ('talos/mac_config.py',), 13:01:55 INFO - 'default_actions': ('clobber', 13:01:55 INFO - 'read-buildbot-config', 13:01:55 INFO - 'download-and-extract', 13:01:55 INFO - 'populate-webroot', 13:01:55 INFO - 'create-virtualenv', 13:01:55 INFO - 'install', 13:01:55 INFO - 'run-tests'), 13:01:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:01:55 INFO - 'download_minidump_stackwalk': True, 13:01:55 INFO - 'download_symbols': 'ondemand', 13:01:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:01:55 INFO - 'tooltool.py': '/tools/tooltool.py', 13:01:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:01:55 INFO - '/tools/misc-python/virtualenv.py')}, 13:01:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:01:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:01:55 INFO - 'installer_path': 'installer.exe', 13:01:55 INFO - 'log_level': 'info', 13:01:55 INFO - 'log_name': 'talos', 13:01:55 INFO - 'log_to_console': True, 13:01:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:01:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:01:55 INFO - 'opt_config_files': (), 13:01:55 INFO - 'pip_index': False, 13:01:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:01:55 INFO - 'cmd': ('bash', 13:01:55 INFO - '-c', 13:01:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:01:55 INFO - 'enabled': True, 13:01:55 INFO - 'halt_on_failure': False, 13:01:55 INFO - 'name': 'check_screen_resolution'},), 13:01:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:01:55 INFO - 'cmd': ('bash', 13:01:55 INFO - '-c', 13:01:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:01:55 INFO - 'enabled': True, 13:01:55 INFO - 'halt_on_failure': False, 13:01:55 INFO - 'name': 'check_screen_resolution'},), 13:01:55 INFO - 'run_cmd_checks_enabled': True, 13:01:55 INFO - 'sps_profile': False, 13:01:55 INFO - 'sps_profile_interval': 0, 13:01:55 INFO - 'suite': 'dromaeojs-e10s', 13:01:55 INFO - 'system_bits': '64', 13:01:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:01:55 INFO - 'title': 't-yosemite-r7-0018', 13:01:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:01:55 INFO - 'use_talos_json': True, 13:01:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:01:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:01:55 INFO - 'work_dir': 'build'} 13:01:55 INFO - ##### 13:01:55 INFO - ##### Running clobber step. 13:01:55 INFO - ##### 13:01:55 INFO - Running pre-action listener: _resource_record_pre_action 13:01:55 INFO - Running main action method: clobber 13:01:55 INFO - rmtree: /builds/slave/test/build 13:01:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:01:57 INFO - Running post-action listener: _resource_record_post_action 13:01:57 INFO - ##### 13:01:57 INFO - ##### Running read-buildbot-config step. 13:01:57 INFO - ##### 13:01:57 INFO - Running pre-action listener: _resource_record_pre_action 13:01:57 INFO - Running main action method: read_buildbot_config 13:01:57 INFO - Using buildbot properties: 13:01:57 INFO - { 13:01:57 INFO - "properties": { 13:01:57 INFO - "buildnumber": 3, 13:01:57 INFO - "product": "firefox", 13:01:57 INFO - "script_repo_revision": "production", 13:01:57 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 13:01:57 INFO - "repository": "", 13:01:57 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 13:01:57 INFO - "buildid": "20151118095124", 13:01:57 INFO - "slavename": "t-yosemite-r7-0018", 13:01:57 INFO - "pgo_build": "False", 13:01:57 INFO - "basedir": "/builds/slave/test", 13:01:57 INFO - "project": "", 13:01:57 INFO - "platform": "yosemite_r7", 13:01:57 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:01:57 INFO - "slavebuilddir": "test", 13:01:57 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:01:57 INFO - "branch": "fx-team", 13:01:57 INFO - "repo_path": "integration/fx-team", 13:01:57 INFO - "stage_platform": "macosx64", 13:01:57 INFO - "builduid": "44abfd8021434a6cb5d9398df0cdf265", 13:01:57 INFO - "revision": "5cb637976cf157ccbe39795017eba8f937aae9d5" 13:01:57 INFO - }, 13:01:57 INFO - "sourcestamp": { 13:01:57 INFO - "repository": "", 13:01:57 INFO - "hasPatch": false, 13:01:57 INFO - "project": "", 13:01:57 INFO - "branch": "fx-team-macosx64-talos", 13:01:57 INFO - "changes": [ 13:01:57 INFO - { 13:01:57 INFO - "category": null, 13:01:57 INFO - "files": [ 13:01:57 INFO - { 13:01:57 INFO - "url": null, 13:01:57 INFO - "name": "https://queue.taskcluster.net/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 13:01:57 INFO - } 13:01:57 INFO - ], 13:01:57 INFO - "repository": "", 13:01:57 INFO - "rev": "5cb637976cf157ccbe39795017eba8f937aae9d5", 13:01:57 INFO - "who": "jwein@mozilla.com", 13:01:57 INFO - "when": 1447875524, 13:01:57 INFO - "number": 6678405, 13:01:57 INFO - "comments": "Bug 1190961 - Change info-pages.css' placeholder icon to one that exists in toolkit/ r=jaws", 13:01:57 INFO - "project": "", 13:01:57 INFO - "at": "Wed 18 Nov 2015 11:38:44", 13:01:57 INFO - "branch": "fx-team-macosx64-talos", 13:01:57 INFO - "revlink": "", 13:01:57 INFO - "properties": [ 13:01:57 INFO - [ 13:01:57 INFO - "buildid", 13:01:57 INFO - "20151118095124", 13:01:57 INFO - "Change" 13:01:57 INFO - ], 13:01:57 INFO - [ 13:01:57 INFO - "builduid", 13:01:57 INFO - "44abfd8021434a6cb5d9398df0cdf265", 13:01:57 INFO - "Change" 13:01:57 INFO - ], 13:01:57 INFO - [ 13:01:57 INFO - "pgo_build", 13:01:57 INFO - "False", 13:01:57 INFO - "Change" 13:01:57 INFO - ] 13:01:57 INFO - ], 13:01:57 INFO - "revision": "5cb637976cf157ccbe39795017eba8f937aae9d5" 13:01:57 INFO - } 13:01:57 INFO - ], 13:01:57 INFO - "revision": "5cb637976cf157ccbe39795017eba8f937aae9d5" 13:01:57 INFO - } 13:01:57 INFO - } 13:01:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 13:01:57 INFO - Running post-action listener: _resource_record_post_action 13:01:57 INFO - ##### 13:01:57 INFO - ##### Running download-and-extract step. 13:01:57 INFO - ##### 13:01:57 INFO - Running pre-action listener: _resource_record_pre_action 13:01:57 INFO - Running main action method: download_and_extract 13:01:57 INFO - mkdir: /builds/slave/test/build/tests 13:01:57 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')]} 13:01:57 INFO - https://queue.taskcluster.net/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:01:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/test_packages.json 13:01:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/test_packages.json 13:01:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:01:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:01:58 INFO - Downloaded 1149 bytes. 13:01:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:01:58 INFO - Using the following test package requirements: 13:01:58 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 13:01:58 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:01:58 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 13:01:58 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:01:58 INFO - u'jsshell-mac.zip'], 13:01:58 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:01:58 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 13:01:58 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 13:01:58 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:01:58 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 13:01:58 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:01:58 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 13:01:58 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:01:58 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 13:01:58 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 13:01:58 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 13:01:58 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 13:01:58 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:58 INFO - https://queue.taskcluster.net/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:01:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:01:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:01:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/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 13:01:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/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 13:02:00 INFO - Downloaded 17476922 bytes. 13:02:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 13:02:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:02:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 13:02:02 INFO - Return code: 0 13:02:02 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 13:02:02 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')]} 13:02:02 INFO - https://queue.taskcluster.net/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:02:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:02:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:02:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/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 13:02:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/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 13:02:03 INFO - Downloaded 17476922 bytes. 13:02:03 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 13:02:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 13:02:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 13:02:07 INFO - Return code: 0 13:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:07 INFO - https://queue.taskcluster.net/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 13:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 13:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/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 13:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/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 13:02:08 INFO - Downloaded 11130997 bytes. 13:02:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 13:02:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 13:02:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 13:02:08 INFO - Return code: 0 13:02:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:08 INFO - https://queue.taskcluster.net/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:02:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 13:02:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 13:02:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 13:02:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/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 13:02:11 INFO - Downloaded 108852268 bytes. 13:02:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 13:02:11 INFO - mkdir: /builds/slave/test/properties 13:02:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:02:11 INFO - Writing to file /builds/slave/test/properties/build_url 13:02:11 INFO - Contents: 13:02:11 INFO - build_url:https://queue.taskcluster.net/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 13:02:11 INFO - Running post-action listener: _resource_record_post_action 13:02:11 INFO - Running post-action listener: set_extra_try_arguments 13:02:11 INFO - ##### 13:02:11 INFO - ##### Running populate-webroot step. 13:02:11 INFO - ##### 13:02:11 INFO - Running pre-action listener: _resource_record_pre_action 13:02:11 INFO - Running main action method: populate_webroot 13:02:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:02:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:02:11 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:02:11 INFO - '../fennec_ids.txt'], 13:02:11 INFO - 'tests': ['tcheck2']}, 13:02:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:02:11 INFO - '--tppagecycles', 13:02:11 INFO - '7'], 13:02:11 INFO - 'tests': ['tsvgm']}}, 13:02:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:02:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:02:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:02:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:02:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:02:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:02:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:02:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:11 INFO - 'talos_options': ['--e10s'], 13:02:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:02:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:11 INFO - 'tests': ['damp', 'tps']}, 13:02:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:11 INFO - 'talos_options': ['--e10s'], 13:02:11 INFO - 'tests': ['damp', 'tps']}, 13:02:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:02:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:02:11 INFO - 'other': {'tests': ['a11yr', 13:02:11 INFO - 'ts_paint', 13:02:11 INFO - 'tpaint', 13:02:11 INFO - 'sessionrestore', 13:02:11 INFO - 'sessionrestore_no_auto_restore']}, 13:02:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:02:11 INFO - 'tests': ['a11yr', 13:02:11 INFO - 'ts_paint', 13:02:11 INFO - 'tpaint', 13:02:11 INFO - 'sessionrestore', 13:02:11 INFO - 'sessionrestore_no_auto_restore']}, 13:02:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:02:11 INFO - 'tests': ['a11yr', 13:02:11 INFO - 'ts_paint', 13:02:11 INFO - 'tpaint', 13:02:11 INFO - 'sessionrestore', 13:02:11 INFO - 'sessionrestore_no_auto_restore']}, 13:02:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:02:11 INFO - 'tests': ['a11yr', 13:02:11 INFO - 'ts_paint', 13:02:11 INFO - 'tpaint', 13:02:11 INFO - 'sessionrestore', 13:02:11 INFO - 'sessionrestore_no_auto_restore']}, 13:02:11 INFO - 'other_l64': {'tests': ['a11yr', 13:02:11 INFO - 'ts_paint', 13:02:11 INFO - 'tpaint', 13:02:11 INFO - 'sessionrestore', 13:02:11 INFO - 'sessionrestore_no_auto_restore']}, 13:02:11 INFO - 'other_nol64': {'tests': ['a11yr', 13:02:11 INFO - 'ts_paint', 13:02:11 INFO - 'tpaint', 13:02:11 INFO - 'sessionrestore', 13:02:11 INFO - 'sessionrestore_no_auto_restore']}, 13:02:11 INFO - 'svgr': {'tests': ['tsvgx', 13:02:11 INFO - 'tsvgr_opacity', 13:02:11 INFO - 'tart', 13:02:11 INFO - 'tscrollx', 13:02:11 INFO - 'cart']}, 13:02:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:02:11 INFO - 'tests': ['tsvgx', 13:02:11 INFO - 'tsvgr_opacity', 13:02:11 INFO - 'tart', 13:02:11 INFO - 'tscrollx', 13:02:11 INFO - 'cart']}, 13:02:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:11 INFO - 'tests': ['tp5o']}, 13:02:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:11 INFO - 'talos_options': ['--e10s'], 13:02:11 INFO - 'tests': ['tp5o']}, 13:02:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:11 INFO - 'talos_options': ['--xperf_path', 13:02:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:02:11 INFO - 'tests': ['tp5n']}, 13:02:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:11 INFO - 'talos_options': ['--e10s', 13:02:11 INFO - '--xperf_path', 13:02:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:02:11 INFO - 'tests': ['tp5n']}}, 13:02:11 INFO - 'talos.zip': {'path': '', 13:02:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:02:11 INFO - Running post-action listener: _resource_record_post_action 13:02:11 INFO - ##### 13:02:11 INFO - ##### Running create-virtualenv step. 13:02:11 INFO - ##### 13:02:11 INFO - Running pre-action listener: _resource_record_pre_action 13:02:11 INFO - Running main action method: create_virtualenv 13:02:11 INFO - Creating virtualenv /builds/slave/test/build/venv 13:02:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:02:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:02:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:02:11 INFO - Using real prefix '/tools/python27' 13:02:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:02:12 INFO - Installing distribute.............................................................................................................................................................................................done. 13:02:15 INFO - Installing pip.................done. 13:02:15 INFO - Return code: 0 13:02:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:02:15 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')]} 13:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:15 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')]} 13:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:15 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 0x10b778490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b755228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9570500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b69c9f0>, '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 0x10b3fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68f8c8>, '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.0vxrc8f6f8/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.6MaNLqnVpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 13:02:15 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 13:02:15 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 13:02:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0vxrc8f6f8/Render', 13:02:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:15 INFO - 'HOME': '/Users/cltbld', 13:02:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:15 INFO - 'LOGNAME': 'cltbld', 13:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:15 INFO - 'MOZ_NO_REMOTE': '1', 13:02:15 INFO - 'NO_EM_RESTART': '1', 13:02:15 INFO - 'PAGER': '/bin/cat', 13:02:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:15 INFO - 'PWD': '/builds/slave/test', 13:02:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:15 INFO - 'SHELL': '/bin/bash', 13:02:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6MaNLqnVpu/Listeners', 13:02:15 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 13:02:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:15 INFO - 'USER': 'cltbld', 13:02:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:15 INFO - 'XPC_FLAGS': '0x0', 13:02:15 INFO - 'XPC_SERVICE_NAME': '0', 13:02:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:15 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 13:02:15 INFO - Cleaning up... 13:02:15 INFO - Return code: 0 13:02:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:02:15 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')]} 13:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:15 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')]} 13:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:15 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 0x10b778490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b755228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9570500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b69c9f0>, '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 0x10b3fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68f8c8>, '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.0vxrc8f6f8/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.6MaNLqnVpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 13:02:15 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 13:02:15 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 13:02:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0vxrc8f6f8/Render', 13:02:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:15 INFO - 'HOME': '/Users/cltbld', 13:02:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:15 INFO - 'LOGNAME': 'cltbld', 13:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:15 INFO - 'MOZ_NO_REMOTE': '1', 13:02:15 INFO - 'NO_EM_RESTART': '1', 13:02:15 INFO - 'PAGER': '/bin/cat', 13:02:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:15 INFO - 'PWD': '/builds/slave/test', 13:02:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:15 INFO - 'SHELL': '/bin/bash', 13:02:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6MaNLqnVpu/Listeners', 13:02:15 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 13:02:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:15 INFO - 'USER': 'cltbld', 13:02:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:15 INFO - 'XPC_FLAGS': '0x0', 13:02:15 INFO - 'XPC_SERVICE_NAME': '0', 13:02:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:15 INFO - Downloading/unpacking psutil>=0.7.1 13:02:15 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 13:02:15 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 13:02:15 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 13:02:15 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 13:02:15 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 13:02:15 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 13:02:18 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:02:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:02:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:02:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:02:18 INFO - Installing collected packages: psutil 13:02:18 INFO - Running setup.py install for psutil 13:02:18 INFO - building 'psutil._psutil_osx' extension 13:02:18 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 13:02:18 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 13:02:19 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 13:02:19 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 13:02:19 INFO - building 'psutil._psutil_posix' extension 13:02:19 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 13:02:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:02:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:02:19 INFO - ^ 13:02:19 INFO - 1 warning generated. 13:02:19 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 13:02:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:02:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:02:19 INFO - Successfully installed psutil 13:02:19 INFO - Cleaning up... 13:02:19 INFO - Return code: 0 13:02:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:02:19 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')]} 13:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:19 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')]} 13:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:19 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 0x10b778490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b755228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9570500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b69c9f0>, '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 0x10b3fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68f8c8>, '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.0vxrc8f6f8/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.6MaNLqnVpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 13:02:19 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 13:02:19 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 13:02:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0vxrc8f6f8/Render', 13:02:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:19 INFO - 'HOME': '/Users/cltbld', 13:02:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:19 INFO - 'LOGNAME': 'cltbld', 13:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:19 INFO - 'MOZ_NO_REMOTE': '1', 13:02:19 INFO - 'NO_EM_RESTART': '1', 13:02:19 INFO - 'PAGER': '/bin/cat', 13:02:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:19 INFO - 'PWD': '/builds/slave/test', 13:02:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:19 INFO - 'SHELL': '/bin/bash', 13:02:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6MaNLqnVpu/Listeners', 13:02:19 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 13:02:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:19 INFO - 'USER': 'cltbld', 13:02:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:19 INFO - 'XPC_FLAGS': '0x0', 13:02:19 INFO - 'XPC_SERVICE_NAME': '0', 13:02:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:02:19 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 13:02:19 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 13:02:19 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 13:02:19 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 13:02:19 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 13:02:19 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 13:02:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:02:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:02:21 INFO - Installing collected packages: mozsystemmonitor 13:02:21 INFO - Running setup.py install for mozsystemmonitor 13:02:22 INFO - Successfully installed mozsystemmonitor 13:02:22 INFO - Cleaning up... 13:02:22 INFO - Return code: 0 13:02:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:02: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')]} 13:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b778490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b755228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9570500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b69c9f0>, '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 0x10b3fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68f8c8>, '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.0vxrc8f6f8/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.6MaNLqnVpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 13:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:02:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0vxrc8f6f8/Render', 13:02:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:22 INFO - 'HOME': '/Users/cltbld', 13:02:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:22 INFO - 'LOGNAME': 'cltbld', 13:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:22 INFO - 'MOZ_NO_REMOTE': '1', 13:02:22 INFO - 'NO_EM_RESTART': '1', 13:02:22 INFO - 'PAGER': '/bin/cat', 13:02:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:22 INFO - 'PWD': '/builds/slave/test', 13:02:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:22 INFO - 'SHELL': '/bin/bash', 13:02:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6MaNLqnVpu/Listeners', 13:02:22 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 13:02:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:22 INFO - 'USER': 'cltbld', 13:02:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:22 INFO - 'XPC_FLAGS': '0x0', 13:02:22 INFO - 'XPC_SERVICE_NAME': '0', 13:02:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:22 INFO - Downloading/unpacking blobuploader==1.2.4 13:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:24 INFO - Downloading blobuploader-1.2.4.tar.gz 13:02:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:02:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:02:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:02:24 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 13:02:24 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 13:02:24 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 13:02:24 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 13:02:24 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 13:02:24 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 13:02:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:02:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:02:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:25 INFO - Downloading docopt-0.6.1.tar.gz 13:02:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:02:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:02:25 INFO - Installing collected packages: blobuploader, requests, docopt 13:02:25 INFO - Running setup.py install for blobuploader 13:02:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:02:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:02:25 INFO - Running setup.py install for requests 13:02:26 INFO - Running setup.py install for docopt 13:02:26 INFO - Successfully installed blobuploader requests docopt 13:02:26 INFO - Cleaning up... 13:02:26 INFO - Return code: 0 13:02:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:26 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 0x10b778490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b755228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9570500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b69c9f0>, '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 0x10b3fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68f8c8>, '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.0vxrc8f6f8/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.6MaNLqnVpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 13:02:26 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 13:02:26 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 13:02:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0vxrc8f6f8/Render', 13:02:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:26 INFO - 'HOME': '/Users/cltbld', 13:02:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:26 INFO - 'LOGNAME': 'cltbld', 13:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:26 INFO - 'MOZ_NO_REMOTE': '1', 13:02:26 INFO - 'NO_EM_RESTART': '1', 13:02:26 INFO - 'PAGER': '/bin/cat', 13:02:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:26 INFO - 'PWD': '/builds/slave/test', 13:02:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:26 INFO - 'SHELL': '/bin/bash', 13:02:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6MaNLqnVpu/Listeners', 13:02:26 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 13:02:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:26 INFO - 'USER': 'cltbld', 13:02:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:26 INFO - 'XPC_FLAGS': '0x0', 13:02:26 INFO - 'XPC_SERVICE_NAME': '0', 13:02:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:02:26 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-Rl5SLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:02:26 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-eft6my-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:02:27 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-FQxKH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:02:27 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-8tRTsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:02:27 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-wNLabk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:02:27 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-f3VZhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:02:27 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-jN5pFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:02:27 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-LVt8BB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:02:27 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-P40A2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:02:27 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-Ex63Ut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:02:27 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-D7VjtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:02:28 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-YlsiXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:02:28 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-jsSAYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:02:28 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-5EI_AL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:28 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-fMhRsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:02:28 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-4yJXJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:02:28 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-aFNW0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:02:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:02:28 INFO - Running setup.py install for manifestparser 13:02:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:02:28 INFO - Running setup.py install for mozcrash 13:02:28 INFO - Running setup.py install for mozdebug 13:02:29 INFO - Running setup.py install for mozdevice 13:02:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:02:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:02:29 INFO - Running setup.py install for mozfile 13:02:29 INFO - Running setup.py install for mozhttpd 13:02:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:02:29 INFO - Running setup.py install for mozinfo 13:02:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:02:29 INFO - Running setup.py install for mozInstall 13:02:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:02:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:02:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:02:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:02:29 INFO - Running setup.py install for mozleak 13:02:29 INFO - Running setup.py install for mozlog 13:02:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:02:30 INFO - Running setup.py install for moznetwork 13:02:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:02:30 INFO - Running setup.py install for mozprocess 13:02:30 INFO - Running setup.py install for mozprofile 13:02:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:02:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:02:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:02:30 INFO - Running setup.py install for mozrunner 13:02:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:02:30 INFO - Running setup.py install for mozscreenshot 13:02:30 INFO - Running setup.py install for moztest 13:02:31 INFO - Running setup.py install for mozversion 13:02:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:02:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:02:31 INFO - Cleaning up... 13:02:31 INFO - Return code: 0 13:02:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10b778490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b755228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9570500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b69c9f0>, '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 0x10b3fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68f8c8>, '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.0vxrc8f6f8/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.6MaNLqnVpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 13:02:31 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 13:02:31 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 13:02:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0vxrc8f6f8/Render', 13:02:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:31 INFO - 'HOME': '/Users/cltbld', 13:02:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:31 INFO - 'LOGNAME': 'cltbld', 13:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:31 INFO - 'MOZ_NO_REMOTE': '1', 13:02:31 INFO - 'NO_EM_RESTART': '1', 13:02:31 INFO - 'PAGER': '/bin/cat', 13:02:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:31 INFO - 'PWD': '/builds/slave/test', 13:02:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:31 INFO - 'SHELL': '/bin/bash', 13:02:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6MaNLqnVpu/Listeners', 13:02:31 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 13:02:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:31 INFO - 'USER': 'cltbld', 13:02:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:31 INFO - 'XPC_FLAGS': '0x0', 13:02:31 INFO - 'XPC_SERVICE_NAME': '0', 13:02:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:02:31 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-IrR5sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:02:31 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)) 13:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:02:31 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-Kkbd3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:02:31 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)) 13:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:02:31 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-6qH1yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:02:31 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)) 13:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:02:31 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-y8I4C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:02:31 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)) 13:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:02:31 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-bkhPdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:02:31 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)) 13:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:02:32 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-BuKPap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:02:32 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-KnW6QV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:02:32 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-bRIUsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:02:32 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-i1ugo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:02:32 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-pGWg6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:02:32 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-KR0Bhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:02:32 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-QA7CYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:02:32 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-gHIV7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:02:32 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-h5CGPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:02:32 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)) 13:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:32 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-S0c57y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:33 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)) 13:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:02:33 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-bUJTWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:02:33 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)) 13:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:02:33 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-NjUtSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:02:33 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)) 13:02:33 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)) 13:02:33 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)) 13:02:33 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)) 13:02:33 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)) 13:02:33 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)) 13:02:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:02:33 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 13:02:33 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 13:02:33 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 13:02:33 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 13:02:33 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 13:02:33 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 13:02:35 INFO - Downloading blessings-1.5.1.tar.gz 13:02:35 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 13:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:02:35 INFO - Installing collected packages: blessings 13:02:35 INFO - Running setup.py install for blessings 13:02:35 INFO - Successfully installed blessings 13:02:35 INFO - Cleaning up... 13:02:35 INFO - Return code: 0 13:02:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:02:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:02:35 INFO - Reading from file tmpfile_stdout 13:02:35 INFO - Current package versions: 13:02:35 INFO - blessings == 1.5.1 13:02:35 INFO - blobuploader == 1.2.4 13:02:35 INFO - docopt == 0.6.1 13:02:35 INFO - manifestparser == 1.1 13:02:35 INFO - mozInstall == 1.12 13:02:35 INFO - mozcrash == 0.16 13:02:35 INFO - mozdebug == 0.1 13:02:35 INFO - mozdevice == 0.47 13:02:35 INFO - mozfile == 1.2 13:02:35 INFO - mozhttpd == 0.7 13:02:35 INFO - mozinfo == 0.9 13:02:35 INFO - mozleak == 0.1 13:02:35 INFO - mozlog == 3.0 13:02:35 INFO - moznetwork == 0.27 13:02:35 INFO - mozprocess == 0.22 13:02:35 INFO - mozprofile == 0.27 13:02:35 INFO - mozrunner == 6.11 13:02:35 INFO - mozscreenshot == 0.1 13:02:35 INFO - mozsystemmonitor == 0.0 13:02:35 INFO - moztest == 0.7 13:02:35 INFO - mozversion == 1.4 13:02:35 INFO - psutil == 3.1.1 13:02:35 INFO - requests == 1.2.3 13:02:35 INFO - wsgiref == 0.1.2 13:02:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:35 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 0x10b778490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b755228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefc9570500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b69c9f0>, '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 0x10b3fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68f8c8>, '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.0vxrc8f6f8/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.6MaNLqnVpu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 13:02:35 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 13:02:35 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 13:02:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0vxrc8f6f8/Render', 13:02:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:35 INFO - 'HOME': '/Users/cltbld', 13:02:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:35 INFO - 'LOGNAME': 'cltbld', 13:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:35 INFO - 'MOZ_NO_REMOTE': '1', 13:02:35 INFO - 'NO_EM_RESTART': '1', 13:02:35 INFO - 'PAGER': '/bin/cat', 13:02:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:35 INFO - 'PWD': '/builds/slave/test', 13:02:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:35 INFO - 'SHELL': '/bin/bash', 13:02:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6MaNLqnVpu/Listeners', 13:02:35 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 13:02:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:35 INFO - 'USER': 'cltbld', 13:02:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:35 INFO - 'XPC_FLAGS': '0x0', 13:02:35 INFO - 'XPC_SERVICE_NAME': '0', 13:02:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:36 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)) 13:02:36 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)) 13:02:36 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)) 13:02:36 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)) 13:02:36 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)) 13:02:36 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)) 13:02:36 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)) 13:02:36 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)) 13:02:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:02:36 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)) 13:02:36 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)) 13:02:36 INFO - Cleaning up... 13:02:36 INFO - Return code: 0 13:02:36 INFO - Running post-action listener: _resource_record_post_action 13:02:36 INFO - Running post-action listener: _start_resource_monitoring 13:02:36 INFO - Starting resource monitoring. 13:02:36 INFO - ##### 13:02:36 INFO - ##### Running install step. 13:02:36 INFO - ##### 13:02:36 INFO - Running pre-action listener: _resource_record_pre_action 13:02:36 INFO - Running main action method: install 13:02:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:02:36 INFO - Reading from file tmpfile_stdout 13:02:36 INFO - Detecting whether we're running mozinstall >=1.0... 13:02:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:02:36 INFO - Reading from file tmpfile_stdout 13:02:36 INFO - Output received: 13:02:36 INFO - Usage: mozinstall [options] installer 13:02:36 INFO - Options: 13:02:36 INFO - -h, --help show this help message and exit 13:02:36 INFO - -d DEST, --destination=DEST 13:02:36 INFO - Directory to install application into. [default: 13:02:36 INFO - "/builds/slave/test"] 13:02:36 INFO - --app=APP Application being installed. [default: firefox] 13:02:36 INFO - mkdir: /builds/slave/test/build/application 13:02:36 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'] 13:02:36 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 13:03:06 INFO - Reading from file tmpfile_stdout 13:03:06 INFO - Output received: 13:03:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:03:06 INFO - Running post-action listener: _resource_record_post_action 13:03:06 INFO - ##### 13:03:06 INFO - ##### Running run-tests step. 13:03:06 INFO - ##### 13:03:06 INFO - Running pre-action listener: _resource_record_pre_action 13:03:06 INFO - Running main action method: run_tests 13:03:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:03:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:03:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:03:06 INFO - 2015-11-18 13:03:06.626 screenresolution[1928:63740] starting screenresolution argv=screenresolution get 13:03:06 INFO - 2015-11-18 13:03:06.629 screenresolution[1928:63740] Display 0: 1600x1200x32@60 13:03:06 INFO - 2015-11-18 13:03:06.635 screenresolution[1929:63743] starting screenresolution argv=screenresolution list 13:03:06 INFO - Available Modes on Display 0 13:03:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:03:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:03:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:03:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:03:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:03:06 INFO - Intel Iris: 13:03:06 INFO - Chipset Model: Intel Iris 13:03:06 INFO - Type: GPU 13:03:06 INFO - Bus: Built-In 13:03:06 INFO - VRAM (Dynamic, Max): 1536 MB 13:03:06 INFO - Vendor: Intel (0x8086) 13:03:06 INFO - Device ID: 0x0a2e 13:03:06 INFO - Revision ID: 0x0009 13:03:06 INFO - Displays: 13:03:06 INFO - Display: 13:03:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:03:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:03:06 INFO - Display Serial Number: 1600x1200 60 13:03:06 INFO - Main Display: Yes 13:03:06 INFO - Mirror: Off 13:03:06 INFO - Online: Yes 13:03:06 INFO - Rotation: Supported 13:03:06 INFO - Return code: 0 13:03:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:03:06 INFO - Python 2.7.3 13:03:06 INFO - Return code: 0 13:03:06 INFO - grabbing minidump binary from tooltool 13:03: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')]} 13:03:06 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 0x10b69c9f0>, '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 0x10b3fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b68f8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:03:06 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 13:03:06 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 13:03:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:03:06 INFO - Return code: 0 13:03:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:03:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:03:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:03:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:03:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:03:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--webServer', 'localhost'] in /builds/slave/test/build 13:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0018 --webServer localhost 13:03:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0vxrc8f6f8/Render', 13:03:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:03:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:03:06 INFO - 'HOME': '/Users/cltbld', 13:03:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:03:06 INFO - 'LOGNAME': 'cltbld', 13:03:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:03:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:06 INFO - 'MOZ_NO_REMOTE': '1', 13:03:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:03:06 INFO - 'NO_EM_RESTART': '1', 13:03:06 INFO - 'PAGER': '/bin/cat', 13:03:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:06 INFO - 'PWD': '/builds/slave/test', 13:03:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:03:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:03:06 INFO - 'SHELL': '/bin/bash', 13:03:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6MaNLqnVpu/Listeners', 13:03:06 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 13:03:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:03:06 INFO - 'USER': 'cltbld', 13:03:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:03:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:06 INFO - 'XPC_FLAGS': '0x0', 13:03:06 INFO - 'XPC_SERVICE_NAME': '0', 13:03:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:03:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--webServer', 'localhost'] with output_timeout 3600 13:03:07 INFO - mozversion INFO | application_buildid: 20151118095124 13:03:07 INFO - mozversion INFO | application_changeset: 5cb637976cf157ccbe39795017eba8f937aae9d5 13:03:07 INFO - mozversion INFO | application_display_name: Nightly 13:03:07 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:03:07 INFO - mozversion INFO | application_name: Firefox 13:03:07 INFO - mozversion INFO | application_remotingname: firefox 13:03:07 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:03:07 INFO - mozversion INFO | application_vendor: Mozilla 13:03:07 INFO - mozversion INFO | application_version: 45.0a1 13:03:07 INFO - mozversion INFO | platform_buildid: 20151118095124 13:03:07 INFO - mozversion INFO | platform_changeset: 5cb637976cf157ccbe39795017eba8f937aae9d5 13:03:07 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:03:07 INFO - mozversion INFO | platform_version: 45.0a1 13:03:07 INFO - 2015-11-18 13:03:07,176 DEBUG : using testdate: 1447880587 13:03:07 INFO - 2015-11-18 13:03:07,176 DEBUG : actual date: 1447880587 13:03:07 INFO - 2015-11-18 13:03:07,556 INFO : starting webserver on 'localhost:53281' 13:03:07 INFO - 2015-11-18 13:03:07,557 INFO : Starting test suite t-yosemite-r7-0018.e 13:03:07 INFO - 2015-11-18 13:03:07,557 INFO : Starting test dromaeo_css 13:03:07 INFO - 2015-11-18 13:03:07,557 DEBUG : operating with platform_type : mac_ 13:03:07 INFO - 2015-11-18 13:03:07,559 INFO : Initialising browser for dromaeo_css test... 13:03:07 INFO - 2015-11-18 13:03:07,570 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpmTyRML/profile http://localhost:53281/getInfo.html 13:03:10 INFO - 2015-11-18 13:03:10,460 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:03:10 INFO - 2015-11-18 13:03:10,460 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:03:10 INFO - 2015-11-18 13:03:10,460 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:03:10 INFO - 2015-11-18 13:03:10,460 DEBUG : BROWSER_OUTPUT: __metrics 13:03:11 INFO - 2015-11-18 13:03:11,176 INFO : Browser initialized. 13:03:11 INFO - 2015-11-18 13:03:11,176 INFO : Running cycle 1/1 for dromaeo_css test... 13:03:11 INFO - 2015-11-18 13:03:11,176 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpmTyRML/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:03:23 INFO - 2015-11-18 13:03:23,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 237137920 13:03:23 INFO - 2015-11-18 13:03:23,177 DEBUG : BROWSER_OUTPUT: 13:04:12 INFO - 2015-11-18 13:04:12,859 DEBUG : BROWSER_OUTPUT: 1447880652851 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] 13:06:22 INFO - 2015-11-18 13:06:22,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53281/tests/dromaeo/cssquery-ext.html) 13:06:23 INFO - 2015-11-18 13:06:23,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 255873024 13:06:23 INFO - 2015-11-18 13:06:23,549 DEBUG : BROWSER_OUTPUT: 13:09:25 INFO - 2015-11-18 13:09:25,403 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/dromaeo/cssquery-ext.html (next: http://localhost:53281/tests/dromaeo/cssquery-jquery.html) 13:09:25 INFO - 2015-11-18 13:09:25,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 263389184 13:09:25 INFO - 2015-11-18 13:09:25,987 DEBUG : BROWSER_OUTPUT: 13:12:27 INFO - 2015-11-18 13:12:27,644 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53281/tests/dromaeo/cssquery-mootools.html) 13:12:28 INFO - 2015-11-18 13:12:28,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 265404416 13:12:28 INFO - 2015-11-18 13:12:28,223 DEBUG : BROWSER_OUTPUT: 13:15:29 INFO - 2015-11-18 13:15:29,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53281/tests/dromaeo/cssquery-prototype.html) 13:15:30 INFO - 2015-11-18 13:15:30,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 266203136 13:15:30 INFO - 2015-11-18 13:15:30,432 DEBUG : BROWSER_OUTPUT: 13:18:32 INFO - 2015-11-18 13:18:32,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53281/tests/dromaeo/cssquery-yui.html) 13:18:33 INFO - 2015-11-18 13:18:33,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 269373440 13:18:33 INFO - 2015-11-18 13:18:33,531 DEBUG : BROWSER_OUTPUT: 13:21:35 INFO - 2015-11-18 13:21:35,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/dromaeo/cssquery-yui.html (next: http://localhost:53281/tests/dromaeo/cssquery-dojo.html) 13:21:36 INFO - 2015-11-18 13:21:36,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 271798272 13:21:36 INFO - 2015-11-18 13:21:36,207 DEBUG : BROWSER_OUTPUT: 13:21:36 INFO - 2015-11-18 13:21:36,207 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:21:36 INFO - 2015-11-18 13:21:36,207 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:21:36 INFO - 2015-11-18 13:21:36,207 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:21:36 INFO - 2015-11-18 13:21:36,208 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:21:36 INFO - 2015-11-18 13:21:36,208 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3289.963661446644;3315.668433156685;3375.6118046424663;3419.2819507903323;3463.5670541182353;5665.178549110382;5666.546676265899;5698.458646428583;5740.225069615601;5744.109663002241;5573.219749235111;5690.7723691052415;5703.942960570393;5736.282964629421;5754.16564598133;5170.914108037307;5204.817831375903;5269.262303277545;5273.393559740622;5284.894302113956;5027.09512287788;5171.043356978952;5262.158054711247;5272.182811664198;5353.946460535384;5073.822416215415;5163.535281824635;5181.740912954356;5220.686758794484;5231.084560201987;4239.342901850218;5231.973840130813;5250.396204436501;5264.947350526522;5295.364556253275;4538.863834084949;4984.053029924339;5116.488351164891;5199.6360254782185;5207.3490813648295;4400.339949007643;5178.705323669083;5520;5528.55771538276;5576.888462230773;6233.532485063638;6252.343503932113;6264.59280146789;6280.340564240781;6284.5600807943465;6055.636661800262;6157.63054216744;6288.434040936292;6309.684515774239;6345.524085693592;5786.07422812348;5908.586398952032;5925.851853703692;5927.2590926134235;5978.611390259619;6308.968455157695;6320.810375688737;6342.39747224013;6362.172917520693;6382.234131904202;5949.583529152917;6056.818295451144;6126.050462178369;6184.907226391608;6187.443130118221;5268.841934741964;6157.9384206158265;6187.535934804908;6221.688915554204;6240.188775459162;6223.066540018943;6241.937580624226;6251.781187658501;6257.061440783918;6284.622922624657;5657.8019769307875;6108.736706092798;6131.202943617391;6139.171211886338;6264.467520260738;4827.324174615556;4901.754912254373;4918.729469879119;4924.556789888928;4954.1082605130705;4482.8206871725415;4492.303692927601;4500.549945005539;4514.300283456069;4545.36364908913;5475.09660905946;5567.359753628303;5779.711014449261;5885.823425297248;5901.203337549376;6199.039148931923;6268;6290.968545157337;6293.118963345135;6302.684865756693;5815.79644712433;5818.44724751148;5826.184334193216;5829.09649004405;5842.620229685057;5196.818111366084;5306.62853600252;5338.786448542092;5435.374931882805;5441.319835020622;6218.968905155445;6228.28374736902;6237.563370564108;6258.593191442633;6279.591826531261;6118.632882027093;6127.050307202391;6127.509799215963;6147.815565533041;6148.077788331786;6179.6292222465;6202.844928876814;6303.716332764945;6306.779262725782;6318.589291696025;6188.381161883775;6197.03945888388;6259.280182779039;6264.123022776906;6267.905981410191;6086.6652334122045;6314.936850631619;6327.3988971047675;6328.493720502257;6330.240371155491;5650.491455769001;5954.285485741739;6039.033754599243;6057.121717350871;6062.7271772769445;5067.847964561069;6099.237595300588;6103.6032657877095;6118.755249789959;6126.417990290915;5583.274174357308;5688.175214593944;5950.285965684146;5978.252718410199;5986.850328741816;5664.85837854057;5918.2898052234;5959.91060134107;5985.670788106696;6057.848553786014;5050.419201791841;5338.798770276657;5568.443155684561;5897.292324921037;6009.128676341993 13:21:36 INFO - 2015-11-18 13:21:36,209 DEBUG : BROWSER_OUTPUT: |1;ext.html;551.8399664097409;555.1299780136693;582.243083990812;587.888301222768;620.8882401167789;40375.39436908442;40391.59608403915;40526.59473405265;40529.18941621166;40608.39087413691;44155.77922110393;44246.89382765433;44346.33480497787;44577;44663;9819.509024548797;9934.602615895355;10012.749681257954;10026.548805303779;10053.195744340435;9779.070988256104;9903.752406189831;9949.701508954742;9954.402735835873;9964.20286377088;8514.446560973547;9820.803583928317;9877.555510002032;9908.90091099087;9933.701988940344;8328.500289982621;9766.658166964122;9774.218062554979;9820.459874706889;9840.409575425461;9713.90286097137;9803.019698030212;9820.558074886647;9837.114659680663;9875.555599998017;41064.58935410638;41103.383449248286;41185.79407102945;41472.170556589;41640;3183.522471629251;3211.8072915624903;3245.480723084319;3474.739394545419;3549.769264997767;28862.278443038882;28933.383327084113;28973.855130724423;29307.41385172306;29613.259668508243;2600.2329312852753;2605.5831067029185;2619.724928882478;2695.1375559820867;2735.548634475309;510992;511105;513159;514945;515985;58367;59404.10893836596;62602.686986565684;62823.6858815703;67997.66001170062;66958.33041669521;67044.32955670479;67090.66454667696;67216;67333.663331684;16381.0171389717;16461.83538164627;16500.587485312724;16525.33898644065;16557;10991.890081099247;11128.610498632508;11849.170558061025;11862;12401.25592464455;16529.834701652828;18487.52099832037;18519.72220416695;20304.79695203029;20412.285570005275;7842.647080881374;8791.824163516821;9075.500847453453;9152.679656212;9267.304952128483;919.3380765848711;1068.7007637861411;1072.8015317166348;1086.0451187861818;1106.7841770854607;25996.35009124787;30114.945976890704;30408.54387184194;30478.695213048028;30498.085057448312;1003.062136901999;1079.6760971708457;1163.2438914705508;1196.1865931166717;1201.129181343519;12894.161879477804;15329.9233503834;15375;15551.377944882304;15598.376064957274;573269;575858;576516;585140;585311;58919.70540147272;58935;59587;59750.70124649349;59828.10257846136;1447.6815100677834;1470.1473145575326;1478.8447213042691;1485.7474229381032;1611.7824093747195;30089.699103009567;30117.548236776904;30327.19713777472;30332.69667303387;30611.846940765154;51198.48801512086;51373.22940155826;51571.22643160281;51637.483625163266;51699.74150129225;516411;525891;526845;530563.4718263994;534035;33556.664433355356;34422.82788586041;34445;34595.48106778451;34627;43474.78262608793;43691.126177475635;43714.34428483512;44030.11939761251;44081.77959110184;37276.62723372732;38023;38102;38378.0405489865;38510.6148938507;36818.63181368152;37044.44433333556;37667.62332376641;37794.81102594469;38063.80968095142;36551.45172822463;37138;37419.251614968096;37487.62512374841;37534.6246537542;25825;27971.021014264403;32377.838110809294;33119.840805571686;34284.31431371409;24950.37624059413;24962.126325578516;25049.373765656004;25270.873645631655;25397.746022539537 13:21:36 INFO - 2015-11-18 13:21:36,210 DEBUG : BROWSER_OUTPUT: |2;jquery.html;306.9263376789568;328.29744347097215;329.7098553273119;358.41041486754284;360.0674253682961;15563.68872622547;18024.729629055575;19420;20090.296839610597;21597.46006349842;12477.875221247807;12718.23690578566;12759.872401275985;12804.23174609524;21168.4707882303;4639.884002899921;4843.418789745236;4858.587020103296;4860.198067318888;4860.441049279343;4806.158922188621;5000.97499512502;5073.492650734934;5151.124308867483;5177.559907407875;4972.328735620681;5070.1380765269805;5093.2105523643895;5095.566876815476;5245.344331958505;5131.179011358184;5160.458151894053;5161.793528258865;5188.06614809336;5189.558887494568;4365.083332500179;4366.235908715994;4370.10412865365;4380.299152135675;4393.046258367494;14137.646558836112;14236.288185590782;14307.856921430757;14372.197421502811;14391.712165756626;1907.7710674718983;1919.491334796266;1968.1733671857853;1999.3801921404265;2091.1530830013867;10235.385876847338;10258.281920265585;10318.38089714612;10540.156787457061;10667;1527.9083255004625;1631.3963833381606;1663.808662003873;1689.7380905959596;1725.4219836354837;73942;88173;93474;94233.64415889588;94280.52859735726;6858.5199036067;6862.073620061327;6925.930740692528;6930;6941;7640.197779233101;7849.843003140019;7866.72466463671;7897.802554936057;7925.682972681144;5243.8164664236565;5700.287464066992;5752.6836024019085;5780.855478613068;5866.178734977107;5184.766685499161;6224.06639004153;6244.625322480666;6245.469135123474;6279.434850863444;3049.6645369009393;3056.449839028996;3064.8007879487764;3083.8458077096057;3106.363195544953;1101.9724506887392;1118.2340097033557;1125.7973564758422;1127.0870594818223;1180.1267062373954;396.942443345719;398.89429301235197;429.8538496911065;468.6602213395261;475.0380479528981;11333.829992550118;11365.431728413547;11452.656420307405;11665.00847427978;11787.292762434281;423.92581298272677;438.21340693455323;445.64571165923167;446.32827594470115;450.4482009538355;5969.791057312973;5980.760769569256;6032.668203248776;6076.8784624308155;6090.543209259235;754143;757154;768154;775415;776004;112154.43922780333;112220;112734;114630;114928;394.9861754838567;474.89077512172395;477.29122253453596;478.41155378883474;479.3385128522686;10836.837447438453;10859.2398532102;10930.45347732626;10979.39613321275;10987.450627468435;39925;49842.75393115201;50931.745341273054;51058.48941510686;51684;65262.673686631264;66686;71811.64094179496;72250;73263;6434.903476447951;6501.772437964649;6510.121133646897;6511.300275810053;6573.737050517926;10619.415932123808;10921.962413570698;11961.700957476132;12532.686682832637;12614.49542018309;10696.679099627023;11004.724881878017;11024;11109.055730263019;11127.777444451227;10616.681499555025;10728.432493993254;10771.19216058783;10791.97476239756;11103.611373602209;9561.665341713007;11128.888711112786;11184.720381990515;11384.772304554028;11398.658040258806;6449.645269510034;6460.838479037873;6543.312952139957;6569.047488114292;6574.671266436755;10692.518836652214;10862.619808306672;11059.50232239535;11117.44412779374;11143.554257829595 13:21:36 INFO - 2015-11-18 13:21:36,213 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1392.909460885043;1538.5922730476425;1813.7370081338215;1822.1162736073002;1852.4257480181145;7375.336219740222;7464.477486575942;8055.556944368065;8178.550179740119;8234.341252699793;7731;7930.881036784438;8003.719869804558;8042.7185048523315;8066.556339401331;2314.652802079689;2316.455632926261;2334.1363695432715;2336.976630233693;2345.2612427085414;2184.3119417383473;2330.0563271874835;2357.375295546673;2384.141708984773;2401.7838394544488;2323.2449453927456;2347.542229265294;2350.2126787526113;2355.646653002046;2371.3952941999764;2307.60770668985;2310.838241323108;2324.3143272734414;2337.9298621041394;2340.9063637454483;1989.8607097503182;2345.624700048001;2366.3137690069857;2376.33462630462;2380.2502211803226;8060;8081.797955051112;8125.918740812575;8171.142030086815;8195.590220488952;5040.117979353635;5112.565431938289;5138;5138.177891537373;5173.793048278064;3435.639257877937;3463.8787642432394;3511.0695665648623;3542.4509201073615;3554.893353199408;1050.3907733514543;1051.647698021164;1077.450500244873;1086.1745073743932;1086.2721976275914;10435.269531132824;10469;10621;10637.627683031134;10702.892971070345;3896.5518965318784;4314.89212769677;4628.328892310664;4650.116477869194;4656.092062047868;9309.906900930904;9319.207867331354;9342.486163261086;9343;9343.532823358804;5116.437191908887;5159.406668233126;5166.199239117943;5179.870503237449;5183.5593974512585;4176.206520761046;4228.4080228768;4527.501974782771;4613.653975951817;4699.248120300804;3216.790908590934;3806.5241844769403;3891.9610803892165;3894.337962546374;3894.5910679378826;1137.0789660375124;1152.4468255237532;1219.8475190601175;1256.855461621907;1267.8288431061874;1317.9934100329438;1319.1755153029358;1331.3077199856214;1372.6499742565782;1383.9723205536034;6695.263521012685;7538;7568.810779730551;7870.449068565145;7934.722284720007;1197.5150064224003;1201.5133870782347;1208.2689972566645;1210.425048102162;1232.5193174661888;5982.162497250389;6128.63228206309;6139.631622102688;6143.877122457526;6180.845478862974;9597.23222142227;9750.317477776487;9768;9789.314747967715;9812.950935245279;9334.206592439583;9631.759206019766;9641.566129524188;9678.70963871085;9693.127618514367;7589.279018493235;7718.035245594301;7723.459357845009;7748.3026527611655;7776.7278145264645;7335.889961650686;7364.153122390993;7379.852402951804;7393.445491588045;7403.666834992546;8544;8607.65569377218;8665.393422460367;8721;8755.474671519729;8834.072422395557;8916.33127515452;8951.820963580822;8966;9113.544322783702;5289.550388217045;6439.3238709934785;6632.701528431328;6712.664366781543;6773.525853190229;7553.357964572853;7748.147703752696;7783.727569535039;7793.844123117619;7815.765527034198;7088.574685518885;7176.533525320838;7213.3868621167785;7354.558726476428;7366.7053317866685;6228.781992630236;7064;7181.533200341961;7223.711051557879;7268.636568171676;7130.607816570138;7163.7492687755675;7297.927020729725;7310.232425595236;7369.37360324357;5736.569757268305;6039.939600604113;6141.232345956755;6697.3302669734585;6735.090762746966;6697.698603562754;6793.762218322533;6804.4216241620015;6806.251312355538;6806.489513286622 13:21:36 INFO - 2015-11-18 13:21:36,215 DEBUG : BROWSER_OUTPUT: |4;prototype.html;322.26041235364835;327.76728522748846;328.7485073918453;333.81640097946126;334.4114358728638;6994.712485131992;7055.929440705591;7078.2921707829255;7133.89299160513;7230.96384518078;5788.842231553685;6765.729370825174;7074.398676112537;7091.14906211254;7114.608696521702;5134.306868572751;5134.845954621367;5143.382794064699;5166.121759300928;5187.662801917863;5003.799848006075;5117.513836185556;5132.97433512832;5157.8452646420665;5166.354205724285;3654.579723331811;4751.643626727992;4805.807767689288;5087.643864929457;5094.898102037957;5079.466656001104;5080.187170052793;5084.034033533635;5100.183970564711;5127.769250383742;4197.622214000724;4284.614384705392;4309.5690430956965;4310.719803212781;4319.82720691172;6724.7646332378135;6729.158855143107;6748.190217173921;6753.122094127781;6811.659417029129;5928.7332070056955;5930.851728706817;5936.406359364072;5937.198478205473;5950.137230101611;7246.3840573551315;7457.9186018027085;7459.589722565257;7462.7014919403155;7472.065991751031;4754.881127971794;4758.833440829554;4761.381130415641;4764.2615394613895;4770.427548694144;7846.725364612211;7956.403269754792;7976.322012628933;7985.361171106298;8010.839783204362;4703.223968045234;4812.470628230892;4839.806407743651;4841.273808928689;4843.297721830315;4907.9263811042865;4911.361523001987;4935.481774413634;4955.554000140005;4966.975165124223;5281.0758117329315;5873.119032145127;5983;5984.072468767348;5996.220491336186;7269.382102521345;7536.133344665324;7556.773296801105;7558.168601453835;7584;1702.2254874032533;1714.1686282153146;1716.519374575121;1717.7079896417638;1719.5271300392492;1078.7680648660576;1083.8265877459726;1093.9015488605905;1101.9614313499148;1103.475848971732;5805.593608447452;7126.394256488256;7131.679074441663;7135.036770036082;7138.321859423347;7878.448508604342;7886.408519360956;7893.763187104396;7898.723544675909;7926.920730792618;5735.397783232784;6466.741330346827;6916.619585922823;7097.290270972965;7127.073480447509;3593.3531964246163;3736.1220113273903;3875.3218186817194;4119.279126152911;4151.377293406013;7538.924610753932;8195.71315003972;8235.588220589067;8241.175882411711;8278.668853245923;7208.495405321577;7554.508956917783;7932.920670793334;8187.426880118334;8194.385421093442;8182.263596276244;8195.262426381654;8201.466904651179;8204.958975205085;8207.220314070153;5594.328680558359;7113.146422429135;7881.605919704107;7901.525908445512;7979.760607181794;6208.751649933952;6248;7473.327400533978;7714.421418393531;7744.883826742491;8048.597570121354;8186.304164146114;8227.341812654853;8231.835363292581;8240;4775.403074615673;4856.39295088114;4864.489228631084;4868.780904859219;4882.584980276716;7627.809304767426;7840.490368126054;7865.252800983897;7879.290863822283;7920.128785833438;7525.473216874985;7539.434542409232;7547.528231994708;7554.244575542401;7565.205653406313;7341.74303899361;7494.400447964259;7495.437842161969;7502.474826762293;7513.023306970277;7324.560526368435;7332.560046397233;7335.339819416278;7339.266073392618;7365.926340736738;6457.096006558992;6732.192136943598;6853.760118395832;7131.358177763818;7546.509476883985;5953.28560572734;7238.167610724834;7370.262973702587;7373.9262607375385;7383.1173050871685 13:21:36 INFO - 2015-11-18 13:21:36,216 DEBUG : BROWSER_OUTPUT: |5;yui.html;692.8775383878118;753.3859904178095;792.4017366887998;823.3660081737063;827.0241115483728;13756.624337566263;15257.465988690397;15303.770443443329;15651.765223521628;15662.060276383425;13331.800022999638;13997.39030011549;14299.428022879098;14599.708005839877;14954.252287385641;875.3784812782916;947.9052094790535;977.2475194100539;978.3445091788519;982.062130665213;961.6153538584587;964.6768332608584;971.218169373654;983.955721992512;985.374287327545;1010.6361709784471;1013.9391636501797;1023.687775228555;1032.0711359776187;1034.4672493665769;997.4514017290497;1008.5058321422523;1013.5793645637052;1014.0771897573173;1024.462157367388;734.4931996922106;739.4897520710692;741.6662501874179;754.4002517998205;755.527795128045;13770.449182032708;13979.860201397958;14092.647683807987;14094.718105637932;14153.716925661429;11268.323900565993;11432.599859004895;11587.537536039556;11706.063514918786;12706.809397859039;10087.546060427298;10247.231457640706;10373.636922707668;10571.894281057244;11101.1674124441;3519.454484554898;3521.7886926784477;3563.518924945125;3576.445650924085;3609.4946707460977;64849.730259440694;72379.27620723778;73012;77583.61208193979;81459.59270203671;9659.034096590425;9802.215822734164;10003.79992400148;10026.448545329931;10172.338797978107;18134.90932545329;22887.542249155256;23085.653715194287;23154.42113947131;23167;7388.224236455095;7635.045619297588;7682.884756728654;7726.806829829299;7746.845063098706;3118.6725393833776;4029.6776257899296;4085.611866872642;4232.343986682069;4236.555161708038;3462.4979377990553;3484.26830365621;3491.546099007113;3519.8768043118366;3524.1542029912634;541.7101850509958;556.0630337880684;565.9434056594307;566.5552541255095;568.5934556791914;488.2310361181154;501.23561568608164;547.8602956246211;551.5973339462134;564.7176411794103;8020.518768873886;8705.912940870638;8732.738017859474;8791.032986371494;8936.910630893737;548.6324162810927;578.3551340255585;614.8001899382718;619.5693992675048;620.320748780094;3973.145773658677;4209.957900421018;4356.259435895905;4392.648588112943;4432.955670443319;64731.352686472535;72813;85805;87034.69447958286;87307;78348.21651783523;78706.21293787104;79193.60403197947;79403;81513.59243203746;75986;76979;78124.04689882799;78721;78867.60566197247;8812.148537171553;8995.865062024206;9030.954845225731;9033.50315732641;9116.680916167903;55053.72473137609;55436.72281638566;56353;57243.568910775895;57318.426815731305;68393.9740903877;68500;68906;71766.28233717596;72400;7997.7600671979935;8009.439339246197;8165.918340816515;8192.385571082312;8298.543580103153;12143.635690929286;12361.62915112548;12370.072244581512;12454.626361209179;12757.425915833624;9429.434233945985;11960.58137965167;11983.221090629082;11985.981191598812;12134.271943683054;11921.344326061802;12017.339046352534;12036.097292702907;12091.818622720843;12138.75722485563;11750.70623234426;11791.646250612495;11817.995470385114;11831.46758395857;11987.160898737005;9661.661841835503;9674;9793.363431376938;9798.608055677978;9804.509774511103;9570.712878613653;9989.001099889952;10050.69847904564;10136.391816491034;10164.682846910244 13:21:36 INFO - 2015-11-18 13:21:36,216 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:21:36 INFO - 2015-11-18 13:21:36,216 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:21:36 INFO - 2015-11-18 13:21:36,216 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,326 13:21:36 INFO - 2015-11-18 13:21:36,217 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:21:36 INFO - 2015-11-18 13:21:36,217 DEBUG : BROWSER_OUTPUT: __startTimestamp1447881696203__endTimestamp 13:21:36 INFO - 2015-11-18 13:21:36,217 DEBUG : BROWSER_OUTPUT: 13:21:36 INFO - 2015-11-18 13:21:36,217 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:21:36 INFO - 2015-11-18 13:21:36,217 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:21:36 INFO - 2015-11-18 13:21:36,217 DEBUG : BROWSER_OUTPUT: 13:21:36 INFO - 2015-11-18 13:21:36,217 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5690.59 Median:5908.59 stddev:658.08 (11.1%) stddev-sans-first:632.58 13:21:36 INFO - 2015-11-18 13:21:36,218 DEBUG : BROWSER_OUTPUT: Values: 3290.0 3315.7 3375.6 3419.3 3463.6 5665.2 5666.5 5698.5 5740.2 5744.1 5573.2 5690.8 5703.9 5736.3 5754.2 5170.9 5204.8 5269.3 5273.4 5284.9 5027.1 5171.0 5262.2 5272.2 5353.9 5073.8 5163.5 5181.7 5220.7 5231.1 4239.3 5232.0 5250.4 5264.9 5295.4 4538.9 4984.1 5116.5 5199.6 5207.3 4400.3 5178.7 5520.0 5528.6 5576.9 6233.5 6252.3 6264.6 6280.3 6284.6 6055.6 6157.6 6288.4 6309.7 6345.5 5786.1 5908.6 5925.9 5927.3 5978.6 6309.0 6320.8 6342.4 6362.2 6382.2 5949.6 6056.8 6126.1 6184.9 6187.4 5268.8 6157.9 6187.5 6221.7 6240.2 6223.1 6241.9 6251.8 6257.1 6284.6 5657.8 6108.7 6131.2 6139.2 6264.5 4827.3 4901.8 4918.7 4924.6 4954.1 4482.8 4492.3 4500.5 4514.3 4545.4 5475.1 5567.4 5779.7 5885.8 5901.2 6199.0 6268.0 6291.0 6293.1 6302.7 5815.8 5818.4 5826.2 5829.1 5842.6 5196.8 5306.6 5338.8 5435.4 5441.3 6219.0 6228.3 6237.6 6258.6 6279.6 6118.6 6127.1 6127.5 6147.8 6148.1 6179.6 6202.8 6303.7 6306.8 6318.6 6188.4 6197.0 6259.3 6264.1 6267.9 6086.7 6314.9 6327.4 6328.5 6330.2 5650.5 5954.3 6039.0 6057.1 6062.7 5067.8 6099.2 6103.6 6118.8 6126.4 5583.3 5688.2 5950.3 5978.3 5986.9 5664.9 5918.3 5959.9 5985.7 6057.8 5050.4 5338.8 5568.4 5897.3 6009.1 13:21:36 INFO - 2015-11-18 13:21:36,219 DEBUG : BROWSER_OUTPUT: 13:21:36 INFO - 2015-11-18 13:21:36,219 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:68086.72 Median:38444.33 stddev:144020.94 (374.6%) stddev-sans-first:144335.70 13:21:36 INFO - 2015-11-18 13:21:36,220 DEBUG : BROWSER_OUTPUT: Values: 551.8 555.1 582.2 587.9 620.9 40375.4 40391.6 40526.6 40529.2 40608.4 44155.8 44246.9 44346.3 44577.0 44663.0 9819.5 9934.6 10012.7 10026.5 10053.2 9779.1 9903.8 9949.7 9954.4 9964.2 8514.4 9820.8 9877.6 9908.9 9933.7 8328.5 9766.7 9774.2 9820.5 9840.4 9713.9 9803.0 9820.6 9837.1 9875.6 41064.6 41103.4 41185.8 41472.2 41640.0 3183.5 3211.8 3245.5 3474.7 3549.8 28862.3 28933.4 28973.9 29307.4 29613.3 2600.2 2605.6 2619.7 2695.1 2735.5 510992.0 511105.0 513159.0 514945.0 515985.0 58367.0 59404.1 62602.7 62823.7 67997.7 66958.3 67044.3 67090.7 67216.0 67333.7 16381.0 16461.8 16500.6 16525.3 16557.0 10991.9 11128.6 11849.2 11862.0 12401.3 16529.8 18487.5 18519.7 20304.8 20412.3 7842.6 8791.8 9075.5 9152.7 9267.3 919.3 1068.7 1072.8 1086.0 1106.8 25996.4 30114.9 30408.5 30478.7 30498.1 1003.1 1079.7 1163.2 1196.2 1201.1 12894.2 15329.9 15375.0 15551.4 15598.4 573269.0 575858.0 576516.0 585140.0 585311.0 58919.7 58935.0 59587.0 59750.7 59828.1 1447.7 1470.1 1478.8 1485.7 1611.8 30089.7 30117.5 30327.2 30332.7 30611.8 51198.5 51373.2 51571.2 51637.5 51699.7 516411.0 525891.0 526845.0 530563.5 534035.0 33556.7 34422.8 34445.0 34595.5 34627.0 43474.8 43691.1 43714.3 44030.1 44081.8 37276.6 38023.0 38102.0 38378.0 38510.6 36818.6 37044.4 37667.6 37794.8 38063.8 36551.5 37138.0 37419.3 37487.6 37534.6 25825.0 27971.0 32377.8 33119.8 34284.3 24950.4 24962.1 25049.4 25270.9 25397.7 13:21:36 INFO - 2015-11-18 13:21:36,221 DEBUG : BROWSER_OUTPUT: 13:21:36 INFO - 2015-11-18 13:21:36,221 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:36173.64 Median:4365.66 stddev:126211.80 (2891.0%) stddev-sans-first:126537.12 13:21:36 INFO - 2015-11-18 13:21:36,221 DEBUG : BROWSER_OUTPUT: Values: 306.9 328.3 329.7 358.4 360.1 15563.7 18024.7 19420.0 20090.3 21597.5 12477.9 12718.2 12759.9 12804.2 21168.5 4639.9 4843.4 4858.6 4860.2 4860.4 4806.2 5001.0 5073.5 5151.1 5177.6 4972.3 5070.1 5093.2 5095.6 5245.3 5131.2 5160.5 5161.8 5188.1 5189.6 4365.1 4366.2 4370.1 4380.3 4393.0 14137.6 14236.3 14307.9 14372.2 14391.7 1907.8 1919.5 1968.2 1999.4 2091.2 10235.4 10258.3 10318.4 10540.2 10667.0 1527.9 1631.4 1663.8 1689.7 1725.4 73942.0 88173.0 93474.0 94233.6 94280.5 6858.5 6862.1 6925.9 6930.0 6941.0 7640.2 7849.8 7866.7 7897.8 7925.7 5243.8 5700.3 5752.7 5780.9 5866.2 5184.8 6224.1 6244.6 6245.5 6279.4 3049.7 3056.4 3064.8 3083.8 3106.4 1102.0 1118.2 1125.8 1127.1 1180.1 396.9 398.9 429.9 468.7 475.0 11333.8 11365.4 11452.7 11665.0 11787.3 423.9 438.2 445.6 446.3 450.4 5969.8 5980.8 6032.7 6076.9 6090.5 754143.0 757154.0 768154.0 775415.0 776004.0 112154.4 112220.0 112734.0 114630.0 114928.0 395.0 474.9 477.3 478.4 479.3 10836.8 10859.2 10930.5 10979.4 10987.5 39925.0 49842.8 50931.7 51058.5 51684.0 65262.7 66686.0 71811.6 72250.0 73263.0 6434.9 6501.8 6510.1 6511.3 6573.7 10619.4 10922.0 11961.7 12532.7 12614.5 10696.7 11004.7 11024.0 11109.1 11127.8 10616.7 10728.4 10771.2 10792.0 11103.6 9561.7 11128.9 11184.7 11384.8 11398.7 6449.6 6460.8 6543.3 6569.0 6574.7 10692.5 10862.6 11059.5 11117.4 11143.6 13:21:36 INFO - 2015-11-18 13:21:36,221 DEBUG : BROWSER_OUTPUT: 13:21:36 INFO - 2015-11-18 13:21:36,221 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5631.08 Median:6140.43 stddev:2864.80 (46.7%) stddev-sans-first:2855.12 13:21:36 INFO - 2015-11-18 13:21:36,223 DEBUG : BROWSER_OUTPUT: Values: 1392.9 1538.6 1813.7 1822.1 1852.4 7375.3 7464.5 8055.6 8178.6 8234.3 7731.0 7930.9 8003.7 8042.7 8066.6 2314.7 2316.5 2334.1 2337.0 2345.3 2184.3 2330.1 2357.4 2384.1 2401.8 2323.2 2347.5 2350.2 2355.6 2371.4 2307.6 2310.8 2324.3 2337.9 2340.9 1989.9 2345.6 2366.3 2376.3 2380.3 8060.0 8081.8 8125.9 8171.1 8195.6 5040.1 5112.6 5138.0 5138.2 5173.8 3435.6 3463.9 3511.1 3542.5 3554.9 1050.4 1051.6 1077.5 1086.2 1086.3 10435.3 10469.0 10621.0 10637.6 10702.9 3896.6 4314.9 4628.3 4650.1 4656.1 9309.9 9319.2 9342.5 9343.0 9343.5 5116.4 5159.4 5166.2 5179.9 5183.6 4176.2 4228.4 4527.5 4613.7 4699.2 3216.8 3806.5 3892.0 3894.3 3894.6 1137.1 1152.4 1219.8 1256.9 1267.8 1318.0 1319.2 1331.3 1372.6 1384.0 6695.3 7538.0 7568.8 7870.4 7934.7 1197.5 1201.5 1208.3 1210.4 1232.5 5982.2 6128.6 6139.6 6143.9 6180.8 9597.2 9750.3 9768.0 9789.3 9813.0 9334.2 9631.8 9641.6 9678.7 9693.1 7589.3 7718.0 7723.5 7748.3 7776.7 7335.9 7364.2 7379.9 7393.4 7403.7 8544.0 8607.7 8665.4 8721.0 8755.5 8834.1 8916.3 8951.8 8966.0 9113.5 5289.6 6439.3 6632.7 6712.7 6773.5 7553.4 7748.1 7783.7 7793.8 7815.8 7088.6 7176.5 7213.4 7354.6 7366.7 6228.8 7064.0 7181.5 7223.7 7268.6 7130.6 7163.7 7297.9 7310.2 7369.4 5736.6 6039.9 6141.2 6697.3 6735.1 6697.7 6793.8 6804.4 6806.3 6806.5 13:21:36 INFO - 2015-11-18 13:21:36,223 DEBUG : BROWSER_OUTPUT: 13:21:36 INFO - 2015-11-18 13:21:36,223 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6062.80 Median:6832.71 stddev:1989.64 (29.1%) stddev-sans-first:1948.01 13:21:36 INFO - 2015-11-18 13:21:36,224 DEBUG : BROWSER_OUTPUT: Values: 322.3 327.8 328.7 333.8 334.4 6994.7 7055.9 7078.3 7133.9 7231.0 5788.8 6765.7 7074.4 7091.1 7114.6 5134.3 5134.8 5143.4 5166.1 5187.7 5003.8 5117.5 5133.0 5157.8 5166.4 3654.6 4751.6 4805.8 5087.6 5094.9 5079.5 5080.2 5084.0 5100.2 5127.8 4197.6 4284.6 4309.6 4310.7 4319.8 6724.8 6729.2 6748.2 6753.1 6811.7 5928.7 5930.9 5936.4 5937.2 5950.1 7246.4 7457.9 7459.6 7462.7 7472.1 4754.9 4758.8 4761.4 4764.3 4770.4 7846.7 7956.4 7976.3 7985.4 8010.8 4703.2 4812.5 4839.8 4841.3 4843.3 4907.9 4911.4 4935.5 4955.6 4967.0 5281.1 5873.1 5983.0 5984.1 5996.2 7269.4 7536.1 7556.8 7558.2 7584.0 1702.2 1714.2 1716.5 1717.7 1719.5 1078.8 1083.8 1093.9 1102.0 1103.5 5805.6 7126.4 7131.7 7135.0 7138.3 7878.4 7886.4 7893.8 7898.7 7926.9 5735.4 6466.7 6916.6 7097.3 7127.1 3593.4 3736.1 3875.3 4119.3 4151.4 7538.9 8195.7 8235.6 8241.2 8278.7 7208.5 7554.5 7932.9 8187.4 8194.4 8182.3 8195.3 8201.5 8205.0 8207.2 5594.3 7113.1 7881.6 7901.5 7979.8 6208.8 6248.0 7473.3 7714.4 7744.9 8048.6 8186.3 8227.3 8231.8 8240.0 4775.4 4856.4 4864.5 4868.8 4882.6 7627.8 7840.5 7865.3 7879.3 7920.1 7525.5 7539.4 7547.5 7554.2 7565.2 7341.7 7494.4 7495.4 7502.5 7513.0 7324.6 7332.6 7335.3 7339.3 7365.9 6457.1 6732.2 6853.8 7131.4 7546.5 5953.3 7238.2 7370.3 7373.9 7383.1 13:21:36 INFO - 2015-11-18 13:21:36,224 DEBUG : BROWSER_OUTPUT: 13:21:36 INFO - 2015-11-18 13:21:36,225 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18272.72 Median:27994.16 stddev:25281.13 (90.3%) stddev-sans-first:25317.59 13:21:36 INFO - 2015-11-18 13:21:36,225 DEBUG : BROWSER_OUTPUT: Values: 692.9 753.4 792.4 823.4 827.0 13756.6 15257.5 15303.8 15651.8 15662.1 13331.8 13997.4 14299.4 14599.7 14954.3 875.4 947.9 977.2 978.3 982.1 961.6 964.7 971.2 984.0 985.4 1010.6 1013.9 1023.7 1032.1 1034.5 997.5 1008.5 1013.6 1014.1 1024.5 734.5 739.5 741.7 754.4 755.5 13770.4 13979.9 14092.6 14094.7 14153.7 11268.3 11432.6 11587.5 11706.1 12706.8 10087.5 10247.2 10373.6 10571.9 11101.2 3519.5 3521.8 3563.5 3576.4 3609.5 64849.7 72379.3 73012.0 77583.6 81459.6 9659.0 9802.2 10003.8 10026.4 10172.3 18134.9 22887.5 23085.7 23154.4 23167.0 7388.2 7635.0 7682.9 7726.8 7746.8 3118.7 4029.7 4085.6 4232.3 4236.6 3462.5 3484.3 3491.5 3519.9 3524.2 541.7 556.1 565.9 566.6 568.6 488.2 501.2 547.9 551.6 564.7 8020.5 8705.9 8732.7 8791.0 8936.9 548.6 578.4 614.8 619.6 620.3 3973.1 4210.0 4356.3 4392.6 4433.0 64731.4 72813.0 85805.0 87034.7 87307.0 78348.2 78706.2 79193.6 79403.0 81513.6 75986.0 76979.0 78124.0 78721.0 78867.6 8812.1 8995.9 9031.0 9033.5 9116.7 55053.7 55436.7 56353.0 57243.6 57318.4 68394.0 68500.0 68906.0 71766.3 72400.0 7997.8 8009.4 8165.9 8192.4 8298.5 12143.6 12361.6 12370.1 12454.6 12757.4 9429.4 11960.6 11983.2 11986.0 12134.3 11921.3 12017.3 12036.1 12091.8 12138.8 11750.7 11791.6 11818.0 11831.5 11987.2 9661.7 9674.0 9793.4 9798.6 9804.5 9570.7 9989.0 10050.7 10136.4 10164.7 13:21:36 INFO - 2015-11-18 13:21:36,225 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:21:36 INFO - 2015-11-18 13:21:36,225 DEBUG : BROWSER_OUTPUT: 13:21:36 INFO - 2015-11-18 13:21:36,607 INFO : Browser exited with error code: 0 13:21:36 INFO - 2015-11-18 13:21:36,631 INFO : Completed test dromaeo_css (00:18:29) 13:21:36 INFO - 2015-11-18 13:21:36,631 INFO : Starting test kraken 13:21:36 INFO - 2015-11-18 13:21:36,631 DEBUG : operating with platform_type : mac_ 13:21:36 INFO - 2015-11-18 13:21:36,632 INFO : Initialising browser for kraken test... 13:21:36 INFO - 2015-11-18 13:21:36,644 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpCLCNni/profile http://localhost:53281/getInfo.html 13:21:39 INFO - 2015-11-18 13:21:39,243 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:21:39 INFO - 2015-11-18 13:21:39,243 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:21:39 INFO - 2015-11-18 13:21:39,243 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:21:39 INFO - 2015-11-18 13:21:39,243 DEBUG : BROWSER_OUTPUT: __metrics 13:21:39 INFO - 2015-11-18 13:21:39,901 INFO : Browser initialized. 13:21:39 INFO - 2015-11-18 13:21:39,902 INFO : Running cycle 1/1 for kraken test... 13:21:39 INFO - 2015-11-18 13:21:39,902 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpCLCNni/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:21:51 INFO - 2015-11-18 13:21:51,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 235745280 13:21:51 INFO - 2015-11-18 13:21:51,949 DEBUG : BROWSER_OUTPUT: 13:21:54 INFO - 2015-11-18 13:21:54,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53281/tests/kraken/driver.html?testName=audio-beat-detection) 13:21:55 INFO - 2015-11-18 13:21:55,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 250314752 13:21:55 INFO - 2015-11-18 13:21:55,094 DEBUG : BROWSER_OUTPUT: 13:21:57 INFO - 2015-11-18 13:21:57,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53281/tests/kraken/driver.html?testName=audio-dft) 13:21:58 INFO - 2015-11-18 13:21:58,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 258301952 13:21:58 INFO - 2015-11-18 13:21:58,365 DEBUG : BROWSER_OUTPUT: 13:22:01 INFO - 2015-11-18 13:22:01,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53281/tests/kraken/driver.html?testName=audio-fft) 13:22:02 INFO - 2015-11-18 13:22:02,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 260886528 13:22:02 INFO - 2015-11-18 13:22:02,243 DEBUG : BROWSER_OUTPUT: 13:22:04 INFO - 2015-11-18 13:22:04,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53281/tests/kraken/driver.html?testName=audio-oscillator) 13:22:04 INFO - 2015-11-18 13:22:04,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 262811648 13:22:04 INFO - 2015-11-18 13:22:04,843 DEBUG : BROWSER_OUTPUT: 13:22:06 INFO - 2015-11-18 13:22:06,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:22:07 INFO - 2015-11-18 13:22:07,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 263639040 13:22:07 INFO - 2015-11-18 13:22:07,389 DEBUG : BROWSER_OUTPUT: 13:22:10 INFO - 2015-11-18 13:22:10,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53281/tests/kraken/driver.html?testName=imaging-darkroom) 13:22:10 INFO - 2015-11-18 13:22:10,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 263487488 13:22:10 INFO - 2015-11-18 13:22:10,672 DEBUG : BROWSER_OUTPUT: 13:22:13 INFO - 2015-11-18 13:22:13,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53281/tests/kraken/driver.html?testName=imaging-desaturate) 13:22:14 INFO - 2015-11-18 13:22:14,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 264736768 13:22:14 INFO - 2015-11-18 13:22:14,063 DEBUG : BROWSER_OUTPUT: 13:22:16 INFO - 2015-11-18 13:22:16,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53281/tests/kraken/driver.html?testName=json-parse-financial) 13:22:17 INFO - 2015-11-18 13:22:17,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 262918144 13:22:17 INFO - 2015-11-18 13:22:17,439 DEBUG : BROWSER_OUTPUT: 13:22:19 INFO - 2015-11-18 13:22:19,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:22:19 INFO - 2015-11-18 13:22:19,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 264273920 13:22:19 INFO - 2015-11-18 13:22:19,628 DEBUG : BROWSER_OUTPUT: 13:22:21 INFO - 2015-11-18 13:22:21,418 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53281/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:22:22 INFO - 2015-11-18 13:22:22,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 264171520 13:22:22 INFO - 2015-11-18 13:22:22,063 DEBUG : BROWSER_OUTPUT: 13:22:24 INFO - 2015-11-18 13:22:24,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:22:24 INFO - 2015-11-18 13:22:24,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 264339456 13:22:24 INFO - 2015-11-18 13:22:24,676 DEBUG : BROWSER_OUTPUT: 13:22:27 INFO - 2015-11-18 13:22:27,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:22:27 INFO - 2015-11-18 13:22:27,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 263401472 13:22:27 INFO - 2015-11-18 13:22:27,843 DEBUG : BROWSER_OUTPUT: 13:22:30 INFO - 2015-11-18 13:22:30,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:22:30 INFO - 2015-11-18 13:22:30,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 263577600 13:22:30 INFO - 2015-11-18 13:22:30,815 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53281/tests/kraken/driver.html?testName=ai-astar) 13:22:32 INFO - 2015-11-18 13:22:32,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 264925184 13:22:32 INFO - 2015-11-18 13:22:32,697 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,697 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:22:32 INFO - 2015-11-18 13:22:32,697 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:22:32 INFO - 2015-11-18 13:22:32,697 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:22:32 INFO - 2015-11-18 13:22:32,698 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:22:32 INFO - 2015-11-18 13:22:32,698 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;106;117;113;116;128;115;113;115;115 13:22:32 INFO - 2015-11-18 13:22:32,698 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;123;147;157;119;165;149;153;188;151 13:22:32 INFO - 2015-11-18 13:22:32,698 DEBUG : BROWSER_OUTPUT: |2;audio-dft;197;273;194;196;209;221;198;199;205;196 13:22:32 INFO - 2015-11-18 13:22:32,698 DEBUG : BROWSER_OUTPUT: |3;audio-fft;61;66;55;62;57;63;124;55;59;50 13:22:32 INFO - 2015-11-18 13:22:32,698 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;79;77;110;76;75;81;113;75;77;113 13:22:32 INFO - 2015-11-18 13:22:32,698 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;87;88;87;87;87;103;118;88;78;90 13:22:32 INFO - 2015-11-18 13:22:32,698 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;101;95;95;95;96;107;95;96;96;95 13:22:32 INFO - 2015-11-18 13:22:32,698 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;90;93;93;112;94;90;90;111;91;92 13:22:32 INFO - 2015-11-18 13:22:32,698 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;60;59;61;70;85;89;67;52;52 13:22:32 INFO - 2015-11-18 13:22:32,698 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;65;65;65;66;70;70;71;71;73 13:22:32 INFO - 2015-11-18 13:22:32,698 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;83;82;83;82;83;81;81;84 13:22:32 INFO - 2015-11-18 13:22:32,698 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;136;133;133;111;123;125;164;111;115;135 13:22:32 INFO - 2015-11-18 13:22:32,699 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;140;141;136;138;127;140;136;142;128 13:22:32 INFO - 2015-11-18 13:22:32,699 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;67;66;69;66;66;68;66;68 13:22:32 INFO - 2015-11-18 13:22:32,699 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:22:32 INFO - 2015-11-18 13:22:32,699 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:22:32 INFO - 2015-11-18 13:22:32,699 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,836 13:22:32 INFO - 2015-11-18 13:22:32,699 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:22:32 INFO - 2015-11-18 13:22:32,699 DEBUG : BROWSER_OUTPUT: __startTimestamp1447881752693__endTimestamp 13:22:32 INFO - 2015-11-18 13:22:32,699 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,700 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:22:32 INFO - 2015-11-18 13:22:32,700 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:22:32 INFO - 2015-11-18 13:22:32,700 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,700 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.10 Median:115.00 stddev:5.45 (4.7%) stddev-sans-first:5.72 13:22:32 INFO - 2015-11-18 13:22:32,700 DEBUG : BROWSER_OUTPUT: Values: 113.0 106.0 117.0 113.0 116.0 128.0 115.0 113.0 115.0 115.0 13:22:32 INFO - 2015-11-18 13:22:32,700 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,700 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.70 Median:152.00 stddev:19.58 (12.9%) stddev-sans-first:20.70 13:22:32 INFO - 2015-11-18 13:22:32,700 DEBUG : BROWSER_OUTPUT: Values: 145.0 123.0 147.0 157.0 119.0 165.0 149.0 153.0 188.0 151.0 13:22:32 INFO - 2015-11-18 13:22:32,700 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,700 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:208.80 Median:202.00 stddev:24.00 (11.9%) stddev-sans-first:25.07 13:22:32 INFO - 2015-11-18 13:22:32,700 DEBUG : BROWSER_OUTPUT: Values: 197.0 273.0 194.0 196.0 209.0 221.0 198.0 199.0 205.0 196.0 13:22:32 INFO - 2015-11-18 13:22:32,700 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,701 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:65.20 Median:60.00 stddev:21.18 (35.3%) stddev-sans-first:22.41 13:22:32 INFO - 2015-11-18 13:22:32,701 DEBUG : BROWSER_OUTPUT: Values: 61.0 66.0 55.0 62.0 57.0 63.0 124.0 55.0 59.0 50.0 13:22:32 INFO - 2015-11-18 13:22:32,701 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,701 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:87.60 Median:76.50 stddev:16.95 (22.2%) stddev-sans-first:17.69 13:22:32 INFO - 2015-11-18 13:22:32,701 DEBUG : BROWSER_OUTPUT: Values: 79.0 77.0 110.0 76.0 75.0 81.0 113.0 75.0 77.0 113.0 13:22:32 INFO - 2015-11-18 13:22:32,701 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,701 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:87.00 stddev:11.18 (12.8%) stddev-sans-first:11.74 13:22:32 INFO - 2015-11-18 13:22:32,701 DEBUG : BROWSER_OUTPUT: Values: 87.0 88.0 87.0 87.0 87.0 103.0 118.0 88.0 78.0 90.0 13:22:32 INFO - 2015-11-18 13:22:32,701 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,701 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:97.10 Median:95.00 stddev:3.93 (4.1%) stddev-sans-first:3.91 13:22:32 INFO - 2015-11-18 13:22:32,701 DEBUG : BROWSER_OUTPUT: Values: 101.0 95.0 95.0 95.0 96.0 107.0 95.0 96.0 96.0 95.0 13:22:32 INFO - 2015-11-18 13:22:32,701 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,702 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:91.50 stddev:8.50 (9.3%) stddev-sans-first:8.77 13:22:32 INFO - 2015-11-18 13:22:32,702 DEBUG : BROWSER_OUTPUT: Values: 90.0 93.0 93.0 112.0 94.0 90.0 90.0 111.0 91.0 92.0 13:22:32 INFO - 2015-11-18 13:22:32,702 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,702 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:65.40 Median:64.00 stddev:12.71 (19.9%) stddev-sans-first:13.27 13:22:32 INFO - 2015-11-18 13:22:32,703 DEBUG : BROWSER_OUTPUT: Values: 59.0 60.0 59.0 61.0 70.0 85.0 89.0 67.0 52.0 52.0 13:22:32 INFO - 2015-11-18 13:22:32,703 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,703 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:70.00 stddev:3.08 (4.4%) stddev-sans-first:3.17 13:22:32 INFO - 2015-11-18 13:22:32,703 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 65.0 65.0 66.0 70.0 70.0 71.0 71.0 73.0 13:22:32 INFO - 2015-11-18 13:22:32,704 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,704 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:1.07 (1.3%) stddev-sans-first:1.13 13:22:32 INFO - 2015-11-18 13:22:32,704 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 83.0 82.0 83.0 82.0 83.0 81.0 81.0 84.0 13:22:32 INFO - 2015-11-18 13:22:32,704 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,704 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:133.00 stddev:15.76 (11.9%) stddev-sans-first:16.49 13:22:32 INFO - 2015-11-18 13:22:32,704 DEBUG : BROWSER_OUTPUT: Values: 136.0 133.0 133.0 111.0 123.0 125.0 164.0 111.0 115.0 135.0 13:22:32 INFO - 2015-11-18 13:22:32,704 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,704 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.50 Median:139.00 stddev:5.17 (3.7%) stddev-sans-first:5.48 13:22:32 INFO - 2015-11-18 13:22:32,704 DEBUG : BROWSER_OUTPUT: Values: 137.0 140.0 141.0 136.0 138.0 127.0 140.0 136.0 142.0 128.0 13:22:32 INFO - 2015-11-18 13:22:32,704 DEBUG : BROWSER_OUTPUT: 13:22:32 INFO - 2015-11-18 13:22:32,704 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 13:22:32 INFO - 2015-11-18 13:22:32,704 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 67.0 66.0 69.0 66.0 66.0 68.0 66.0 68.0 13:22:32 INFO - 2015-11-18 13:22:32,704 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:22:32 INFO - 2015-11-18 13:22:32,705 DEBUG : BROWSER_OUTPUT: 13:22:33 INFO - 2015-11-18 13:22:33,290 INFO : Browser exited with error code: 0 13:22:33 INFO - 2015-11-18 13:22:33,337 INFO : Completed test kraken (00:00:56) 13:22:33 INFO - 2015-11-18 13:22:33,337 INFO : Starting test v8_7 13:22:33 INFO - 2015-11-18 13:22:33,337 DEBUG : operating with platform_type : mac_ 13:22:33 INFO - 2015-11-18 13:22:33,337 INFO : Initialising browser for v8_7 test... 13:22:33 INFO - 2015-11-18 13:22:33,349 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmph8AKXc/profile http://localhost:53281/getInfo.html 13:22:36 INFO - 2015-11-18 13:22:36,098 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:22:36 INFO - 2015-11-18 13:22:36,098 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:22:36 INFO - 2015-11-18 13:22:36,098 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 13:22:36 INFO - 2015-11-18 13:22:36,098 DEBUG : BROWSER_OUTPUT: __metrics 13:22:36 INFO - 2015-11-18 13:22:36,699 INFO : Browser initialized. 13:22:36 INFO - 2015-11-18 13:22:36,699 INFO : Running cycle 1/1 for v8_7 test... 13:22:36 INFO - 2015-11-18 13:22:36,700 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmph8AKXc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:22:48 INFO - 2015-11-18 13:22:48,560 DEBUG : BROWSER_OUTPUT: RSS: Main: 237064192 13:22:48 INFO - 2015-11-18 13:22:48,560 DEBUG : BROWSER_OUTPUT: 13:23:09 INFO - 2015-11-18 13:23:09,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53281/tests/v8_7/run.html (next: http://localhost:53281/tests/v8_7/run.html) 13:23:10 INFO - 2015-11-18 13:23:10,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 247717888 13:23:10 INFO - 2015-11-18 13:23:10,246 DEBUG : BROWSER_OUTPUT: 13:23:10 INFO - 2015-11-18 13:23:10,246 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:23:10 INFO - 2015-11-18 13:23:10,246 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:23:10 INFO - 2015-11-18 13:23:10,246 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:23:10 INFO - 2015-11-18 13:23:10,247 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:23:10 INFO - 2015-11-18 13:23:10,247 DEBUG : BROWSER_OUTPUT: |0;Richards;147.8633742422002 13:23:10 INFO - 2015-11-18 13:23:10,247 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;160.90104585679808 13:23:10 INFO - 2015-11-18 13:23:10,247 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.0567734682406 13:23:10 INFO - 2015-11-18 13:23:10,247 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4864.077669902913 13:23:10 INFO - 2015-11-18 13:23:10,247 DEBUG : BROWSER_OUTPUT: |4;RayTrace;955.1098376313277 13:23:10 INFO - 2015-11-18 13:23:10,247 DEBUG : BROWSER_OUTPUT: |5;Earley;736.9196757553427 13:23:10 INFO - 2015-11-18 13:23:10,247 DEBUG : BROWSER_OUTPUT: |6;Boyer;13025.974025974027 13:23:10 INFO - 2015-11-18 13:23:10,247 DEBUG : BROWSER_OUTPUT: |7;RegExp;26736.842105263157 13:23:10 INFO - 2015-11-18 13:23:10,247 DEBUG : BROWSER_OUTPUT: |8;Splay;702.2471910112359 13:23:10 INFO - 2015-11-18 13:23:10,247 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4504.504504504504 13:23:10 INFO - 2015-11-18 13:23:10,247 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:23:10 INFO - 2015-11-18 13:23:10,247 DEBUG : BROWSER_OUTPUT: __startTimestamp1447881790239__endTimestamp 13:23:10 INFO - 2015-11-18 13:23:10,248 DEBUG : BROWSER_OUTPUT: 13:23:10 INFO - 2015-11-18 13:23:10,248 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:23:10 INFO - 2015-11-18 13:23:10,248 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:23:10 INFO - 2015-11-18 13:23:10,248 DEBUG : BROWSER_OUTPUT: 13:23:10 INFO - 2015-11-18 13:23:10,248 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:147.86 Median:147.86 stddev:0.00 (0.0%) 13:23:10 INFO - 2015-11-18 13:23:10,248 DEBUG : BROWSER_OUTPUT: Values: 147.9 13:23:10 INFO - 2015-11-18 13:23:10,248 DEBUG : BROWSER_OUTPUT: 13:23:10 INFO - 2015-11-18 13:23:10,248 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:160.90 Median:160.90 stddev:0.00 (0.0%) 13:23:10 INFO - 2015-11-18 13:23:10,248 DEBUG : BROWSER_OUTPUT: Values: 160.9 13:23:10 INFO - 2015-11-18 13:23:10,248 DEBUG : BROWSER_OUTPUT: 13:23:10 INFO - 2015-11-18 13:23:10,248 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.06 Median:281.06 stddev:0.00 (0.0%) 13:23:10 INFO - 2015-11-18 13:23:10,248 DEBUG : BROWSER_OUTPUT: Values: 281.1 13:23:10 INFO - 2015-11-18 13:23:10,248 DEBUG : BROWSER_OUTPUT: 13:23:10 INFO - 2015-11-18 13:23:10,248 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 13:23:10 INFO - 2015-11-18 13:23:10,248 DEBUG : BROWSER_OUTPUT: Values: 4864.1 13:23:10 INFO - 2015-11-18 13:23:10,249 DEBUG : BROWSER_OUTPUT: 13:23:10 INFO - 2015-11-18 13:23:10,249 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:955.11 Median:955.11 stddev:0.00 (0.0%) 13:23:10 INFO - 2015-11-18 13:23:10,249 DEBUG : BROWSER_OUTPUT: Values: 955.1 13:23:10 INFO - 2015-11-18 13:23:10,249 DEBUG : BROWSER_OUTPUT: 13:23:10 INFO - 2015-11-18 13:23:10,249 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:736.92 Median:736.92 stddev:0.00 (0.0%) 13:23:10 INFO - 2015-11-18 13:23:10,249 DEBUG : BROWSER_OUTPUT: Values: 736.9 13:23:10 INFO - 2015-11-18 13:23:10,249 DEBUG : BROWSER_OUTPUT: 13:23:10 INFO - 2015-11-18 13:23:10,249 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13025.97 Median:13025.97 stddev:0.00 (0.0%) 13:23:10 INFO - 2015-11-18 13:23:10,249 DEBUG : BROWSER_OUTPUT: Values: 13026.0 13:23:10 INFO - 2015-11-18 13:23:10,249 DEBUG : BROWSER_OUTPUT: 13:23:10 INFO - 2015-11-18 13:23:10,249 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26736.84 Median:26736.84 stddev:0.00 (0.0%) 13:23:10 INFO - 2015-11-18 13:23:10,249 DEBUG : BROWSER_OUTPUT: Values: 26736.8 13:23:10 INFO - 2015-11-18 13:23:10,249 DEBUG : BROWSER_OUTPUT: 13:23:10 INFO - 2015-11-18 13:23:10,249 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:702.25 Median:702.25 stddev:0.00 (0.0%) 13:23:10 INFO - 2015-11-18 13:23:10,250 DEBUG : BROWSER_OUTPUT: Values: 702.2 13:23:10 INFO - 2015-11-18 13:23:10,250 DEBUG : BROWSER_OUTPUT: 13:23:10 INFO - 2015-11-18 13:23:10,250 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4504.50 Median:4504.50 stddev:0.00 (0.0%) 13:23:10 INFO - 2015-11-18 13:23:10,250 DEBUG : BROWSER_OUTPUT: Values: 4504.5 13:23:10 INFO - 2015-11-18 13:23:10,250 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:23:10 INFO - 2015-11-18 13:23:10,250 DEBUG : BROWSER_OUTPUT: 13:23:10 INFO - 2015-11-18 13:23:10,838 INFO : Browser exited with error code: 0 13:23:10 INFO - 2015-11-18 13:23:10,857 INFO : Completed test v8_7 (00:00:37) 13:23:11 INFO - 2015-11-18 13:23:11,325 INFO : Completed test suite (00:20:03) 13:23:11 INFO - 2015-11-18 13:23:11,325 DEBUG : Working with test: dromaeo_css 13:23:11 INFO - 2015-11-18 13:23:11,325 DEBUG : Generating results file: dromaeo_css 13:23:11 INFO - 2015-11-18 13:23:11,326 DEBUG : Working with test: kraken 13:23:11 INFO - 2015-11-18 13:23:11,326 DEBUG : Generating results file: kraken 13:23:11 INFO - 2015-11-18 13:23:11,326 INFO : javascript benchmark 13:23:11 INFO - 2015-11-18 13:23:11,326 DEBUG : Working with test: v8_7 13:23:11 INFO - 2015-11-18 13:23:11,326 DEBUG : Generating results file: v8_7 13:23:11 INFO - 2015-11-18 13:23:11,327 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:23:11 INFO - 2015-11-18 13:23:11,378 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 13:23:11 INFO - 2015-11-18 13:23:11,378 DEBUG : process_Request line: dromaeo_css 7249.97 graph.html#tests=[[72,64,61]] 13:23:11 INFO - 2015-11-18 13:23:11,378 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:23:11 INFO - 2015-11-18 13:23:11,407 DEBUG : process_Request line: kraken 1458.60 graph.html#tests=[[232,64,61]] 13:23:11 INFO - 2015-11-18 13:23:11,407 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:23:11 INFO - 2015-11-18 13:23:11,436 DEBUG : process_Request line: v8_7 21847.28 graph.html#tests=[[230,64,61]] 13:23:11 INFO - 2015-11-18 13:23:11,437 INFO : javascript benchmark 13:23:11 INFO - 2015-11-18 13:23:11,441 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3289.963661446644, 3315.668433156685, 3375.6118046424663, 3419.2819507903323, 3463.5670541182353, 5665.178549110382, 5666.546676265899, 5698.458646428583, 5740.225069615601, 5744.109663002241, 5573.219749235111, 5690.7723691052415, 5703.942960570393, 5736.282964629421, 5754.16564598133, 5170.914108037307, 5204.817831375903, 5269.262303277545, 5273.393559740622, 5284.894302113956, 5027.09512287788, 5171.043356978952, 5262.158054711247, 5272.182811664198, 5353.946460535384, 5073.822416215415, 5163.535281824635, 5181.740912954356, 5220.686758794484, 5231.084560201987, 4239.342901850218, 5231.973840130813, 5250.396204436501, 5264.947350526522, 5295.364556253275, 4538.863834084949, 4984.053029924339, 5116.488351164891, 5199.6360254782185, 5207.3490813648295, 4400.339949007643, 5178.705323669083, 5520.0, 5528.55771538276, 5576.888462230773, 6233.532485063638, 6252.343503932113, 6264.59280146789, 6280.340564240781, 6284.5600807943465, 6055.636661800262, 6157.63054216744, 6288.434040936292, 6309.684515774239, 6345.524085693592, 5786.07422812348, 5908.586398952032, 5925.851853703692, 5927.2590926134235, 5978.611390259619, 6308.968455157695, 6320.810375688737, 6342.39747224013, 6362.172917520693, 6382.234131904202, 5949.583529152917, 6056.818295451144, 6126.050462178369, 6184.907226391608, 6187.443130118221, 5268.841934741964, 6157.9384206158265, 6187.535934804908, 6221.688915554204, 6240.188775459162, 6223.066540018943, 6241.937580624226, 6251.781187658501, 6257.061440783918, 6284.622922624657, 5657.8019769307875, 6108.736706092798, 6131.202943617391, 6139.171211886338, 6264.467520260738, 4827.324174615556, 4901.754912254373, 4918.729469879119, 4924.556789888928, 4954.1082605130705, 4482.8206871725415, 4492.303692927601, 4500.549945005539, 4514.300283456069, 4545.36364908913, 5475.09660905946, 5567.359753628303, 5779.711014449261, 5885.823425297248, 5901.203337549376, 6199.039148931923, 6268.0, 6290.968545157337, 6293.118963345135, 6302.684865756693, 5815.79644712433, 5818.44724751148, 5826.184334193216, 5829.09649004405, 5842.620229685057, 5196.818111366084, 5306.62853600252, 5338.786448542092, 5435.374931882805, 5441.319835020622, 6218.968905155445, 6228.28374736902, 6237.563370564108, 6258.593191442633, 6279.591826531261, 6118.632882027093, 6127.050307202391, 6127.509799215963, 6147.815565533041, 6148.077788331786, 6179.6292222465, 6202.844928876814, 6303.716332764945, 6306.779262725782, 6318.589291696025, 6188.381161883775, 6197.03945888388, 6259.280182779039, 6264.123022776906, 6267.905981410191, 6086.6652334122045, 6314.936850631619, 6327.3988971047675, 6328.493720502257, 6330.240371155491, 5650.491455769001, 5954.285485741739, 6039.033754599243, 6057.121717350871, 6062.7271772769445, 5067.847964561069, 6099.237595300588, 6103.6032657877095, 6118.755249789959, 6126.417990290915, 5583.274174357308, 5688.175214593944, 5950.285965684146, 5978.252718410199, 5986.850328741816, 5664.85837854057, 5918.2898052234, 5959.91060134107, 5985.670788106696, 6057.848553786014, 5050.419201791841, 5338.798770276657, 5568.443155684561, 5897.292324921037, 6009.128676341993], "unit": "ms", "name": "dojo.html", "value": 5649.61446079082}, {"lowerIsBetter": false, "replicates": [551.8399664097409, 555.1299780136693, 582.243083990812, 587.888301222768, 620.8882401167789, 40375.39436908442, 40391.59608403915, 40526.59473405265, 40529.18941621166, 40608.39087413691, 44155.77922110393, 44246.89382765433, 44346.33480497787, 44577.0, 44663.0, 9819.509024548797, 9934.602615895355, 10012.749681257954, 10026.548805303779, 10053.195744340435, 9779.070988256104, 9903.752406189831, 9949.701508954742, 9954.402735835873, 9964.20286377088, 8514.446560973547, 9820.803583928317, 9877.555510002032, 9908.90091099087, 9933.701988940344, 8328.500289982621, 9766.658166964122, 9774.218062554979, 9820.459874706889, 9840.409575425461, 9713.90286097137, 9803.019698030212, 9820.558074886647, 9837.114659680663, 9875.555599998017, 41064.58935410638, 41103.383449248286, 41185.79407102945, 41472.170556589, 41640.0, 3183.522471629251, 3211.8072915624903, 3245.480723084319, 3474.739394545419, 3549.769264997767, 28862.278443038882, 28933.383327084113, 28973.855130724423, 29307.41385172306, 29613.259668508243, 2600.2329312852753, 2605.5831067029185, 2619.724928882478, 2695.1375559820867, 2735.548634475309, 510992.0, 511105.0, 513159.0, 514945.0, 515985.0, 58367.0, 59404.10893836596, 62602.686986565684, 62823.6858815703, 67997.66001170062, 66958.33041669521, 67044.32955670479, 67090.66454667696, 67216.0, 67333.663331684, 16381.0171389717, 16461.83538164627, 16500.587485312724, 16525.33898644065, 16557.0, 10991.890081099247, 11128.610498632508, 11849.170558061025, 11862.0, 12401.25592464455, 16529.834701652828, 18487.52099832037, 18519.72220416695, 20304.79695203029, 20412.285570005275, 7842.647080881374, 8791.824163516821, 9075.500847453453, 9152.679656212, 9267.304952128483, 919.3380765848711, 1068.7007637861411, 1072.8015317166348, 1086.0451187861818, 1106.7841770854607, 25996.35009124787, 30114.945976890704, 30408.54387184194, 30478.695213048028, 30498.085057448312, 1003.062136901999, 1079.6760971708457, 1163.2438914705508, 1196.1865931166717, 1201.129181343519, 12894.161879477804, 15329.9233503834, 15375.0, 15551.377944882304, 15598.376064957274, 573269.0, 575858.0, 576516.0, 585140.0, 585311.0, 58919.70540147272, 58935.0, 59587.0, 59750.70124649349, 59828.10257846136, 1447.6815100677834, 1470.1473145575326, 1478.8447213042691, 1485.7474229381032, 1611.7824093747195, 30089.699103009567, 30117.548236776904, 30327.19713777472, 30332.69667303387, 30611.846940765154, 51198.48801512086, 51373.22940155826, 51571.22643160281, 51637.483625163266, 51699.74150129225, 516411.0, 525891.0, 526845.0, 530563.4718263994, 534035.0, 33556.664433355356, 34422.82788586041, 34445.0, 34595.48106778451, 34627.0, 43474.78262608793, 43691.126177475635, 43714.34428483512, 44030.11939761251, 44081.77959110184, 37276.62723372732, 38023.0, 38102.0, 38378.0405489865, 38510.6148938507, 36818.63181368152, 37044.44433333556, 37667.62332376641, 37794.81102594469, 38063.80968095142, 36551.45172822463, 37138.0, 37419.251614968096, 37487.62512374841, 37534.6246537542, 25825.0, 27971.021014264403, 32377.838110809294, 33119.840805571686, 34284.31431371409, 24950.37624059413, 24962.126325578516, 25049.373765656004, 25270.873645631655, 25397.746022539537], "unit": "ms", "name": "ext.html", "value": 20163.775865688007}, {"lowerIsBetter": false, "replicates": [306.9263376789568, 328.29744347097215, 329.7098553273119, 358.41041486754284, 360.0674253682961, 15563.68872622547, 18024.729629055575, 19420.0, 20090.296839610597, 21597.46006349842, 12477.875221247807, 12718.23690578566, 12759.872401275985, 12804.23174609524, 21168.4707882303, 4639.884002899921, 4843.418789745236, 4858.587020103296, 4860.198067318888, 4860.441049279343, 4806.158922188621, 5000.97499512502, 5073.492650734934, 5151.124308867483, 5177.559907407875, 4972.328735620681, 5070.1380765269805, 5093.2105523643895, 5095.566876815476, 5245.344331958505, 5131.179011358184, 5160.458151894053, 5161.793528258865, 5188.06614809336, 5189.558887494568, 4365.083332500179, 4366.235908715994, 4370.10412865365, 4380.299152135675, 4393.046258367494, 14137.646558836112, 14236.288185590782, 14307.856921430757, 14372.197421502811, 14391.712165756626, 1907.7710674718983, 1919.491334796266, 1968.1733671857853, 1999.3801921404265, 2091.1530830013867, 10235.385876847338, 10258.281920265585, 10318.38089714612, 10540.156787457061, 10667.0, 1527.9083255004625, 1631.3963833381606, 1663.808662003873, 1689.7380905959596, 1725.4219836354837, 73942.0, 88173.0, 93474.0, 94233.64415889588, 94280.52859735726, 6858.5199036067, 6862.073620061327, 6925.930740692528, 6930.0, 6941.0, 7640.197779233101, 7849.843003140019, 7866.72466463671, 7897.802554936057, 7925.682972681144, 5243.8164664236565, 5700.287464066992, 5752.6836024019085, 5780.855478613068, 5866.178734977107, 5184.766685499161, 6224.06639004153, 6244.625322480666, 6245.469135123474, 6279.434850863444, 3049.6645369009393, 3056.449839028996, 3064.8007879487764, 3083.8458077096057, 3106.363195544953, 1101.9724506887392, 1118.2340097033557, 1125.7973564758422, 1127.0870594818223, 1180.1267062373954, 396.942443345719, 398.89429301235197, 429.8538496911065, 468.6602213395261, 475.0380479528981, 11333.829992550118, 11365.431728413547, 11452.656420307405, 11665.00847427978, 11787.292762434281, 423.92581298272677, 438.21340693455323, 445.64571165923167, 446.32827594470115, 450.4482009538355, 5969.791057312973, 5980.760769569256, 6032.668203248776, 6076.8784624308155, 6090.543209259235, 754143.0, 757154.0, 768154.0, 775415.0, 776004.0, 112154.43922780333, 112220.0, 112734.0, 114630.0, 114928.0, 394.9861754838567, 474.89077512172395, 477.29122253453596, 478.41155378883474, 479.3385128522686, 10836.837447438453, 10859.2398532102, 10930.45347732626, 10979.39613321275, 10987.450627468435, 39925.0, 49842.75393115201, 50931.745341273054, 51058.48941510686, 51684.0, 65262.673686631264, 66686.0, 71811.64094179496, 72250.0, 73263.0, 6434.903476447951, 6501.772437964649, 6510.121133646897, 6511.300275810053, 6573.737050517926, 10619.415932123808, 10921.962413570698, 11961.700957476132, 12532.686682832637, 12614.49542018309, 10696.679099627023, 11004.724881878017, 11024.0, 11109.055730263019, 11127.777444451227, 10616.681499555025, 10728.432493993254, 10771.19216058783, 10791.97476239756, 11103.611373602209, 9561.665341713007, 11128.888711112786, 11184.720381990515, 11384.772304554028, 11398.658040258806, 6449.645269510034, 6460.838479037873, 6543.312952139957, 6569.047488114292, 6574.671266436755, 10692.518836652214, 10862.619808306672, 11059.50232239535, 11117.44412779374, 11143.554257829595], "unit": "ms", "name": "jquery.html", "value": 7263.497844611063}, {"lowerIsBetter": false, "replicates": [1392.909460885043, 1538.5922730476425, 1813.7370081338215, 1822.1162736073002, 1852.4257480181145, 7375.336219740222, 7464.477486575942, 8055.556944368065, 8178.550179740119, 8234.341252699793, 7731.0, 7930.881036784438, 8003.719869804558, 8042.7185048523315, 8066.556339401331, 2314.652802079689, 2316.455632926261, 2334.1363695432715, 2336.976630233693, 2345.2612427085414, 2184.3119417383473, 2330.0563271874835, 2357.375295546673, 2384.141708984773, 2401.7838394544488, 2323.2449453927456, 2347.542229265294, 2350.2126787526113, 2355.646653002046, 2371.3952941999764, 2307.60770668985, 2310.838241323108, 2324.3143272734414, 2337.9298621041394, 2340.9063637454483, 1989.8607097503182, 2345.624700048001, 2366.3137690069857, 2376.33462630462, 2380.2502211803226, 8060.0, 8081.797955051112, 8125.918740812575, 8171.142030086815, 8195.590220488952, 5040.117979353635, 5112.565431938289, 5138.0, 5138.177891537373, 5173.793048278064, 3435.639257877937, 3463.8787642432394, 3511.0695665648623, 3542.4509201073615, 3554.893353199408, 1050.3907733514543, 1051.647698021164, 1077.450500244873, 1086.1745073743932, 1086.2721976275914, 10435.269531132824, 10469.0, 10621.0, 10637.627683031134, 10702.892971070345, 3896.5518965318784, 4314.89212769677, 4628.328892310664, 4650.116477869194, 4656.092062047868, 9309.906900930904, 9319.207867331354, 9342.486163261086, 9343.0, 9343.532823358804, 5116.437191908887, 5159.406668233126, 5166.199239117943, 5179.870503237449, 5183.5593974512585, 4176.206520761046, 4228.4080228768, 4527.501974782771, 4613.653975951817, 4699.248120300804, 3216.790908590934, 3806.5241844769403, 3891.9610803892165, 3894.337962546374, 3894.5910679378826, 1137.0789660375124, 1152.4468255237532, 1219.8475190601175, 1256.855461621907, 1267.8288431061874, 1317.9934100329438, 1319.1755153029358, 1331.3077199856214, 1372.6499742565782, 1383.9723205536034, 6695.263521012685, 7538.0, 7568.810779730551, 7870.449068565145, 7934.722284720007, 1197.5150064224003, 1201.5133870782347, 1208.2689972566645, 1210.425048102162, 1232.5193174661888, 5982.162497250389, 6128.63228206309, 6139.631622102688, 6143.877122457526, 6180.845478862974, 9597.23222142227, 9750.317477776487, 9768.0, 9789.314747967715, 9812.950935245279, 9334.206592439583, 9631.759206019766, 9641.566129524188, 9678.70963871085, 9693.127618514367, 7589.279018493235, 7718.035245594301, 7723.459357845009, 7748.3026527611655, 7776.7278145264645, 7335.889961650686, 7364.153122390993, 7379.852402951804, 7393.445491588045, 7403.666834992546, 8544.0, 8607.65569377218, 8665.393422460367, 8721.0, 8755.474671519729, 8834.072422395557, 8916.33127515452, 8951.820963580822, 8966.0, 9113.544322783702, 5289.550388217045, 6439.3238709934785, 6632.701528431328, 6712.664366781543, 6773.525853190229, 7553.357964572853, 7748.147703752696, 7783.727569535039, 7793.844123117619, 7815.765527034198, 7088.574685518885, 7176.533525320838, 7213.3868621167785, 7354.558726476428, 7366.7053317866685, 6228.781992630236, 7064.0, 7181.533200341961, 7223.711051557879, 7268.636568171676, 7130.607816570138, 7163.7492687755675, 7297.927020729725, 7310.232425595236, 7369.37360324357, 5736.569757268305, 6039.939600604113, 6141.232345956755, 6697.3302669734585, 6735.090762746966, 6697.698603562754, 6793.762218322533, 6804.4216241620015, 6806.251312355538, 6806.489513286622], "unit": "ms", "name": "mootools.html", "value": 4665.679929386206}, {"lowerIsBetter": false, "replicates": [322.26041235364835, 327.76728522748846, 328.7485073918453, 333.81640097946126, 334.4114358728638, 6994.712485131992, 7055.929440705591, 7078.2921707829255, 7133.89299160513, 7230.96384518078, 5788.842231553685, 6765.729370825174, 7074.398676112537, 7091.14906211254, 7114.608696521702, 5134.306868572751, 5134.845954621367, 5143.382794064699, 5166.121759300928, 5187.662801917863, 5003.799848006075, 5117.513836185556, 5132.97433512832, 5157.8452646420665, 5166.354205724285, 3654.579723331811, 4751.643626727992, 4805.807767689288, 5087.643864929457, 5094.898102037957, 5079.466656001104, 5080.187170052793, 5084.034033533635, 5100.183970564711, 5127.769250383742, 4197.622214000724, 4284.614384705392, 4309.5690430956965, 4310.719803212781, 4319.82720691172, 6724.7646332378135, 6729.158855143107, 6748.190217173921, 6753.122094127781, 6811.659417029129, 5928.7332070056955, 5930.851728706817, 5936.406359364072, 5937.198478205473, 5950.137230101611, 7246.3840573551315, 7457.9186018027085, 7459.589722565257, 7462.7014919403155, 7472.065991751031, 4754.881127971794, 4758.833440829554, 4761.381130415641, 4764.2615394613895, 4770.427548694144, 7846.725364612211, 7956.403269754792, 7976.322012628933, 7985.361171106298, 8010.839783204362, 4703.223968045234, 4812.470628230892, 4839.806407743651, 4841.273808928689, 4843.297721830315, 4907.9263811042865, 4911.361523001987, 4935.481774413634, 4955.554000140005, 4966.975165124223, 5281.0758117329315, 5873.119032145127, 5983.0, 5984.072468767348, 5996.220491336186, 7269.382102521345, 7536.133344665324, 7556.773296801105, 7558.168601453835, 7584.0, 1702.2254874032533, 1714.1686282153146, 1716.519374575121, 1717.7079896417638, 1719.5271300392492, 1078.7680648660576, 1083.8265877459726, 1093.9015488605905, 1101.9614313499148, 1103.475848971732, 5805.593608447452, 7126.394256488256, 7131.679074441663, 7135.036770036082, 7138.321859423347, 7878.448508604342, 7886.408519360956, 7893.763187104396, 7898.723544675909, 7926.920730792618, 5735.397783232784, 6466.741330346827, 6916.619585922823, 7097.290270972965, 7127.073480447509, 3593.3531964246163, 3736.1220113273903, 3875.3218186817194, 4119.279126152911, 4151.377293406013, 7538.924610753932, 8195.71315003972, 8235.588220589067, 8241.175882411711, 8278.668853245923, 7208.495405321577, 7554.508956917783, 7932.920670793334, 8187.426880118334, 8194.385421093442, 8182.263596276244, 8195.262426381654, 8201.466904651179, 8204.958975205085, 8207.220314070153, 5594.328680558359, 7113.146422429135, 7881.605919704107, 7901.525908445512, 7979.760607181794, 6208.751649933952, 6248.0, 7473.327400533978, 7714.421418393531, 7744.883826742491, 8048.597570121354, 8186.304164146114, 8227.341812654853, 8231.835363292581, 8240.0, 4775.403074615673, 4856.39295088114, 4864.489228631084, 4868.780904859219, 4882.584980276716, 7627.809304767426, 7840.490368126054, 7865.252800983897, 7879.290863822283, 7920.128785833438, 7525.473216874985, 7539.434542409232, 7547.528231994708, 7554.244575542401, 7565.205653406313, 7341.74303899361, 7494.400447964259, 7495.437842161969, 7502.474826762293, 7513.023306970277, 7324.560526368435, 7332.560046397233, 7335.339819416278, 7339.266073392618, 7365.926340736738, 6457.096006558992, 6732.192136943598, 6853.760118395832, 7131.358177763818, 7546.509476883985, 5953.28560572734, 7238.167610724834, 7370.262973702587, 7373.9262607375385, 7383.1173050871685], "unit": "ms", "name": "prototype.html", "value": 5393.4242939137}, {"lowerIsBetter": false, "replicates": [692.8775383878118, 753.3859904178095, 792.4017366887998, 823.3660081737063, 827.0241115483728, 13756.624337566263, 15257.465988690397, 15303.770443443329, 15651.765223521628, 15662.060276383425, 13331.800022999638, 13997.39030011549, 14299.428022879098, 14599.708005839877, 14954.252287385641, 875.3784812782916, 947.9052094790535, 977.2475194100539, 978.3445091788519, 982.062130665213, 961.6153538584587, 964.6768332608584, 971.218169373654, 983.955721992512, 985.374287327545, 1010.6361709784471, 1013.9391636501797, 1023.687775228555, 1032.0711359776187, 1034.4672493665769, 997.4514017290497, 1008.5058321422523, 1013.5793645637052, 1014.0771897573173, 1024.462157367388, 734.4931996922106, 739.4897520710692, 741.6662501874179, 754.4002517998205, 755.527795128045, 13770.449182032708, 13979.860201397958, 14092.647683807987, 14094.718105637932, 14153.716925661429, 11268.323900565993, 11432.599859004895, 11587.537536039556, 11706.063514918786, 12706.809397859039, 10087.546060427298, 10247.231457640706, 10373.636922707668, 10571.894281057244, 11101.1674124441, 3519.454484554898, 3521.7886926784477, 3563.518924945125, 3576.445650924085, 3609.4946707460977, 64849.730259440694, 72379.27620723778, 73012.0, 77583.61208193979, 81459.59270203671, 9659.034096590425, 9802.215822734164, 10003.79992400148, 10026.448545329931, 10172.338797978107, 18134.90932545329, 22887.542249155256, 23085.653715194287, 23154.42113947131, 23167.0, 7388.224236455095, 7635.045619297588, 7682.884756728654, 7726.806829829299, 7746.845063098706, 3118.6725393833776, 4029.6776257899296, 4085.611866872642, 4232.343986682069, 4236.555161708038, 3462.4979377990553, 3484.26830365621, 3491.546099007113, 3519.8768043118366, 3524.1542029912634, 541.7101850509958, 556.0630337880684, 565.9434056594307, 566.5552541255095, 568.5934556791914, 488.2310361181154, 501.23561568608164, 547.8602956246211, 551.5973339462134, 564.7176411794103, 8020.518768873886, 8705.912940870638, 8732.738017859474, 8791.032986371494, 8936.910630893737, 548.6324162810927, 578.3551340255585, 614.8001899382718, 619.5693992675048, 620.320748780094, 3973.145773658677, 4209.957900421018, 4356.259435895905, 4392.648588112943, 4432.955670443319, 64731.352686472535, 72813.0, 85805.0, 87034.69447958286, 87307.0, 78348.21651783523, 78706.21293787104, 79193.60403197947, 79403.0, 81513.59243203746, 75986.0, 76979.0, 78124.04689882799, 78721.0, 78867.60566197247, 8812.148537171553, 8995.865062024206, 9030.954845225731, 9033.50315732641, 9116.680916167903, 55053.72473137609, 55436.72281638566, 56353.0, 57243.568910775895, 57318.426815731305, 68393.9740903877, 68500.0, 68906.0, 71766.28233717596, 72400.0, 7997.7600671979935, 8009.439339246197, 8165.918340816515, 8192.385571082312, 8298.543580103153, 12143.635690929286, 12361.62915112548, 12370.072244581512, 12454.626361209179, 12757.425915833624, 9429.434233945985, 11960.58137965167, 11983.221090629082, 11985.981191598812, 12134.271943683054, 11921.344326061802, 12017.339046352534, 12036.097292702907, 12091.818622720843, 12138.75722485563, 11750.70623234426, 11791.646250612495, 11817.995470385114, 11831.46758395857, 11987.160898737005, 9661.661841835503, 9674.0, 9793.363431376938, 9798.608055677978, 9804.509774511103, 9570.712878613653, 9989.001099889952, 10050.69847904564, 10136.391816491034, 10164.682846910244], "unit": "ms", "name": "yui.html", "value": 6973.749946120278}], "name": "dromaeo_css", "value": 7249.969402146116}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 117.0, 113.0, 116.0, 128.0, 115.0, 113.0, 115.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 115.1}, {"lowerIsBetter": true, "replicates": [145.0, 123.0, 147.0, 157.0, 119.0, 165.0, 149.0, 153.0, 188.0, 151.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [197.0, 273.0, 194.0, 196.0, 209.0, 221.0, 198.0, 199.0, 205.0, 196.0], "unit": "ms", "name": "audio-dft", "value": 208.8}, {"lowerIsBetter": true, "replicates": [61.0, 66.0, 55.0, 62.0, 57.0, 63.0, 124.0, 55.0, 59.0, 50.0], "unit": "ms", "name": "audio-fft", "value": 65.2}, {"lowerIsBetter": true, "replicates": [79.0, 77.0, 110.0, 76.0, 75.0, 81.0, 113.0, 75.0, 77.0, 113.0], "unit": "ms", "name": "audio-oscillator", "value": 87.6}, {"lowerIsBetter": true, "replicates": [87.0, 88.0, 87.0, 87.0, 87.0, 103.0, 118.0, 88.0, 78.0, 90.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 91.3}, {"lowerIsBetter": true, "replicates": [101.0, 95.0, 95.0, 95.0, 96.0, 107.0, 95.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-darkroom", "value": 97.1}, {"lowerIsBetter": true, "replicates": [90.0, 93.0, 93.0, 112.0, 94.0, 90.0, 90.0, 111.0, 91.0, 92.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 59.0, 61.0, 70.0, 85.0, 89.0, 67.0, 52.0, 52.0], "unit": "ms", "name": "json-parse-financial", "value": 65.4}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 65.0, 65.0, 66.0, 70.0, 70.0, 71.0, 71.0, 73.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 83.0, 82.0, 83.0, 82.0, 83.0, 81.0, 81.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [136.0, 133.0, 133.0, 111.0, 123.0, 125.0, 164.0, 111.0, 115.0, 135.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.6}, {"lowerIsBetter": true, "replicates": [137.0, 140.0, 141.0, 136.0, 138.0, 127.0, 140.0, 136.0, 142.0, 128.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 136.5}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 66.0, 69.0, 66.0, 66.0, 68.0, 66.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1458.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [147.8633742422002], "unit": "score", "name": "Richards", "value": 238.74742600000002}, {"lowerIsBetter": false, "replicates": [160.90104585679808], "unit": "score", "name": "DeltaBlue", "value": 410.92337}, {"lowerIsBetter": false, "replicates": [281.0567734682406], "unit": "score", "name": "Encrypt", "value": 947.0719979999998}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "Decrypt", "value": 54.723838323353256}, {"lowerIsBetter": false, "replicates": [955.1098376313277], "unit": "score", "name": "RayTrace", "value": 774.7684829999998}, {"lowerIsBetter": false, "replicates": [736.9196757553427], "unit": "score", "name": "Earley", "value": 904.3902909999999}, {"lowerIsBetter": false, "replicates": [13025.974025974027], "unit": "score", "name": "Boyer", "value": 51.1641585244267}, {"lowerIsBetter": false, "replicates": [26736.842105263157], "unit": "score", "name": "RegExp", "value": 34.07227362204725}, {"lowerIsBetter": false, "replicates": [702.2471910112359], "unit": "score", "name": "Splay", "value": 116.04318400000004}, {"lowerIsBetter": false, "replicates": [4504.504504504504], "unit": "score", "name": "NavierStokes", "value": 329.44800000000015}], "name": "v8_7", "value": 21847.275105008586}]} 13:23:11 INFO - RETURN: dromaeo_css: 7249.97 13:23:11 INFO - RETURN: kraken: 1458.60 13:23:11 INFO - RETURN: v8_7: 21847.28 13:23:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "21847.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1458.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7249.97"}}} 13:23:11 INFO - Return code: 0 13:23:11 INFO - # TBPL SUCCESS # 13:23:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:23:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:23:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:23:11 INFO - 2015-11-18 13:23:11.526 screenresolution[1960:66757] starting screenresolution argv=screenresolution get 13:23:11 INFO - 2015-11-18 13:23:11.529 screenresolution[1960:66757] Display 0: 1600x1200x32@60 13:23:11 INFO - 2015-11-18 13:23:11.534 screenresolution[1961:66760] starting screenresolution argv=screenresolution list 13:23:11 INFO - Available Modes on Display 0 13:23:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:23:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:23:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:23:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:23:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:23:11 INFO - Intel Iris: 13:23:11 INFO - Chipset Model: Intel Iris 13:23:11 INFO - Type: GPU 13:23:11 INFO - Bus: Built-In 13:23:11 INFO - VRAM (Dynamic, Max): 1536 MB 13:23:11 INFO - Vendor: Intel (0x8086) 13:23:11 INFO - Device ID: 0x0a2e 13:23:11 INFO - Revision ID: 0x0009 13:23:11 INFO - Displays: 13:23:11 INFO - Display: 13:23:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:23:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:23:11 INFO - Display Serial Number: 1600x1200 60 13:23:11 INFO - Main Display: Yes 13:23:11 INFO - Mirror: Off 13:23:11 INFO - Online: Yes 13:23:11 INFO - Rotation: Supported 13:23:11 INFO - Return code: 0 13:23:11 INFO - Running post-action listener: _resource_record_post_action 13:23:11 INFO - Running post-run listener: _resource_record_post_run 13:23:12 INFO - Total resource usage - Wall time: 1235s; CPU: 54.0%; Read bytes: 106496; Write bytes: 689699328; Read time: 4; Write time: 2138 13:23:12 INFO - install - Wall time: 30s; CPU: 54.0%; Read bytes: 339235328; Write bytes: 335837184; Read time: 26002; Write time: 605 13:23:12 INFO - run-tests - Wall time: 1205s; CPU: 54.0%; Read bytes: 102400; Write bytes: 342434304; Read time: 3; Write time: 1496 13:23:12 INFO - Running post-run listener: _upload_blobber_files 13:23:12 INFO - Blob upload gear active. 13:23:12 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:23:12 INFO - Copying logs to upload dir... 13:23:12 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.399999 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-11-18 13:23:12.880263) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 13:23:12.883987) ========= 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.0vxrc8f6f8/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.6MaNLqnVpu/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009568 build_url: 'https://queue.taskcluster.net/v1/task/V_wgNSnpSOWfe3XG6ke8Yw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 13:23:12.908392) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:23:12.908736) ========= 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.0vxrc8f6f8/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.6MaNLqnVpu/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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.005224 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:23:12.957332) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 13:23:12.957674) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 13:23:12.958099) ========= ========= Total master_lag: 0.22 =========