builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0029 starttime: 1446769291.46 results: success (0) buildid: 20151105140536 builduid: 62764bd1e0604ad39b4b8cc6681bf17d revision: 319e09c9668b8d2937c49dabdfd84a30d8771ac1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:31.459905) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:31.460452) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:31.460785) ========= 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.L7cpMrKHAy/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.95wtk6II3e/Listeners TMPDIR=/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006040 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:31.484644) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:31.485023) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:31.500912) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:31.501616) ========= 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.L7cpMrKHAy/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.95wtk6II3e/Listeners TMPDIR=/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005339 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:31.552186) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:31.552599) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:31.553033) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:31.553452) ========= 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.L7cpMrKHAy/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.95wtk6II3e/Listeners TMPDIR=/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-05 16:21:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 7.49M=0.002s 2015-11-05 16:21:31 (7.49 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191553 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:31.762334) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:31.762709) ========= 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.L7cpMrKHAy/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.95wtk6II3e/Listeners TMPDIR=/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.019589 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:31.812739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-05 16:21:31.813156) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 319e09c9668b8d2937c49dabdfd84a30d8771ac1 --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 319e09c9668b8d2937c49dabdfd84a30d8771ac1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L7cpMrKHAy/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.95wtk6II3e/Listeners TMPDIR=/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-05 16:21:31,882 truncating revision to first 12 chars 2015-11-05 16:21:31,882 Setting DEBUG logging. 2015-11-05 16:21:31,882 attempt 1/10 2015-11-05 16:21:31,882 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/319e09c9668b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-05 16:21:32,900 unpacking tar archive at: fx-team-319e09c9668b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.418984 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-05 16:21:33.248807) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:33.249225) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:33.262127) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:33.262516) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 16:21:33.262972) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2015-11-05 16:21:33.263320) ========= /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.L7cpMrKHAy/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.95wtk6II3e/Listeners TMPDIR=/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 16:21:33 INFO - MultiFileLogger online at 20151105 16:21:33 in /builds/slave/test 16:21:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:21:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:21:33 INFO - {'append_to_log': False, 16:21:33 INFO - 'base_work_dir': '/builds/slave/test', 16:21:33 INFO - 'blob_upload_branch': 'Fx-Team', 16:21:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:21:33 INFO - 'branch': 'Fx-Team', 16:21:33 INFO - 'buildbot_json_path': 'buildprops.json', 16:21:33 INFO - 'config_files': ('talos/mac_config.py',), 16:21:33 INFO - 'default_actions': ('clobber', 16:21:33 INFO - 'read-buildbot-config', 16:21:33 INFO - 'download-and-extract', 16:21:33 INFO - 'populate-webroot', 16:21:33 INFO - 'create-virtualenv', 16:21:33 INFO - 'install', 16:21:33 INFO - 'run-tests'), 16:21:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:21:33 INFO - 'download_minidump_stackwalk': True, 16:21:33 INFO - 'download_symbols': 'ondemand', 16:21:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:21:33 INFO - 'tooltool.py': '/tools/tooltool.py', 16:21:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:21:33 INFO - '/tools/misc-python/virtualenv.py')}, 16:21:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:21:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:21:33 INFO - 'installer_path': 'installer.exe', 16:21:33 INFO - 'log_level': 'info', 16:21:33 INFO - 'log_name': 'talos', 16:21:33 INFO - 'log_to_console': True, 16:21:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:21:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:21:33 INFO - 'opt_config_files': (), 16:21:33 INFO - 'pip_index': False, 16:21:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:21:33 INFO - 'cmd': ('bash', 16:21:33 INFO - '-c', 16:21:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:21:33 INFO - 'enabled': True, 16:21:33 INFO - 'halt_on_failure': False, 16:21:33 INFO - 'name': 'check_screen_resolution'},), 16:21:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:21:33 INFO - 'cmd': ('bash', 16:21:33 INFO - '-c', 16:21:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:21:33 INFO - 'enabled': True, 16:21:33 INFO - 'halt_on_failure': False, 16:21:33 INFO - 'name': 'check_screen_resolution'},), 16:21:33 INFO - 'run_cmd_checks_enabled': True, 16:21:33 INFO - 'sps_profile': False, 16:21:33 INFO - 'sps_profile_interval': 0, 16:21:33 INFO - 'suite': 'dromaeojs-e10s', 16:21:33 INFO - 'system_bits': '64', 16:21:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:21:33 INFO - 'title': 't-yosemite-r5-0029', 16:21:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:21:33 INFO - 'use_talos_json': True, 16:21:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:21:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:21:33 INFO - 'work_dir': 'build'} 16:21:33 INFO - ##### 16:21:33 INFO - ##### Running clobber step. 16:21:33 INFO - ##### 16:21:33 INFO - Running pre-action listener: _resource_record_pre_action 16:21:33 INFO - Running main action method: clobber 16:21:33 INFO - rmtree: /builds/slave/test/build 16:21:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:21:33 INFO - Running post-action listener: _resource_record_post_action 16:21:33 INFO - ##### 16:21:33 INFO - ##### Running read-buildbot-config step. 16:21:33 INFO - ##### 16:21:33 INFO - Running pre-action listener: _resource_record_pre_action 16:21:33 INFO - Running main action method: read_buildbot_config 16:21:33 INFO - Using buildbot properties: 16:21:33 INFO - { 16:21:33 INFO - "properties": { 16:21:33 INFO - "buildnumber": 12, 16:21:33 INFO - "product": "firefox", 16:21:33 INFO - "script_repo_revision": "production", 16:21:33 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 16:21:33 INFO - "repository": "", 16:21:33 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 16:21:33 INFO - "buildid": "20151105140536", 16:21:33 INFO - "slavename": "t-yosemite-r5-0029", 16:21:33 INFO - "pgo_build": "False", 16:21:33 INFO - "basedir": "/builds/slave/test", 16:21:33 INFO - "project": "", 16:21:33 INFO - "platform": "yosemite", 16:21:33 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:21:33 INFO - "slavebuilddir": "test", 16:21:33 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:21:33 INFO - "branch": "fx-team", 16:21:33 INFO - "repo_path": "integration/fx-team", 16:21:33 INFO - "stage_platform": "macosx64", 16:21:33 INFO - "builduid": "62764bd1e0604ad39b4b8cc6681bf17d", 16:21:33 INFO - "revision": "319e09c9668b8d2937c49dabdfd84a30d8771ac1" 16:21:33 INFO - }, 16:21:33 INFO - "sourcestamp": { 16:21:33 INFO - "repository": "", 16:21:33 INFO - "hasPatch": false, 16:21:33 INFO - "project": "", 16:21:33 INFO - "branch": "fx-team-macosx64-talos", 16:21:33 INFO - "changes": [ 16:21:33 INFO - { 16:21:33 INFO - "category": null, 16:21:33 INFO - "files": [ 16:21:33 INFO - { 16:21:33 INFO - "url": null, 16:21:33 INFO - "name": "https://queue.taskcluster.net/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 16:21:33 INFO - } 16:21:33 INFO - ], 16:21:33 INFO - "repository": "", 16:21:33 INFO - "rev": "319e09c9668b8d2937c49dabdfd84a30d8771ac1", 16:21:33 INFO - "who": "nalexander@mozilla.com", 16:21:33 INFO - "when": 1446767044, 16:21:33 INFO - "number": 6627370, 16:21:33 INFO - "comments": "Bug 1220887 - Make 'base' Gradle project in the srcdir. r=sebastian\n\nThis is the last Gradle project that isn't in the srcdir. Since base/\ndoesn't have the correct package prefix directory structure, we still\nneed to symlink, but we only need one link. This effectively\ndeprecates |mach gradle-install|.\n\nThis should improve the robustness of our Gradle configuration,\nensuring that we always have projects to import. Since\nsettings.gradle executes very early in the IDE import project\nsequence: before Gradle project evaluation time, and thus before any\nGradle task is executed, we should always see a complete project. (It\nwas possible to see incomplete Gradle configurations if |mach\ngradle-install| hadn't been run at just the right time.)", 16:21:33 INFO - "project": "", 16:21:33 INFO - "at": "Thu 05 Nov 2015 15:44:04", 16:21:33 INFO - "branch": "fx-team-macosx64-talos", 16:21:33 INFO - "revlink": "", 16:21:33 INFO - "properties": [ 16:21:33 INFO - [ 16:21:33 INFO - "buildid", 16:21:33 INFO - "20151105140536", 16:21:33 INFO - "Change" 16:21:33 INFO - ], 16:21:33 INFO - [ 16:21:33 INFO - "builduid", 16:21:33 INFO - "62764bd1e0604ad39b4b8cc6681bf17d", 16:21:33 INFO - "Change" 16:21:33 INFO - ], 16:21:33 INFO - [ 16:21:33 INFO - "pgo_build", 16:21:33 INFO - "False", 16:21:33 INFO - "Change" 16:21:33 INFO - ] 16:21:33 INFO - ], 16:21:33 INFO - "revision": "319e09c9668b8d2937c49dabdfd84a30d8771ac1" 16:21:33 INFO - } 16:21:33 INFO - ], 16:21:33 INFO - "revision": "319e09c9668b8d2937c49dabdfd84a30d8771ac1" 16:21:33 INFO - } 16:21:33 INFO - } 16:21:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 16:21:33 INFO - Running post-action listener: _resource_record_post_action 16:21:33 INFO - ##### 16:21:33 INFO - ##### Running download-and-extract step. 16:21:33 INFO - ##### 16:21:33 INFO - Running pre-action listener: _resource_record_pre_action 16:21:33 INFO - Running main action method: download_and_extract 16:21:33 INFO - mkdir: /builds/slave/test/build/tests 16:21:33 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')]} 16:21:33 INFO - https://queue.taskcluster.net/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:21:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/test_packages.json 16:21:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/test_packages.json 16:21:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:21:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:21:34 INFO - Downloaded 1149 bytes. 16:21:34 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:21:34 INFO - Using the following test package requirements: 16:21:34 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:21:34 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:21:34 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 16:21:34 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:21:34 INFO - u'jsshell-mac.zip'], 16:21:34 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:21:34 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 16:21:34 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:21:34 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:21:34 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 16:21:34 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:21:34 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 16:21:34 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:21:34 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 16:21:34 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:21:34 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:21:34 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 16:21:34 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:34 INFO - https://queue.taskcluster.net/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:21:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:21:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:21:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/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 16:21:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/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 16:21:35 INFO - Downloaded 17458889 bytes. 16:21:35 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 16:21:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:21:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:21:40 INFO - Return code: 0 16:21:40 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 16:21:40 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')]} 16:21:40 INFO - https://queue.taskcluster.net/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:21:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:21:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:21:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/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 16:21:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/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 16:21:42 INFO - Downloaded 17458889 bytes. 16:21:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 16:21:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:21:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:21:48 INFO - Return code: 0 16:21:48 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')]} 16:21:48 INFO - https://queue.taskcluster.net/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:21:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:21:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:21:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/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 16:21:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/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 16:21:49 INFO - Downloaded 11131307 bytes. 16:21:49 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 16:21:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:21:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 16:21:50 INFO - Return code: 0 16:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:50 INFO - https://queue.taskcluster.net/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:21:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:21:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:21:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 16:21:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/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 16:21:53 INFO - Downloaded 108674862 bytes. 16:21:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:21:53 INFO - mkdir: /builds/slave/test/properties 16:21:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:21:53 INFO - Writing to file /builds/slave/test/properties/build_url 16:21:53 INFO - Contents: 16:21:53 INFO - build_url:https://queue.taskcluster.net/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:21:53 INFO - Running post-action listener: _resource_record_post_action 16:21:53 INFO - Running post-action listener: set_extra_try_arguments 16:21:53 INFO - ##### 16:21:53 INFO - ##### Running populate-webroot step. 16:21:53 INFO - ##### 16:21:53 INFO - Running pre-action listener: _resource_record_pre_action 16:21:53 INFO - Running main action method: populate_webroot 16:21:53 INFO - Guessing talos json url... 16:21:53 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')]} 16:21:53 INFO - https://queue.taskcluster.net/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 16:21:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 16:21:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 16:21:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 16:21:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 16:21:54 INFO - Downloaded 103 bytes. 16:21:54 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 16:21:54 INFO - Contents: 16:21:54 INFO - 20151105140536 16:21:54 INFO - https://hg.mozilla.org/integration/fx-team/rev/319e09c9668b8d2937c49dabdfd84a30d8771ac1 16:21:54 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')]} 16:21:54 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/319e09c966/testing/talos/talos.json 16:21:54 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/319e09c966/testing/talos/talos.json to /builds/slave/test/build/talos.json 16:21:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/319e09c966/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 16:21:54 INFO - Downloaded 4264 bytes. 16:21:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:21:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:21:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:21:54 INFO - '../fennec_ids.txt'], 16:21:54 INFO - 'tests': ['tcheck2']}, 16:21:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:21:54 INFO - '--tppagecycles', 16:21:54 INFO - '7'], 16:21:54 INFO - 'tests': ['tsvgm']}}, 16:21:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:21:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:21:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:21:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:21:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:54 INFO - 'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:54 INFO - 'tests': ['damp', 'tps']}, 16:21:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:54 INFO - 'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['damp', 'tps']}, 16:21:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:21:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:21:54 INFO - 'other': {'tests': ['a11yr', 16:21:54 INFO - 'ts_paint', 16:21:54 INFO - 'tpaint', 16:21:54 INFO - 'sessionrestore', 16:21:54 INFO - 'sessionrestore_no_auto_restore']}, 16:21:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['a11yr', 16:21:54 INFO - 'ts_paint', 16:21:54 INFO - 'tpaint', 16:21:54 INFO - 'sessionrestore', 16:21:54 INFO - 'sessionrestore_no_auto_restore']}, 16:21:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['a11yr', 16:21:54 INFO - 'ts_paint', 16:21:54 INFO - 'tpaint', 16:21:54 INFO - 'sessionrestore', 16:21:54 INFO - 'sessionrestore_no_auto_restore']}, 16:21:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['a11yr', 16:21:54 INFO - 'ts_paint', 16:21:54 INFO - 'tpaint', 16:21:54 INFO - 'sessionrestore', 16:21:54 INFO - 'sessionrestore_no_auto_restore']}, 16:21:54 INFO - 'other_l64': {'tests': ['a11yr', 16:21:54 INFO - 'ts_paint', 16:21:54 INFO - 'tpaint', 16:21:54 INFO - 'sessionrestore', 16:21:54 INFO - 'sessionrestore_no_auto_restore']}, 16:21:54 INFO - 'other_nol64': {'tests': ['a11yr', 16:21:54 INFO - 'ts_paint', 16:21:54 INFO - 'tpaint', 16:21:54 INFO - 'sessionrestore', 16:21:54 INFO - 'sessionrestore_no_auto_restore']}, 16:21:54 INFO - 'svgr': {'tests': ['tsvgx', 16:21:54 INFO - 'tsvgr_opacity', 16:21:54 INFO - 'tart', 16:21:54 INFO - 'tscrollx', 16:21:54 INFO - 'cart']}, 16:21:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['tsvgx', 16:21:54 INFO - 'tsvgr_opacity', 16:21:54 INFO - 'tart', 16:21:54 INFO - 'tscrollx', 16:21:54 INFO - 'cart']}, 16:21:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:54 INFO - 'tests': ['tp5o']}, 16:21:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:54 INFO - 'talos_options': ['--e10s'], 16:21:54 INFO - 'tests': ['tp5o']}, 16:21:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:54 INFO - 'talos_options': ['--xperf_path', 16:21:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:54 INFO - 'tests': ['tp5n']}, 16:21:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:54 INFO - 'talos_options': ['--e10s', 16:21:54 INFO - '--xperf_path', 16:21:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 16:21:54 INFO - 'C:/slave/talos-data/talos/xperf.config'], 16:21:54 INFO - 'tests': ['tp5n']}}, 16:21:54 INFO - 'talos.zip': {'path': '', 16:21:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:21:54 INFO - Running post-action listener: _resource_record_post_action 16:21:54 INFO - ##### 16:21:54 INFO - ##### Running create-virtualenv step. 16:21:54 INFO - ##### 16:21:54 INFO - Running pre-action listener: _resource_record_pre_action 16:21:54 INFO - Running main action method: create_virtualenv 16:21:54 INFO - Creating virtualenv /builds/slave/test/build/venv 16:21:54 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 16:21:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:21:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:21:54 INFO - Using real prefix '/tools/python27' 16:21:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:21:55 INFO - Installing distribute.............................................................................................................................................................................................done. 16:21:59 INFO - Installing pip.................done. 16:21:59 INFO - Return code: 0 16:21:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:21:59 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')]} 16:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:59 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')]} 16:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:59 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 0x10f480a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49af4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4359f0>, '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 0x10f194cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3ff990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L7cpMrKHAy/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.95wtk6II3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:59 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 16:21:59 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 16:21:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L7cpMrKHAy/Render', 16:21:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:59 INFO - 'HOME': '/Users/cltbld', 16:21:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:59 INFO - 'LOGNAME': 'cltbld', 16:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:59 INFO - 'MOZ_NO_REMOTE': '1', 16:21:59 INFO - 'NO_EM_RESTART': '1', 16:21:59 INFO - 'PAGER': '/bin/cat', 16:21:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:59 INFO - 'PWD': '/builds/slave/test', 16:21:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:59 INFO - 'SHELL': '/bin/bash', 16:21:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.95wtk6II3e/Listeners', 16:21:59 INFO - 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', 16:21:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:59 INFO - 'USER': 'cltbld', 16:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:59 INFO - 'XPC_FLAGS': '0x0', 16:21:59 INFO - 'XPC_SERVICE_NAME': '0', 16:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:59 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 16:21:59 INFO - Cleaning up... 16:21:59 INFO - Return code: 0 16:21:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:21:59 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')]} 16:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:59 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')]} 16:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:59 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 0x10f480a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49af4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4359f0>, '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 0x10f194cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3ff990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L7cpMrKHAy/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.95wtk6II3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:21:59 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 16:21:59 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 16:21:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L7cpMrKHAy/Render', 16:21:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:59 INFO - 'HOME': '/Users/cltbld', 16:21:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:59 INFO - 'LOGNAME': 'cltbld', 16:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:59 INFO - 'MOZ_NO_REMOTE': '1', 16:21:59 INFO - 'NO_EM_RESTART': '1', 16:21:59 INFO - 'PAGER': '/bin/cat', 16:21:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:59 INFO - 'PWD': '/builds/slave/test', 16:21:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:59 INFO - 'SHELL': '/bin/bash', 16:21:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.95wtk6II3e/Listeners', 16:21:59 INFO - 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', 16:21:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:59 INFO - 'USER': 'cltbld', 16:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:59 INFO - 'XPC_FLAGS': '0x0', 16:21:59 INFO - 'XPC_SERVICE_NAME': '0', 16:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:59 INFO - Downloading/unpacking psutil>=0.7.1 16:21:59 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 16:21:59 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 16:21:59 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 16:21:59 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 16:21:59 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 16:21:59 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 16:22:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:22:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:22:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:22:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:22:02 INFO - Installing collected packages: psutil 16:22:02 INFO - Running setup.py install for psutil 16:22:02 INFO - building 'psutil._psutil_osx' extension 16:22:02 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 16:22:02 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 16:22:02 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 16:22:02 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 16:22:02 INFO - building 'psutil._psutil_posix' extension 16:22:02 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 16:22:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:22:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:22:02 INFO - ^ 16:22:02 INFO - 1 warning generated. 16:22:02 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 16:22:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:22:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:22:03 INFO - Successfully installed psutil 16:22:03 INFO - Cleaning up... 16:22:03 INFO - Return code: 0 16:22:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:03 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 0x10f480a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49af4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4359f0>, '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 0x10f194cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3ff990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L7cpMrKHAy/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.95wtk6II3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:22:03 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 16:22:03 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 16:22:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L7cpMrKHAy/Render', 16:22:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:22:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:22:03 INFO - 'HOME': '/Users/cltbld', 16:22:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:22:03 INFO - 'LOGNAME': 'cltbld', 16:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:03 INFO - 'MOZ_NO_REMOTE': '1', 16:22:03 INFO - 'NO_EM_RESTART': '1', 16:22:03 INFO - 'PAGER': '/bin/cat', 16:22:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:03 INFO - 'PWD': '/builds/slave/test', 16:22:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:22:03 INFO - 'SHELL': '/bin/bash', 16:22:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.95wtk6II3e/Listeners', 16:22:03 INFO - 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', 16:22:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:22:03 INFO - 'USER': 'cltbld', 16:22:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:22:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:03 INFO - 'XPC_FLAGS': '0x0', 16:22:03 INFO - 'XPC_SERVICE_NAME': '0', 16:22:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:22:03 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 16:22:03 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 16:22:03 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 16:22:03 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 16:22:03 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 16:22:03 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 16:22:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:22:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:22:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:22:05 INFO - Installing collected packages: mozsystemmonitor 16:22:05 INFO - Running setup.py install for mozsystemmonitor 16:22:06 INFO - Successfully installed mozsystemmonitor 16:22:06 INFO - Cleaning up... 16:22:06 INFO - Return code: 0 16:22:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:22: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')]} 16:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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')]} 16:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f480a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49af4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4359f0>, '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 0x10f194cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3ff990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L7cpMrKHAy/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.95wtk6II3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:22:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:22:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L7cpMrKHAy/Render', 16:22:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:22:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:22:06 INFO - 'HOME': '/Users/cltbld', 16:22:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:22:06 INFO - 'LOGNAME': 'cltbld', 16:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:06 INFO - 'MOZ_NO_REMOTE': '1', 16:22:06 INFO - 'NO_EM_RESTART': '1', 16:22:06 INFO - 'PAGER': '/bin/cat', 16:22:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:06 INFO - 'PWD': '/builds/slave/test', 16:22:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:22:06 INFO - 'SHELL': '/bin/bash', 16:22:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.95wtk6II3e/Listeners', 16:22:06 INFO - 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', 16:22:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:22:06 INFO - 'USER': 'cltbld', 16:22:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:22:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:06 INFO - 'XPC_FLAGS': '0x0', 16:22:06 INFO - 'XPC_SERVICE_NAME': '0', 16:22:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:06 INFO - Downloading/unpacking blobuploader==1.2.4 16:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:08 INFO - Downloading blobuploader-1.2.4.tar.gz 16:22:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:22:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:22:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:22:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:10 INFO - Downloading docopt-0.6.1.tar.gz 16:22:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:22:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:22:10 INFO - Installing collected packages: blobuploader, requests, docopt 16:22:10 INFO - Running setup.py install for blobuploader 16:22:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:22:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:22:10 INFO - Running setup.py install for requests 16:22:11 INFO - Running setup.py install for docopt 16:22:11 INFO - Successfully installed blobuploader requests docopt 16:22:11 INFO - Cleaning up... 16:22:11 INFO - Return code: 0 16:22:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22:11 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')]} 16:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:11 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')]} 16:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:11 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 0x10f480a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49af4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4359f0>, '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 0x10f194cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3ff990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L7cpMrKHAy/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.95wtk6II3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:22:11 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 16:22:11 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 16:22:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L7cpMrKHAy/Render', 16:22:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:22:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:22:11 INFO - 'HOME': '/Users/cltbld', 16:22:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:22:11 INFO - 'LOGNAME': 'cltbld', 16:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:11 INFO - 'MOZ_NO_REMOTE': '1', 16:22:11 INFO - 'NO_EM_RESTART': '1', 16:22:11 INFO - 'PAGER': '/bin/cat', 16:22:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:11 INFO - 'PWD': '/builds/slave/test', 16:22:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:22:11 INFO - 'SHELL': '/bin/bash', 16:22:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.95wtk6II3e/Listeners', 16:22:11 INFO - 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', 16:22:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:22:11 INFO - 'USER': 'cltbld', 16:22:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:22:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:11 INFO - 'XPC_FLAGS': '0x0', 16:22:11 INFO - 'XPC_SERVICE_NAME': '0', 16:22:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:22:11 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-FS0dQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:22:11 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-T1eWjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:22:11 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-yzzmo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:22:11 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-O2uwvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:22:12 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-G3VCJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:22:12 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-scag1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:22:12 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-3htCHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:22:12 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-nwsMje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:22:12 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-EKMUjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:22:12 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-Hny_Vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:22:12 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-DhLSoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:22:12 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-iLLd5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:22:13 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-0997_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:22:13 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-6XQJnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:13 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-N3Pu9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:22:13 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-0r0Vlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:22:13 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-elxkzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:22:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:22:13 INFO - Running setup.py install for manifestparser 16:22:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:22:13 INFO - Running setup.py install for mozcrash 16:22:13 INFO - Running setup.py install for mozdebug 16:22:14 INFO - Running setup.py install for mozdevice 16:22:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:22:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:22:14 INFO - Running setup.py install for mozfile 16:22:14 INFO - Running setup.py install for mozhttpd 16:22:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:22:14 INFO - Running setup.py install for mozinfo 16:22:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:22:14 INFO - Running setup.py install for mozInstall 16:22:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:22:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:22:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:22:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:22:15 INFO - Running setup.py install for mozleak 16:22:15 INFO - Running setup.py install for mozlog 16:22:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:22:15 INFO - Running setup.py install for moznetwork 16:22:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:22:15 INFO - Running setup.py install for mozprocess 16:22:15 INFO - Running setup.py install for mozprofile 16:22:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:22:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:22:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:22:15 INFO - Running setup.py install for mozrunner 16:22:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:22:16 INFO - Running setup.py install for mozscreenshot 16:22:16 INFO - Running setup.py install for moztest 16:22:16 INFO - Running setup.py install for mozversion 16:22:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:22:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:22:16 INFO - Cleaning up... 16:22:16 INFO - Return code: 0 16:22:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10f480a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49af4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4359f0>, '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 0x10f194cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3ff990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L7cpMrKHAy/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.95wtk6II3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:22:16 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 16:22:16 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 16:22:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L7cpMrKHAy/Render', 16:22:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:22:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:22:16 INFO - 'HOME': '/Users/cltbld', 16:22:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:22:16 INFO - 'LOGNAME': 'cltbld', 16:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:16 INFO - 'MOZ_NO_REMOTE': '1', 16:22:16 INFO - 'NO_EM_RESTART': '1', 16:22:16 INFO - 'PAGER': '/bin/cat', 16:22:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:16 INFO - 'PWD': '/builds/slave/test', 16:22:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:22:16 INFO - 'SHELL': '/bin/bash', 16:22:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.95wtk6II3e/Listeners', 16:22:16 INFO - 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', 16:22:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:22:16 INFO - 'USER': 'cltbld', 16:22:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:22:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:16 INFO - 'XPC_FLAGS': '0x0', 16:22:16 INFO - 'XPC_SERVICE_NAME': '0', 16:22:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:22:16 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-OsrUV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:22:17 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)) 16:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:22:17 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-uUPftN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:22:17 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)) 16:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:22:17 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-m1jLEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:22:17 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)) 16:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:22:17 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-JGlQQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:22:17 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)) 16:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:22:17 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-VTmE3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:22:17 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)) 16:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:22:17 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-6QmnhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:22:17 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)) 16:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:22:17 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-ATeNnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:22:17 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)) 16:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:22:17 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-av0MCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:22:17 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)) 16:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:22:17 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-Rt2D4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:22:18 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)) 16:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:22:18 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-Yh5DSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:22:18 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)) 16:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:22:18 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-fULjRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:22:18 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)) 16:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:22:18 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-x2V9RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:22:18 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)) 16:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:22:18 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-PSeCxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:22:18 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)) 16:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:22:18 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-IHwfmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:22:18 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)) 16:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:18 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-vNja3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:18 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)) 16:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:22:18 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-KcL9Uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:22:18 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)) 16:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:22:18 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-p74v_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:22:19 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)) 16:22:19 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)) 16:22:19 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)) 16:22:19 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)) 16:22:19 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)) 16:22:19 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)) 16:22:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22: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 16:22:21 INFO - Downloading blessings-1.5.1.tar.gz 16:22:21 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 16:22:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:22:21 INFO - Installing collected packages: blessings 16:22:21 INFO - Running setup.py install for blessings 16:22:21 INFO - Successfully installed blessings 16:22:21 INFO - Cleaning up... 16:22:21 INFO - Return code: 0 16:22:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:22:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:22:22 INFO - Reading from file tmpfile_stdout 16:22:22 INFO - Current package versions: 16:22:22 INFO - blessings == 1.5.1 16:22:22 INFO - blobuploader == 1.2.4 16:22:22 INFO - docopt == 0.6.1 16:22:22 INFO - manifestparser == 1.1 16:22:22 INFO - mozInstall == 1.12 16:22:22 INFO - mozcrash == 0.16 16:22:22 INFO - mozdebug == 0.1 16:22:22 INFO - mozdevice == 0.47 16:22:22 INFO - mozfile == 1.2 16:22:22 INFO - mozhttpd == 0.7 16:22:22 INFO - mozinfo == 0.9 16:22:22 INFO - mozleak == 0.1 16:22:22 INFO - mozlog == 3.0 16:22:22 INFO - moznetwork == 0.27 16:22:22 INFO - mozprocess == 0.22 16:22:22 INFO - mozprofile == 0.27 16:22:22 INFO - mozrunner == 6.11 16:22:22 INFO - mozscreenshot == 0.1 16:22:22 INFO - mozsystemmonitor == 0.0 16:22:22 INFO - moztest == 0.7 16:22:22 INFO - mozversion == 1.4 16:22:22 INFO - psutil == 3.1.1 16:22:22 INFO - requests == 1.2.3 16:22:22 INFO - wsgiref == 0.1.2 16:22:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22: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')]} 16:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22: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')]} 16:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:22:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f480a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd49af4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4359f0>, '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 0x10f194cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3ff990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L7cpMrKHAy/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.95wtk6II3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:22:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L7cpMrKHAy/Render', 16:22:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:22:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:22:22 INFO - 'HOME': '/Users/cltbld', 16:22:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:22:22 INFO - 'LOGNAME': 'cltbld', 16:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:22 INFO - 'MOZ_NO_REMOTE': '1', 16:22:22 INFO - 'NO_EM_RESTART': '1', 16:22:22 INFO - 'PAGER': '/bin/cat', 16:22:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:22 INFO - 'PWD': '/builds/slave/test', 16:22:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:22:22 INFO - 'SHELL': '/bin/bash', 16:22:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.95wtk6II3e/Listeners', 16:22:22 INFO - 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', 16:22:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:22:22 INFO - 'USER': 'cltbld', 16:22:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:22:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:22 INFO - 'XPC_FLAGS': '0x0', 16:22:22 INFO - 'XPC_SERVICE_NAME': '0', 16:22:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:22 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)) 16:22:22 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)) 16:22:22 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)) 16:22:22 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)) 16:22:22 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)) 16:22:22 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)) 16:22:22 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)) 16:22:22 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)) 16:22:22 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)) 16:22:22 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)) 16:22:22 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)) 16:22:22 INFO - Cleaning up... 16:22:22 INFO - Return code: 0 16:22:22 INFO - Running post-action listener: _resource_record_post_action 16:22:22 INFO - Running post-action listener: _start_resource_monitoring 16:22:22 INFO - Starting resource monitoring. 16:22:22 INFO - ##### 16:22:22 INFO - ##### Running install step. 16:22:22 INFO - ##### 16:22:22 INFO - Running pre-action listener: _resource_record_pre_action 16:22:22 INFO - Running main action method: install 16:22:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:22:22 INFO - Reading from file tmpfile_stdout 16:22:22 INFO - Detecting whether we're running mozinstall >=1.0... 16:22:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:22:22 INFO - Reading from file tmpfile_stdout 16:22:22 INFO - Output received: 16:22:22 INFO - Usage: mozinstall [options] installer 16:22:22 INFO - Options: 16:22:22 INFO - -h, --help show this help message and exit 16:22:22 INFO - -d DEST, --destination=DEST 16:22:22 INFO - Directory to install application into. [default: 16:22:22 INFO - "/builds/slave/test"] 16:22:22 INFO - --app=APP Application being installed. [default: firefox] 16:22:22 INFO - mkdir: /builds/slave/test/build/application 16:22:22 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'] 16:22:22 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 16:23:00 INFO - Reading from file tmpfile_stdout 16:23:00 INFO - Output received: 16:23:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:23:00 INFO - Running post-action listener: _resource_record_post_action 16:23:00 INFO - ##### 16:23:00 INFO - ##### Running run-tests step. 16:23:00 INFO - ##### 16:23:00 INFO - Running pre-action listener: _resource_record_pre_action 16:23:00 INFO - Running main action method: run_tests 16:23:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:23:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:23:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:23:00 INFO - 2015-11-05 16:23:00.784 screenresolution[2498:16661] starting screenresolution argv=screenresolution get 16:23:00 INFO - 2015-11-05 16:23:00.788 screenresolution[2498:16661] Display 0: 1600x1200x32@60 16:23:00 INFO - 2015-11-05 16:23:00.795 screenresolution[2499:16663] starting screenresolution argv=screenresolution list 16:23:00 INFO - Available Modes on Display 0 16:23:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:23:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:23:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:23:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:23:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:23:01 INFO - Intel HD Graphics 3000: 16:23:01 INFO - Chipset Model: Intel HD Graphics 3000 16:23:01 INFO - Type: GPU 16:23:01 INFO - Bus: Built-In 16:23:01 INFO - VRAM (Total): 512 MB 16:23:01 INFO - VRAM (Dynamic, Max): 10 16:23:01 INFO - Vendor: Intel (0x8086) 16:23:01 INFO - Device ID: 0x0116 16:23:01 INFO - Revision ID: 0x0009 16:23:01 INFO - Displays: 16:23:01 INFO - Display: 16:23:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:23:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:23:01 INFO - Display Serial Number: 1600x1200 60 16:23:01 INFO - Main Display: Yes 16:23:01 INFO - Mirror: Off 16:23:01 INFO - Online: Yes 16:23:01 INFO - Rotation: Supported 16:23:01 INFO - Return code: 0 16:23:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:23:01 INFO - Python 2.7.3 16:23:01 INFO - Return code: 0 16:23:01 INFO - grabbing minidump binary from tooltool 16:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:23:01 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 0x10f4359f0>, '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 0x10f194cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3ff990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:23:01 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 16:23:01 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 16:23:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:23:01 INFO - Return code: 0 16:23:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:23:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:23:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:23:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:23:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:23:01 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/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0029', '--webServer', 'localhost'] in /builds/slave/test/build 16:23:01 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/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0029 --webServer localhost 16:23:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L7cpMrKHAy/Render', 16:23:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:23:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:23:01 INFO - 'HOME': '/Users/cltbld', 16:23:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:23:01 INFO - 'LOGNAME': 'cltbld', 16:23:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:23:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:01 INFO - 'MOZ_NO_REMOTE': '1', 16:23:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:23:01 INFO - 'NO_EM_RESTART': '1', 16:23:01 INFO - 'PAGER': '/bin/cat', 16:23:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:01 INFO - 'PWD': '/builds/slave/test', 16:23:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:23:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:23:01 INFO - 'SHELL': '/bin/bash', 16:23:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.95wtk6II3e/Listeners', 16:23:01 INFO - 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', 16:23:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:23:01 INFO - 'USER': 'cltbld', 16:23:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:23:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:01 INFO - 'XPC_FLAGS': '0x0', 16:23:01 INFO - 'XPC_SERVICE_NAME': '0', 16:23:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:23:01 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/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0029', '--webServer', 'localhost'] with output_timeout 3600 16:23:01 INFO - mozversion INFO | application_buildid: 20151105140536 16:23:01 INFO - mozversion INFO | application_changeset: 319e09c9668b8d2937c49dabdfd84a30d8771ac1 16:23:01 INFO - mozversion INFO | application_display_name: Nightly 16:23:01 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:23:01 INFO - mozversion INFO | application_name: Firefox 16:23:01 INFO - mozversion INFO | application_remotingname: firefox 16:23:01 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:23:01 INFO - mozversion INFO | application_vendor: Mozilla 16:23:01 INFO - mozversion INFO | application_version: 45.0a1 16:23:01 INFO - mozversion INFO | platform_buildid: 20151105140536 16:23:01 INFO - mozversion INFO | platform_changeset: 319e09c9668b8d2937c49dabdfd84a30d8771ac1 16:23:01 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:23:01 INFO - mozversion INFO | platform_version: 45.0a1 16:23:01 INFO - 2015-11-05 16:23:01,416 DEBUG : using testdate: 1446769381 16:23:01 INFO - 2015-11-05 16:23:01,416 DEBUG : actual date: 1446769381 16:23:01 INFO - 2015-11-05 16:23:01,425 INFO : starting webserver on 'localhost:50032' 16:23:01 INFO - 2015-11-05 16:23:01,426 INFO : Starting test suite t-yosemite-r5-0029.e 16:23:01 INFO - 2015-11-05 16:23:01,426 INFO : Starting test dromaeo_css 16:23:01 INFO - 2015-11-05 16:23:01,427 DEBUG : operating with platform_type : mac_ 16:23:01 INFO - 2015-11-05 16:23:01,427 INFO : Initialising browser for dromaeo_css test... 16:23:01 INFO - 2015-11-05 16:23:01,461 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/tmpyNubSW/profile http://localhost:50032/getInfo.html 16:23:04 INFO - 2015-11-05 16:23:04,441 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:23:04 INFO - 2015-11-05 16:23:04,442 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:23:04 INFO - 2015-11-05 16:23:04,442 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:23:04 INFO - 2015-11-05 16:23:04,442 DEBUG : BROWSER_OUTPUT: __metrics 16:23:05 INFO - 2015-11-05 16:23:05,073 INFO : Browser initialized. 16:23:05 INFO - 2015-11-05 16:23:05,074 INFO : Running cycle 1/1 for dromaeo_css test... 16:23:05 INFO - 2015-11-05 16:23:05,074 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/tmpyNubSW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:23:17 INFO - 2015-11-05 16:23:17,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 233127936 16:23:17 INFO - 2015-11-05 16:23:17,087 DEBUG : BROWSER_OUTPUT: 16:24:06 INFO - 2015-11-05 16:24:06,935 DEBUG : BROWSER_OUTPUT: 1446769446927 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] 16:26:16 INFO - 2015-11-05 16:26:16,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50032/tests/dromaeo/cssquery-ext.html) 16:26:17 INFO - 2015-11-05 16:26:17,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 259952640 16:26:17 INFO - 2015-11-05 16:26:17,843 DEBUG : BROWSER_OUTPUT: 16:29:19 INFO - 2015-11-05 16:29:19,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/dromaeo/cssquery-ext.html (next: http://localhost:50032/tests/dromaeo/cssquery-jquery.html) 16:29:20 INFO - 2015-11-05 16:29:20,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 265535488 16:29:20 INFO - 2015-11-05 16:29:20,531 DEBUG : BROWSER_OUTPUT: 16:32:22 INFO - 2015-11-05 16:32:22,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50032/tests/dromaeo/cssquery-mootools.html) 16:32:22 INFO - 2015-11-05 16:32:22,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 266039296 16:32:22 INFO - 2015-11-05 16:32:22,823 DEBUG : BROWSER_OUTPUT: 16:35:24 INFO - 2015-11-05 16:35:24,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50032/tests/dromaeo/cssquery-prototype.html) 16:35:25 INFO - 2015-11-05 16:35:25,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 270766080 16:35:25 INFO - 2015-11-05 16:35:25,119 DEBUG : BROWSER_OUTPUT: 16:38:27 INFO - 2015-11-05 16:38:27,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50032/tests/dromaeo/cssquery-yui.html) 16:38:28 INFO - 2015-11-05 16:38:28,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 276393984 16:38:28 INFO - 2015-11-05 16:38:28,269 DEBUG : BROWSER_OUTPUT: 16:41:30 INFO - 2015-11-05 16:41:30,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/dromaeo/cssquery-yui.html (next: http://localhost:50032/tests/dromaeo/cssquery-dojo.html) 16:41:30 INFO - 2015-11-05 16:41:30,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 281985024 16:41:30 INFO - 2015-11-05 16:41:30,825 DEBUG : BROWSER_OUTPUT: 16:41:30 INFO - 2015-11-05 16:41:30,825 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:41:30 INFO - 2015-11-05 16:41:30,826 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:41:30 INFO - 2015-11-05 16:41:30,826 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:41:30 INFO - 2015-11-05 16:41:30,827 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:41:30 INFO - 2015-11-05 16:41:30,828 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3047.8018928769643;3141.4816555268394;3169.0492852144353;3209.582754241949;3296.060622722523;5098.107831129551;5151;5153.227015947609;5160.612954028449;5170.482951704837;4854.271859221119;4969.503049695038;4975.651704380694;5048.671836330636;5059.924101138486;4638.165130276549;4708.952910470885;4777.713337199762;4789.305550695164;4815.0610630926985;15.758609617873415;4645.233536466479;4673.369095172142;4774.73738944358;4783.736894470802;4671.579557839811;4699.859004229878;4720.834770783006;4764.0471905619015;4775.9283610745515;4692.906141877143;4696.319033740123;4729.929051064237;4753.619710423158;4808.134535783557;4531.796069176895;4568.565986231336;4616.515265897099;4730.550597693248;4738.265568836836;4781.450133234688;4971.602271818246;4975.477574854661;5048.747562621891;5123.333966584358;5301.7084060376665;5368.248445217672;5373;5400.243965844785;5418.756155972991;5251.422343542207;5382.515573598395;5448.182772584105;5460.781568737246;5559.416261292587;5035.62232832539;5044.142495775727;5074.59403247743;5083.923741143886;5089.287499750038;5505.917411238835;5531.363893152339;5543.6396634218645;5574.1917421973585;5597.272354593958;5105.387353517602;5206.271122042917;5243.318368612056;5286.1806420004195;5296.04671159195;5460.071787796084;5466.617336786467;5477.3427188737605;5477.835664930059;5511.834644960658;5247.790088396498;5343.091674415281;5363.383210930715;5385.838424847261;5416.8104116355735;5189.065968125774;5198.402183748842;5201.505856943584;5206.791728330824;5285.63000589955;4165.875023749292;4178.937315940263;4184.958150418518;4205.915881682349;4234.3860140279485;3702.0929872181487;3774.9433758493647;3817.4655548223272;3872.361060425055;3889.4554762333296;5067.569256613229;5101.668391554537;5124.436312005676;5130.9230361544605;5132.794688212504;5415.214793854948;5526.088195447786;5534.169874518854;5539.972300138474;5540.972295138498;4968.180250258739;5045.7981680732355;5124.718140502234;5217.843464696065;5224.8171314004585;4714.952850471452;4728.905421891543;4746.4541577719;4801.831935882227;4807.927881081787;5504.422035686275;5511.063119269814;5525.778968841281;5548.029094908375;5556.333240011144;5324.201369794562;5484.149956756709;5490.3411590609385;5522.972385138049;5542.61201715876;5422.918656220081;5432.945670543244;5492.395836457907;5493.2034854946605;5501.889962200814;5291.259223708606;5304.045271851104;5321;5324.627276090637;5357.491038351351;5300.178472336794;5309.309789727466;5318.468153184651;5376.542993845411;5386.973065134649;5174.249733788655;5202.947970520247;5271.71005594696;5291.497307755757;5301.469853014668;5142.202958541432;5191.143461328838;5276.366835979707;5301.416844147064;5339.439358867418;5193.844184674465;5233.790648374023;5241.9737901310245;5244.134717771525;5282.864184200415;5043.36957880265;5309.044372013074;5314.256004159498;5314.5216930476445;5364.436734142859;4992.15133427311;4993.976234871915;5084.6440749147205;5139.460356662496;5182.792688292426 16:41:30 INFO - 2015-11-05 16:41:30,829 DEBUG : BROWSER_OUTPUT: |1;ext.html;516.6512603992304;543.909461529633;549.4532939724975;552.8424399046272;557.7155650618183;36791.63208367916;37458.4381234281;37759.24481510368;37783;37980.240395192115;40092.398614020814;40665.18669626606;40669.38995915056;40768.796156019256;40864.795676021655;8662.6101825418;8781.38530302879;8788.516631585293;8819.823603527926;8868.778280542974;8416.368772342068;8573.699920502784;8647.65409383624;8694.652213911437;8709.564521773918;8530.87203691945;8605.053444121173;8607.526586037766;8627.396082274243;8642.697505587306;8502.914970850305;8518.190771876692;8673.739787806377;8707.303415726727;8711.912880871174;8493.362997775192;8601.913980860236;8620.051794302623;8637.870431943526;8648.524331161783;37603.43594846079;37989;38054.23891522182;38070.238595227944;38408.231835363134;2861.9427611447654;2971.2423332050407;3009.232645675361;3190.9310381022387;3277.115178901683;26069.348266293495;26469.867650661818;26663.466730665474;27109.593356099675;27232.45535089307;2285.931422057341;2299.6855471082317;2305.619572770491;2319.1766922742354;2320.0951628864755;257544;258353.9999999981;258631;258833;261520.9999999981;39935.60064399319;40514.1897162061;40763;54861.725691371284;55027.724861375435;39594;39927;39985.20029599392;40131.799341003694;40252.59747402547;13957.092788968685;14508.637284067772;14548.127112373291;14666.853331466762;14723.116613003254;11701.473433695504;11753.236039657395;11760.647180584596;11788.410579470992;11815.054795616503;13258.337083145803;13282.867171328357;13349.599512014462;13354.131981421177;13454.394552245172;5970.283565972024;6072.149899014142;6134.693265336716;6181.660008699565;6186.876262474725;853.906070332263;928.7724507495707;1008.0473952115327;1070.208046045936;1098.9890101099047;27260.86369568179;27355.452890942466;27519.44961100767;27579;27672.446551068864;1005.5927349423495;1010.4392062405288;1027.0705011964185;1052.7999680060916;1119.2445099557929;14301.57095287143;14606.780898286534;14739;15226.497905481801;15391;348207;349331;349903;350263;352237;55829;55927.88144237174;56051;56170.438295617336;56196.719016404655;1352.4319785690034;1358.7825947848296;1359.8572149924116;1375.4291968833022;1533.8236102848093;28746;28774.856125719238;28796;29083.272918177216;29136.854315728287;47003.764981176246;47361.52638473571;47578.52421475741;47589.5241047599;47654;266398;269915;269945;270824;271207;26654.46691066129;26942.326441838326;31062.22344441407;31725.36549269048;42644.343468025305;42033.15933681248;42183.78908105563;42587.57412425836;43419;43446.78276608597;34288.828555857064;35414.82292588521;35973;36030;36121.27757444889;34695.479567805996;34985.65014349824;34988.65011349854;35085.82457087698;35294.47058294179;35829.64170358263;35849.46225806563;35880.820595896854;37814.810925945196;38414.58232303321;29762.70237297686;30985.845070774503;31028.53457198099;31044.53433198549;31314.21714457157;23445;30008.699913001463;31051.534226987063;31500;32082.67917320797 16:41:30 INFO - 2015-11-05 16:41:30,833 DEBUG : BROWSER_OUTPUT: |2;jquery.html;311.41143239277784;315.81051369178493;316.80041573808495;321.86642543344516;325.07029894501727;11265.380404077772;11696.239744416607;17065.573360665974;17619.383321583748;17683.469495915127;11299.435028248576;11356.432178391067;11390.7152321192;11433.314001159915;11709.70725731857;4180.393842892787;4298.419713338691;4301.827926882921;4302.569743025703;4312.935305970413;4177.248095342837;4233.386159006942;4244.087521182945;4318.870433886988;4325;4222.134462435209;4257.425247591582;4280.4221430107;4426.933595996063;4465.263231566803;4267.551907049746;4418.381426600278;4420.182266280733;4422.712523685982;4457.99695068607;3665;3739.046543131484;3786.3941769316775;3791.469194312798;3810.504634397538;12666.303353315656;12733;12748.61754147377;22951.31146065621;22977.88511057451;1911.961760764777;1914.6745053340965;1917.9808201917942;1962.2347284559035;2026.63520566298;13429.865701342958;13430;13505.86494135056;13704.862951370458;13979.37092830825;1567.482730698878;1665.1840598106962;1665.7917760279965;1677.6728537935107;1730.7057800174;51703.74148129235;54855.451445485436;57593.424065759646;63989.68005159991;67237;16276.75584866228;16648.667026659397;16651.41720039817;16766.664666706598;16890.74663880043;23489.765102349098;23609.527809443716;23658.4085397863;23671.644925326134;23696.526069478514;9530.904690953003;9658.3722058066;9707.805843883083;9758.024197580327;9769.071938165864;8227.917720822836;8308.916910830936;8313;8327.458715183615;8336.62485188168;7685.692572297157;7901.881471777928;7914.920850791534;7917.920820791834;7922.286994170552;3203.7757356985253;3211.855466504013;3224.2584205632365;3233.417984762765;3257.560229369005;379.28694055176095;387.4343458550548;395.2608621877051;403.16745919675776;419.24326590503824;10909.563617455371;11019.504122314514;11187.272827266364;11247;11273.267237629529;434.9391085248068;436.7706953849191;452.7351499372904;454.4069988664824;469.4296429837764;5909.379515150933;6056.121862330026;6065.5450841187085;6075.3924607539775;6143.56995010345;506617;523165;534129;545541;546322;65722.67138664372;68608.6569567159;68875;68924.3107568928;69678.30321696718;439.21380728496274;446.3037661248463;448.4081013062726;450.14921797801526;450.9481409637868;10134.087932086148;10319.587216511256;10397.896021039693;10460.110890574386;10509.789804204025;32172.517412239304;32848.67151328552;33311.50032749559;33355.49966750452;33519;44738.3289250655;44956.550434495235;45256.54743452524;45442.545574545155;46080.53919460763;5747.827565173052;5815.883682326415;5827.621204621686;5865.384134665798;5878.559108066997;10806.837897431702;10861.565537378416;10935.890641093487;10995.175361847734;11082.445877706245;8106.959465202636;8296.377771667028;9362.391444556082;9375.953120234355;9513.90486095158;8330.750077497685;8553.657853685783;8763.60563774619;8864.689735859214;8964.955175224082;9005.864912026456;9066.138716821892;9100.954495227481;9171.724848254564;9185;5435.782568697366;5528.723563821713;5556.72216389187;5562.3047119110115;5591.30108736408;8880.777980550538;9009.63961441535;9078.45529268246;9265.675701350421;9310.208632266333 16:41:30 INFO - 2015-11-05 16:41:30,835 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1470.0518165783064;1588.5472640297514;1664.5672125247431;1688.0462538665654;1710.5210541048502;6481.1250481185025;6591.077249185118;6937.514373993822;7176.964115179423;7279;6825.35159159879;6923.446124310056;7042.718291268356;7087.89368159478;7102.9644851775665;2044.8057434543693;2088;2096.90563924623;2105.2421128393767;2108.4939614492487;2081.8022287882627;2101;2108.5150415404464;2120.321497120914;2127.7340332458443;2037.4906273431643;2061.670132778748;2065.266830275253;2083.708280840676;2087.5720477302193;2068.1934045722182;2071.720317757106;2071.8135367816894;2087.425957861585;2098.3914664747203;2019.4446527205137;2043.1827269092332;2067.1937944201773;2069.5860827834495;2092.9162833486644;7075.39859111971;7098.290170982912;7126.144862616467;7153.713851445936;7173.641317934134;4247.8088486018205;4329.675274354436;4348.043430445297;4348.586884246023;4406.405135306724;2405.9759402406103;2483.192962287246;2655.2830735701446;2727.1136880513914;2728.086091159464;774.0865778381508;809.6882700160422;814.771863878115;830.2859540794911;831.1522247307712;9062;9087.772805679844;9101.499417532033;9119.088091190828;9156.954215228949;3945.270125026879;4011.859584914514;4031.657309128698;4062.7156099073372;4100.91798164035;8015.919840801634;8016.679332826621;8050;8051.677932882736;8060.758177254692;4442.68901176921;4447.177272204653;4476.127155204769;4480.843170489017;4509.458864936229;4046.4537287465814;4099.959000410017;4111.280525907954;4119.155573107506;4136.544980052192;3400.9319813604084;3429.6741809528053;3452.7065199457825;3459.550258466383;3472.930541389158;1113.1039513191959;1113.265244938353;1118.2731224703846;1119.4458742922307;1138.65271092316;1249.9312537810326;1262.1354372255034;1262.8042653388738;1264.0456455376132;1277.118788036252;6587.242467116247;6610.0745895574655;6694.430973367318;6701.195856497252;6717.462602991749;428.1650780977045;435.9515365545867;437.5864807756703;437.72621670937417;442.5729171349663;5277.129273669878;5370.892582148335;5383.865403364947;5391.649542779707;5393.5954803389905;7560.621968901533;7746.38028957682;8056;8204.343652507785;8286.46138001028;8100;8142.918570814216;8224.876626850602;8241.217084376975;8247.670093196204;6501.739930402826;6562.967185164043;6589.901151482732;6605.636689982001;6661.500387470862;6561.770338038145;6647.268800432045;6652.201735791736;6662.56693314933;6664.933350666625;7310.488265821342;7434.73978410753;7441.55350678961;7462.029936108272;7464.962675186806;7457.962710186414;7552.546847189186;7639.541627502145;7659.693612255447;7677.193894641206;6176.845578860564;6246.5002799775;6247.750089996531;6248.4376406123665;6282.623042617458;6641.900371494528;6793.864122717419;6846.178458585002;6860.965695171492;6884.4148247399535;6152.077188421773;6232.875342493216;6381.457576105898;6460.12788273577;6500.869982600416;6206.503479721521;6299.11812346281;6306.148669929501;6321.0834429008455;6338.954072577973;6196.1635179252025;6317.368263173646;6328.493720502257;6347.936520634919;6351.777687780906;5563.693996830213;5584.832455026356;5621.297337832771;5648.802291919763;5654.264945557051;5980.132880732356;6002.129691194839;6005.6396616203165;6013.067974463965;6064.909026364519 16:41:30 INFO - 2015-11-05 16:41:30,836 DEBUG : BROWSER_OUTPUT: |4;prototype.html;295.7294075920533;300.7924532072871;305.11060259344026;305.6103468078201;306.20692406666734;5808.564357673175;5860.970695146523;5868.76524939003;5881.558883083764;5892.852678683024;5761.279840019997;5761.654300741959;5768.625039372438;5780.306363236417;5791.739371728272;4297.5057868345075;4442.133783912139;4455.532169122244;4455.910881782371;4503.954960450386;4359.912801743979;4394.6703997200175;4400.845970391037;4403.273459879116;4429.42417485728;4329.307310830268;4333.956660433402;4352.6300264477395;4352.890013046669;4365.716228445157;4330.545292744279;4342.869713908588;4343.739375637456;4348.652107831366;4364.018095928423;3735.8979101165223;3737.9626203737885;3740.532433445819;3783.356829339019;3783.375743002401;5573.024720673866;5573.247611572427;5673.063944449161;5704.429557044304;5705.942940570582;4927.5318844710055;4928.063667903087;4932.0629080474955;4937.703737775745;4938.407391113054;6059.66671833049;6074.939250607482;6078.209832721718;6084.665343406111;6103.847403814896;3923.234969181011;4031.7984100794843;4052.53395859477;4057.6956728245204;4085.387191921206;6414.8717025659225;6480.157579514633;6486.708098135548;6497.382748638872;6506.707198176094;4165.021220013295;4175.164967006611;4176.874693759192;4187.623113919762;4197.706160568792;4212.452381190487;4223.68322375823;4266.743995360288;4269.935950960738;4270.743755374688;4810.2063159578975;4955.934474088089;4964.801407943642;4988.201887698024;4991.800327986913;6113;6151.938480615226;6162.198914141222;6171.9691401542705;6215.720292586844;1496.4313560846808;1505.503183949294;1511.4029958166464;1517.484055421162;1517.833038365779;960.865478832964;973.6543527047937;975.5609975511048;983.3509883476871;989.8911119776819;5940.821775346746;5959.344472108065;5977.731002104916;5988.520918326523;6001.219841420588;6372.426481616677;6400.103985442041;6414.294427612959;6421.068945002949;6460.741570337133;5916.3787802281;5946.226990491295;5959.255093113361;5970.432808883149;5974.701264936736;3385.153711572107;3510.227749895019;3543.2204914919193;3547.592026916886;3548.8757893473603;6385.936140638627;6481.513886458534;6506.3818937200895;6536.771213007617;6554.934450655528;6443.548951573345;6476.935230647728;6509.2839787623325;6518.315576864456;6520.869582608321;6458.418742313214;6470.352964703586;6472.190976127984;6475.352464753581;6516.706748196248;6257.311695713559;6347.174867267226;6370.362963703593;6377.713002914973;6378.840528986812;6235.688215589294;6240.594361366497;6255.218097737783;6256.249250090018;6285.528585356025;6525.1517302750335;6527.804165875032;6540.705668245036;6546.672666366758;6554.082428460115;4087.080406908422;4137.50349958007;4142.502899652061;4166.604172603597;4177.101923086551;6157.630542167484;6271.874562508816;6427.55007149495;6443;6452.806415807533;6197.845053873689;6220.968895155495;6225.159603453476;6227.875442491216;6239.75040998355;6245.68771561411;6255.812325630239;6256.0303153011355;6258.186435763321;6263.843403914939;5939.732712027882;6037.124616930609;6064.666443345482;6121.32665406796;6134.877302453837;6290.654014029273;6291.748330066929;6292.056191571301;6292.402221788922;6298.401651843067;6047.48596369296;6108.17539632144;6108.602940808833;6128.417800308964;6188.504919606511 16:41:30 INFO - 2015-11-05 16:41:30,838 DEBUG : BROWSER_OUTPUT: |5;yui.html;685.6811582614083;710.2081179484869;711.9110111236096;715.6242972439469;724.54353757133;12801.935990320047;12877.871221287784;13074.607761767138;13097.7380452391;13100.606981790537;12277.754444911096;12423.875761242385;12431.937840310786;12450.626481205556;12455.750884982295;823.5305875650881;826.6528058215564;845.6997765793147;847.8685803700405;852.3735054734765;830.6926437218208;845.0746432656232;849.9320054395633;850.8255807559435;853.185208126241;862.3532350736947;877.2674816528206;880.1198801198801;886.835935351962;886.8980067292247;867.5748883047293;868.3400615532178;874.2263097158997;875.4178471316567;876.9736907892742;631.0156156396037;631.8388810853249;635.4693830651412;637.3053371824687;643.3212960326854;12709.936450317782;12783.61649150527;12813.93593032029;12965.092443528956;12966.027547933849;8813.603387847497;9141.817163656757;9372.203362714177;9576.23390128788;9656.951715241448;8371.874421883676;8492.66029358825;8555.614997325136;8638.524881131536;8644.783880402978;2783.178962206154;2834.7732181425436;2943.7644988400875;2956.127942257039;2973.04862444018;40149;40779.18441631181;40785.59214407847;40923.7953810232;45606.31590526145;6290.654014029181;6389.616623002635;6498.902516462257;6559.212894452697;6618.271990081087;11486.712832179262;11512.597059103058;11545.595904143314;11581.247218930743;11597.304161750153;5712.857178570569;5718.056520674126;5733.541316694655;5861.413858614104;5951.432327981157;3481.2515309208643;3699.408094704834;3726.832292546842;3764.6235376462682;3784.0918179636687;2566.8459892406518;2600.726923672987;2615.856127912983;2619.1749598876295;2619.3975385661406;368.7934756536348;370.73492452896306;375.7557587568103;379.23394742620303;382.1516233960603;487.5928599619287;542.2814770429197;550.7604192176416;566.832784328624;575.7840809696364;7333.853322933512;7438.2933621306975;7469.589172595451;7698.538087714643;7700.229977002255;430.2148578843623;463.594354939428;485.35447854353623;557.3005877623557;562.353293712226;3482.703970162514;3523.4320727276117;3523.4714792781288;3579.4093974493917;3676.117731744362;56827.71586142043;56905.43094569084;57391;57915;61120.38879611236;49976.75011624918;50175.74912125416;50204.49795501998;50410.74794626003;50544.49455505471;46807.999999999316;46858.29712554315;47008.294875576896;47896.521034789206;48238.75880620575;7692.730754423568;7760.68957241704;7773.41699372538;7987.201279872199;8019.438639295194;33214.335713285116;34268.48597271093;34405;34823.12942176466;35020.47469287912;44839.775801120784;45358.546414535434;45955.31067034064;46498.76750616225;47034;7215.458840587082;7293.927060729325;7351.632418378953;7410.296021877913;7446.25537446251;10412.791744165226;10547.261691681815;10609.628662996758;10682.893171068501;10782.245242832927;9971.850422243817;10325.028856776431;10494.317869338469;10688.946555267174;10742.785144297226;9988.200943924323;10324.690259292232;10381.896181038093;10474.633387831389;10517.579296828348;9881.20950323958;9991.100800927952;10225.84661230097;10258.948705256425;10295.352743560994;8622.396432249683;8683.292415040894;8720.984962964647;8865.290776737716;9003.61404227867;8456.2812160967;8869.778255543662;8914.197722205032;9005.774855628662;9090.454572725657 16:41:30 INFO - 2015-11-05 16:41:30,838 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:41:30 INFO - 2015-11-05 16:41:30,838 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:41:30 INFO - 2015-11-05 16:41:30,839 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,282 16:41:30 INFO - 2015-11-05 16:41:30,839 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:41:30 INFO - 2015-11-05 16:41:30,839 DEBUG : BROWSER_OUTPUT: __startTimestamp1446770490825__endTimestamp 16:41:30 INFO - 2015-11-05 16:41:30,839 DEBUG : BROWSER_OUTPUT: 16:41:30 INFO - 2015-11-05 16:41:30,839 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:41:30 INFO - 2015-11-05 16:41:30,839 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:41:30 INFO - 2015-11-05 16:41:30,840 DEBUG : BROWSER_OUTPUT: 16:41:30 INFO - 2015-11-05 16:41:30,840 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5009.29 Median:5189.07 stddev:642.37 (12.4%) stddev-sans-first:625.63 16:41:30 INFO - 2015-11-05 16:41:30,841 DEBUG : BROWSER_OUTPUT: Values: 3047.8 3141.5 3169.0 3209.6 3296.1 5098.1 5151.0 5153.2 5160.6 5170.5 4854.3 4969.5 4975.7 5048.7 5059.9 4638.2 4709.0 4777.7 4789.3 4815.1 15.8 4645.2 4673.4 4774.7 4783.7 4671.6 4699.9 4720.8 4764.0 4775.9 4692.9 4696.3 4729.9 4753.6 4808.1 4531.8 4568.6 4616.5 4730.6 4738.3 4781.5 4971.6 4975.5 5048.7 5123.3 5301.7 5368.2 5373.0 5400.2 5418.8 5251.4 5382.5 5448.2 5460.8 5559.4 5035.6 5044.1 5074.6 5083.9 5089.3 5505.9 5531.4 5543.6 5574.2 5597.3 5105.4 5206.3 5243.3 5286.2 5296.0 5460.1 5466.6 5477.3 5477.8 5511.8 5247.8 5343.1 5363.4 5385.8 5416.8 5189.1 5198.4 5201.5 5206.8 5285.6 4165.9 4178.9 4185.0 4205.9 4234.4 3702.1 3774.9 3817.5 3872.4 3889.5 5067.6 5101.7 5124.4 5130.9 5132.8 5415.2 5526.1 5534.2 5540.0 5541.0 4968.2 5045.8 5124.7 5217.8 5224.8 4715.0 4728.9 4746.5 4801.8 4807.9 5504.4 5511.1 5525.8 5548.0 5556.3 5324.2 5484.1 5490.3 5523.0 5542.6 5422.9 5432.9 5492.4 5493.2 5501.9 5291.3 5304.0 5321.0 5324.6 5357.5 5300.2 5309.3 5318.5 5376.5 5387.0 5174.2 5202.9 5271.7 5291.5 5301.5 5142.2 5191.1 5276.4 5301.4 5339.4 5193.8 5233.8 5242.0 5244.1 5282.9 5043.4 5309.0 5314.3 5314.5 5364.4 4992.2 4994.0 5084.6 5139.5 5182.8 16:41:30 INFO - 2015-11-05 16:41:30,841 DEBUG : BROWSER_OUTPUT: 16:41:30 INFO - 2015-11-05 16:41:30,841 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45083.49 Median:193661.41 stddev:77464.64 (40.0%) stddev-sans-first:77609.68 16:41:30 INFO - 2015-11-05 16:41:30,843 DEBUG : BROWSER_OUTPUT: Values: 516.7 543.9 549.5 552.8 557.7 36791.6 37458.4 37759.2 37783.0 37980.2 40092.4 40665.2 40669.4 40768.8 40864.8 8662.6 8781.4 8788.5 8819.8 8868.8 8416.4 8573.7 8647.7 8694.7 8709.6 8530.9 8605.1 8607.5 8627.4 8642.7 8502.9 8518.2 8673.7 8707.3 8711.9 8493.4 8601.9 8620.1 8637.9 8648.5 37603.4 37989.0 38054.2 38070.2 38408.2 2861.9 2971.2 3009.2 3190.9 3277.1 26069.3 26469.9 26663.5 27109.6 27232.5 2285.9 2299.7 2305.6 2319.2 2320.1 257544.0 258354.0 258631.0 258833.0 261521.0 39935.6 40514.2 40763.0 54861.7 55027.7 39594.0 39927.0 39985.2 40131.8 40252.6 13957.1 14508.6 14548.1 14666.9 14723.1 11701.5 11753.2 11760.6 11788.4 11815.1 13258.3 13282.9 13349.6 13354.1 13454.4 5970.3 6072.1 6134.7 6181.7 6186.9 853.9 928.8 1008.0 1070.2 1099.0 27260.9 27355.5 27519.4 27579.0 27672.4 1005.6 1010.4 1027.1 1052.8 1119.2 14301.6 14606.8 14739.0 15226.5 15391.0 348207.0 349331.0 349903.0 350263.0 352237.0 55829.0 55927.9 56051.0 56170.4 56196.7 1352.4 1358.8 1359.9 1375.4 1533.8 28746.0 28774.9 28796.0 29083.3 29136.9 47003.8 47361.5 47578.5 47589.5 47654.0 266398.0 269915.0 269945.0 270824.0 271207.0 26654.5 26942.3 31062.2 31725.4 42644.3 42033.2 42183.8 42587.6 43419.0 43446.8 34288.8 35414.8 35973.0 36030.0 36121.3 34695.5 34985.7 34988.7 35085.8 35294.5 35829.6 35849.5 35880.8 37814.8 38414.6 29762.7 30985.8 31028.5 31044.5 31314.2 23445.0 30008.7 31051.5 31500.0 32082.7 16:41:30 INFO - 2015-11-05 16:41:30,843 DEBUG : BROWSER_OUTPUT: 16:41:30 INFO - 2015-11-05 16:41:30,843 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27087.20 Median:4307.75 stddev:86856.30 (2016.3%) stddev-sans-first:87076.68 16:41:30 INFO - 2015-11-05 16:41:30,845 DEBUG : BROWSER_OUTPUT: Values: 311.4 315.8 316.8 321.9 325.1 11265.4 11696.2 17065.6 17619.4 17683.5 11299.4 11356.4 11390.7 11433.3 11709.7 4180.4 4298.4 4301.8 4302.6 4312.9 4177.2 4233.4 4244.1 4318.9 4325.0 4222.1 4257.4 4280.4 4426.9 4465.3 4267.6 4418.4 4420.2 4422.7 4458.0 3665.0 3739.0 3786.4 3791.5 3810.5 12666.3 12733.0 12748.6 22951.3 22977.9 1912.0 1914.7 1918.0 1962.2 2026.6 13429.9 13430.0 13505.9 13704.9 13979.4 1567.5 1665.2 1665.8 1677.7 1730.7 51703.7 54855.5 57593.4 63989.7 67237.0 16276.8 16648.7 16651.4 16766.7 16890.7 23489.8 23609.5 23658.4 23671.6 23696.5 9530.9 9658.4 9707.8 9758.0 9769.1 8227.9 8308.9 8313.0 8327.5 8336.6 7685.7 7901.9 7914.9 7917.9 7922.3 3203.8 3211.9 3224.3 3233.4 3257.6 379.3 387.4 395.3 403.2 419.2 10909.6 11019.5 11187.3 11247.0 11273.3 434.9 436.8 452.7 454.4 469.4 5909.4 6056.1 6065.5 6075.4 6143.6 506617.0 523165.0 534129.0 545541.0 546322.0 65722.7 68608.7 68875.0 68924.3 69678.3 439.2 446.3 448.4 450.1 450.9 10134.1 10319.6 10397.9 10460.1 10509.8 32172.5 32848.7 33311.5 33355.5 33519.0 44738.3 44956.6 45256.5 45442.5 46080.5 5747.8 5815.9 5827.6 5865.4 5878.6 10806.8 10861.6 10935.9 10995.2 11082.4 8107.0 8296.4 9362.4 9376.0 9513.9 8330.8 8553.7 8763.6 8864.7 8965.0 9005.9 9066.1 9101.0 9171.7 9185.0 5435.8 5528.7 5556.7 5562.3 5591.3 8880.8 9009.6 9078.5 9265.7 9310.2 16:41:30 INFO - 2015-11-05 16:41:30,845 DEBUG : BROWSER_OUTPUT: 16:41:30 INFO - 2015-11-05 16:41:30,845 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4912.58 Median:6164.46 stddev:2486.52 (40.3%) stddev-sans-first:2480.03 16:41:30 INFO - 2015-11-05 16:41:30,845 DEBUG : BROWSER_OUTPUT: Values: 1470.1 1588.5 1664.6 1688.0 1710.5 6481.1 6591.1 6937.5 7177.0 7279.0 6825.4 6923.4 7042.7 7087.9 7103.0 2044.8 2088.0 2096.9 2105.2 2108.5 2081.8 2101.0 2108.5 2120.3 2127.7 2037.5 2061.7 2065.3 2083.7 2087.6 2068.2 2071.7 2071.8 2087.4 2098.4 2019.4 2043.2 2067.2 2069.6 2092.9 7075.4 7098.3 7126.1 7153.7 7173.6 4247.8 4329.7 4348.0 4348.6 4406.4 2406.0 2483.2 2655.3 2727.1 2728.1 774.1 809.7 814.8 830.3 831.2 9062.0 9087.8 9101.5 9119.1 9157.0 3945.3 4011.9 4031.7 4062.7 4100.9 8015.9 8016.7 8050.0 8051.7 8060.8 4442.7 4447.2 4476.1 4480.8 4509.5 4046.5 4100.0 4111.3 4119.2 4136.5 3400.9 3429.7 3452.7 3459.6 3472.9 1113.1 1113.3 1118.3 1119.4 1138.7 1249.9 1262.1 1262.8 1264.0 1277.1 6587.2 6610.1 6694.4 6701.2 6717.5 428.2 436.0 437.6 437.7 442.6 5277.1 5370.9 5383.9 5391.6 5393.6 7560.6 7746.4 8056.0 8204.3 8286.5 8100.0 8142.9 8224.9 8241.2 8247.7 6501.7 6563.0 6589.9 6605.6 6661.5 6561.8 6647.3 6652.2 6662.6 6664.9 7310.5 7434.7 7441.6 7462.0 7465.0 7458.0 7552.5 7639.5 7659.7 7677.2 6176.8 6246.5 6247.8 6248.4 6282.6 6641.9 6793.9 6846.2 6861.0 6884.4 6152.1 6232.9 6381.5 6460.1 6500.9 6206.5 6299.1 6306.1 6321.1 6339.0 6196.2 6317.4 6328.5 6347.9 6351.8 5563.7 5584.8 5621.3 5648.8 5654.3 5980.1 6002.1 6005.6 6013.1 6064.9 16:41:30 INFO - 2015-11-05 16:41:30,845 DEBUG : BROWSER_OUTPUT: 16:41:30 INFO - 2015-11-05 16:41:30,846 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5119.32 Median:5964.89 stddev:1584.39 (26.6%) stddev-sans-first:1546.92 16:41:30 INFO - 2015-11-05 16:41:30,846 DEBUG : BROWSER_OUTPUT: Values: 295.7 300.8 305.1 305.6 306.2 5808.6 5861.0 5868.8 5881.6 5892.9 5761.3 5761.7 5768.6 5780.3 5791.7 4297.5 4442.1 4455.5 4455.9 4504.0 4359.9 4394.7 4400.8 4403.3 4429.4 4329.3 4334.0 4352.6 4352.9 4365.7 4330.5 4342.9 4343.7 4348.7 4364.0 3735.9 3738.0 3740.5 3783.4 3783.4 5573.0 5573.2 5673.1 5704.4 5705.9 4927.5 4928.1 4932.1 4937.7 4938.4 6059.7 6074.9 6078.2 6084.7 6103.8 3923.2 4031.8 4052.5 4057.7 4085.4 6414.9 6480.2 6486.7 6497.4 6506.7 4165.0 4175.2 4176.9 4187.6 4197.7 4212.5 4223.7 4266.7 4269.9 4270.7 4810.2 4955.9 4964.8 4988.2 4991.8 6113.0 6151.9 6162.2 6172.0 6215.7 1496.4 1505.5 1511.4 1517.5 1517.8 960.9 973.7 975.6 983.4 989.9 5940.8 5959.3 5977.7 5988.5 6001.2 6372.4 6400.1 6414.3 6421.1 6460.7 5916.4 5946.2 5959.3 5970.4 5974.7 3385.2 3510.2 3543.2 3547.6 3548.9 6385.9 6481.5 6506.4 6536.8 6554.9 6443.5 6476.9 6509.3 6518.3 6520.9 6458.4 6470.4 6472.2 6475.4 6516.7 6257.3 6347.2 6370.4 6377.7 6378.8 6235.7 6240.6 6255.2 6256.2 6285.5 6525.2 6527.8 6540.7 6546.7 6554.1 4087.1 4137.5 4142.5 4166.6 4177.1 6157.6 6271.9 6427.6 6443.0 6452.8 6197.8 6221.0 6225.2 6227.9 6239.8 6245.7 6255.8 6256.0 6258.2 6263.8 5939.7 6037.1 6064.7 6121.3 6134.9 6290.7 6291.7 6292.1 6292.4 6298.4 6047.5 6108.2 6108.6 6128.4 6188.5 16:41:30 INFO - 2015-11-05 16:41:30,847 DEBUG : BROWSER_OUTPUT: 16:41:30 INFO - 2015-11-05 16:41:30,848 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12731.55 Median:546.52 stddev:15851.87 (2900.5%) stddev-sans-first:15870.53 16:41:30 INFO - 2015-11-05 16:41:30,848 DEBUG : BROWSER_OUTPUT: Values: 685.7 710.2 711.9 715.6 724.5 12801.9 12877.9 13074.6 13097.7 13100.6 12277.8 12423.9 12431.9 12450.6 12455.8 823.5 826.7 845.7 847.9 852.4 830.7 845.1 849.9 850.8 853.2 862.4 877.3 880.1 886.8 886.9 867.6 868.3 874.2 875.4 877.0 631.0 631.8 635.5 637.3 643.3 12709.9 12783.6 12813.9 12965.1 12966.0 8813.6 9141.8 9372.2 9576.2 9657.0 8371.9 8492.7 8555.6 8638.5 8644.8 2783.2 2834.8 2943.8 2956.1 2973.0 40149.0 40779.2 40785.6 40923.8 45606.3 6290.7 6389.6 6498.9 6559.2 6618.3 11486.7 11512.6 11545.6 11581.2 11597.3 5712.9 5718.1 5733.5 5861.4 5951.4 3481.3 3699.4 3726.8 3764.6 3784.1 2566.8 2600.7 2615.9 2619.2 2619.4 368.8 370.7 375.8 379.2 382.2 487.6 542.3 550.8 566.8 575.8 7333.9 7438.3 7469.6 7698.5 7700.2 430.2 463.6 485.4 557.3 562.4 3482.7 3523.4 3523.5 3579.4 3676.1 56827.7 56905.4 57391.0 57915.0 61120.4 49976.8 50175.7 50204.5 50410.7 50544.5 46808.0 46858.3 47008.3 47896.5 48238.8 7692.7 7760.7 7773.4 7987.2 8019.4 33214.3 34268.5 34405.0 34823.1 35020.5 44839.8 45358.5 45955.3 46498.8 47034.0 7215.5 7293.9 7351.6 7410.3 7446.3 10412.8 10547.3 10609.6 10682.9 10782.2 9971.9 10325.0 10494.3 10688.9 10742.8 9988.2 10324.7 10381.9 10474.6 10517.6 9881.2 9991.1 10225.8 10258.9 10295.4 8622.4 8683.3 8721.0 8865.3 9003.6 8456.3 8869.8 8914.2 9005.8 9090.5 16:41:30 INFO - 2015-11-05 16:41:30,848 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:41:30 INFO - 2015-11-05 16:41:30,848 DEBUG : BROWSER_OUTPUT: 16:41:31 INFO - 2015-11-05 16:41:31,490 INFO : Browser exited with error code: 0 16:41:31 INFO - 2015-11-05 16:41:31,519 INFO : Completed test dromaeo_css (00:18:30) 16:41:31 INFO - 2015-11-05 16:41:31,519 INFO : Starting test kraken 16:41:31 INFO - 2015-11-05 16:41:31,519 DEBUG : operating with platform_type : mac_ 16:41:31 INFO - 2015-11-05 16:41:31,520 INFO : Initialising browser for kraken test... 16:41:31 INFO - 2015-11-05 16:41:31,533 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/tmp4j08QI/profile http://localhost:50032/getInfo.html 16:41:34 INFO - 2015-11-05 16:41:34,509 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:41:34 INFO - 2015-11-05 16:41:34,509 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:41:34 INFO - 2015-11-05 16:41:34,509 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:41:34 INFO - 2015-11-05 16:41:34,509 DEBUG : BROWSER_OUTPUT: __metrics 16:41:35 INFO - 2015-11-05 16:41:35,169 INFO : Browser initialized. 16:41:35 INFO - 2015-11-05 16:41:35,169 INFO : Running cycle 1/1 for kraken test... 16:41:35 INFO - 2015-11-05 16:41:35,169 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/tmp4j08QI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:41:47 INFO - 2015-11-05 16:41:47,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 234512384 16:41:47 INFO - 2015-11-05 16:41:47,143 DEBUG : BROWSER_OUTPUT: 16:41:49 INFO - 2015-11-05 16:41:49,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50032/tests/kraken/driver.html?testName=audio-beat-detection) 16:41:50 INFO - 2015-11-05 16:41:50,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 251809792 16:41:50 INFO - 2015-11-05 16:41:50,264 DEBUG : BROWSER_OUTPUT: 16:41:52 INFO - 2015-11-05 16:41:52,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50032/tests/kraken/driver.html?testName=audio-dft) 16:41:53 INFO - 2015-11-05 16:41:53,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 260243456 16:41:53 INFO - 2015-11-05 16:41:53,572 DEBUG : BROWSER_OUTPUT: 16:41:56 INFO - 2015-11-05 16:41:56,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50032/tests/kraken/driver.html?testName=audio-fft) 16:41:57 INFO - 2015-11-05 16:41:57,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 260747264 16:41:57 INFO - 2015-11-05 16:41:57,163 DEBUG : BROWSER_OUTPUT: 16:41:59 INFO - 2015-11-05 16:41:59,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50032/tests/kraken/driver.html?testName=audio-oscillator) 16:41:59 INFO - 2015-11-05 16:41:59,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 260997120 16:41:59 INFO - 2015-11-05 16:41:59,781 DEBUG : BROWSER_OUTPUT: 16:42:01 INFO - 2015-11-05 16:42:01,983 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50032/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:42:02 INFO - 2015-11-05 16:42:02,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 260956160 16:42:02 INFO - 2015-11-05 16:42:02,553 DEBUG : BROWSER_OUTPUT: 16:42:05 INFO - 2015-11-05 16:42:05,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50032/tests/kraken/driver.html?testName=imaging-darkroom) 16:42:06 INFO - 2015-11-05 16:42:06,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 260247552 16:42:06 INFO - 2015-11-05 16:42:06,319 DEBUG : BROWSER_OUTPUT: 16:42:09 INFO - 2015-11-05 16:42:09,606 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50032/tests/kraken/driver.html?testName=imaging-desaturate) 16:42:10 INFO - 2015-11-05 16:42:10,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 261394432 16:42:10 INFO - 2015-11-05 16:42:10,201 DEBUG : BROWSER_OUTPUT: 16:42:13 INFO - 2015-11-05 16:42:13,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50032/tests/kraken/driver.html?testName=json-parse-financial) 16:42:13 INFO - 2015-11-05 16:42:13,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 259289088 16:42:13 INFO - 2015-11-05 16:42:13,850 DEBUG : BROWSER_OUTPUT: 16:42:15 INFO - 2015-11-05 16:42:15,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50032/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:42:16 INFO - 2015-11-05 16:42:16,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 260280320 16:42:16 INFO - 2015-11-05 16:42:16,034 DEBUG : BROWSER_OUTPUT: 16:42:17 INFO - 2015-11-05 16:42:17,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50032/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:42:18 INFO - 2015-11-05 16:42:18,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 260669440 16:42:18 INFO - 2015-11-05 16:42:18,525 DEBUG : BROWSER_OUTPUT: 16:42:20 INFO - 2015-11-05 16:42:20,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50032/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:42:21 INFO - 2015-11-05 16:42:21,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 260833280 16:42:21 INFO - 2015-11-05 16:42:21,301 DEBUG : BROWSER_OUTPUT: 16:42:24 INFO - 2015-11-05 16:42:24,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50032/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:42:24 INFO - 2015-11-05 16:42:24,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 261038080 16:42:24 INFO - 2015-11-05 16:42:24,607 DEBUG : BROWSER_OUTPUT: 16:42:27 INFO - 2015-11-05 16:42:27,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50032/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:42:27 INFO - 2015-11-05 16:42:27,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 260644864 16:42:27 INFO - 2015-11-05 16:42:27,886 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,630 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50032/tests/kraken/driver.html?testName=ai-astar) 16:42:29 INFO - 2015-11-05 16:42:29,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 260194304 16:42:29 INFO - 2015-11-05 16:42:29,883 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,884 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:42:29 INFO - 2015-11-05 16:42:29,884 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:42:29 INFO - 2015-11-05 16:42:29,884 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:42:29 INFO - 2015-11-05 16:42:29,885 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:42:29 INFO - 2015-11-05 16:42:29,885 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;101;110;109;109;120;111;112;111;109 16:42:29 INFO - 2015-11-05 16:42:29,885 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;132;156;164;138;153;155;130;179;145 16:42:29 INFO - 2015-11-05 16:42:29,885 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;172;172;177;179;188;195;182;181;178 16:42:29 INFO - 2015-11-05 16:42:29,885 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;77;78;69;73;74;78;137;74;90 16:42:29 INFO - 2015-11-05 16:42:29,886 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;90;131;92;97;100;142;98;100;140 16:42:29 INFO - 2015-11-05 16:42:29,886 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;127;121;129;125;136;130;125;124;130;130 16:42:29 INFO - 2015-11-05 16:42:29,886 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;133;127;143;143;136;142;142;137;144;143 16:42:29 INFO - 2015-11-05 16:42:29,886 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;109;116;117;116;116;126;117;118;116;116 16:42:29 INFO - 2015-11-05 16:42:29,886 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;63;63;63;63;64;66;75;69;69 16:42:29 INFO - 2015-11-05 16:42:29,886 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;69;72;71;73;74;77;77;77 16:42:29 INFO - 2015-11-05 16:42:29,887 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;92;93;94;97;98;99;98;93;95 16:42:29 INFO - 2015-11-05 16:42:29,887 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;136;143;153;143;142;141;154;147;139 16:42:29 INFO - 2015-11-05 16:42:29,887 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;152;161;164;156;173;162;165;169;175 16:42:29 INFO - 2015-11-05 16:42:29,887 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;71;71;71;74;78;76;79;80;80 16:42:29 INFO - 2015-11-05 16:42:29,887 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:42:29 INFO - 2015-11-05 16:42:29,887 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:42:29 INFO - 2015-11-05 16:42:29,887 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,702 16:42:29 INFO - 2015-11-05 16:42:29,887 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:42:29 INFO - 2015-11-05 16:42:29,888 DEBUG : BROWSER_OUTPUT: __startTimestamp1446770549883__endTimestamp 16:42:29 INFO - 2015-11-05 16:42:29,888 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,889 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:42:29 INFO - 2015-11-05 16:42:29,889 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:42:29 INFO - 2015-11-05 16:42:29,889 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,889 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:4.62 (4.2%) stddev-sans-first:4.87 16:42:29 INFO - 2015-11-05 16:42:29,890 DEBUG : BROWSER_OUTPUT: Values: 112.0 101.0 110.0 109.0 109.0 120.0 111.0 112.0 111.0 109.0 16:42:29 INFO - 2015-11-05 16:42:29,890 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,890 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.40 Median:155.50 stddev:15.36 (9.9%) stddev-sans-first:15.81 16:42:29 INFO - 2015-11-05 16:42:29,890 DEBUG : BROWSER_OUTPUT: Values: 162.0 132.0 156.0 164.0 138.0 153.0 155.0 130.0 179.0 145.0 16:42:29 INFO - 2015-11-05 16:42:29,890 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,891 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:178.70 Median:180.00 stddev:8.87 (4.9%) stddev-sans-first:7.37 16:42:29 INFO - 2015-11-05 16:42:29,891 DEBUG : BROWSER_OUTPUT: Values: 163.0 172.0 172.0 177.0 179.0 188.0 195.0 182.0 181.0 178.0 16:42:29 INFO - 2015-11-05 16:42:29,891 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,891 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:20.12 (26.7%) stddev-sans-first:20.94 16:42:29 INFO - 2015-11-05 16:42:29,891 DEBUG : BROWSER_OUTPUT: Values: 71.0 77.0 78.0 69.0 73.0 74.0 78.0 137.0 74.0 90.0 16:42:29 INFO - 2015-11-05 16:42:29,891 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,892 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.90 Median:89.50 stddev:21.08 (23.6%) stddev-sans-first:21.22 16:42:29 INFO - 2015-11-05 16:42:29,892 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 131.0 92.0 97.0 100.0 142.0 98.0 100.0 140.0 16:42:29 INFO - 2015-11-05 16:42:29,892 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,892 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:127.70 Median:129.50 stddev:4.22 (3.3%) stddev-sans-first:4.47 16:42:29 INFO - 2015-11-05 16:42:29,893 DEBUG : BROWSER_OUTPUT: Values: 127.0 121.0 129.0 125.0 136.0 130.0 125.0 124.0 130.0 130.0 16:42:29 INFO - 2015-11-05 16:42:29,893 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,894 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:139.00 Median:142.50 stddev:5.62 (3.9%) stddev-sans-first:5.52 16:42:29 INFO - 2015-11-05 16:42:29,894 DEBUG : BROWSER_OUTPUT: Values: 133.0 127.0 143.0 143.0 136.0 142.0 142.0 137.0 144.0 143.0 16:42:29 INFO - 2015-11-05 16:42:29,894 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,894 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:116.70 Median:116.50 stddev:4.08 (3.5%) stddev-sans-first:3.24 16:42:29 INFO - 2015-11-05 16:42:29,894 DEBUG : BROWSER_OUTPUT: Values: 109.0 116.0 117.0 116.0 116.0 126.0 117.0 118.0 116.0 116.0 16:42:29 INFO - 2015-11-05 16:42:29,894 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,894 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.00 stddev:3.98 (6.1%) stddev-sans-first:4.17 16:42:29 INFO - 2015-11-05 16:42:29,895 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 63.0 63.0 63.0 64.0 66.0 75.0 69.0 69.0 16:42:29 INFO - 2015-11-05 16:42:29,895 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,895 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:73.50 stddev:3.50 (4.8%) stddev-sans-first:3.44 16:42:29 INFO - 2015-11-05 16:42:29,895 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 72.0 71.0 73.0 74.0 77.0 77.0 77.0 16:42:29 INFO - 2015-11-05 16:42:29,895 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,895 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:94.90 Median:96.00 stddev:3.00 (3.1%) stddev-sans-first:2.60 16:42:29 INFO - 2015-11-05 16:42:29,895 DEBUG : BROWSER_OUTPUT: Values: 90.0 92.0 93.0 94.0 97.0 98.0 99.0 98.0 93.0 95.0 16:42:29 INFO - 2015-11-05 16:42:29,896 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,896 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:142.70 Median:143.00 stddev:7.47 (5.2%) stddev-sans-first:6.06 16:42:29 INFO - 2015-11-05 16:42:29,896 DEBUG : BROWSER_OUTPUT: Values: 129.0 136.0 143.0 153.0 143.0 142.0 141.0 154.0 147.0 139.0 16:42:29 INFO - 2015-11-05 16:42:29,896 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,896 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:164.50 stddev:9.72 (5.9%) stddev-sans-first:7.49 16:42:29 INFO - 2015-11-05 16:42:29,897 DEBUG : BROWSER_OUTPUT: Values: 143.0 152.0 161.0 164.0 156.0 173.0 162.0 165.0 169.0 175.0 16:42:29 INFO - 2015-11-05 16:42:29,897 DEBUG : BROWSER_OUTPUT: 16:42:29 INFO - 2015-11-05 16:42:29,898 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:77.00 stddev:3.96 (5.1%) stddev-sans-first:3.91 16:42:29 INFO - 2015-11-05 16:42:29,898 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 71.0 74.0 78.0 76.0 79.0 80.0 80.0 16:42:29 INFO - 2015-11-05 16:42:29,898 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:42:29 INFO - 2015-11-05 16:42:29,898 DEBUG : BROWSER_OUTPUT: 16:42:30 INFO - 2015-11-05 16:42:30,557 INFO : Browser exited with error code: 0 16:42:30 INFO - 2015-11-05 16:42:30,609 INFO : Completed test kraken (00:00:59) 16:42:30 INFO - 2015-11-05 16:42:30,609 INFO : Starting test v8_7 16:42:30 INFO - 2015-11-05 16:42:30,609 DEBUG : operating with platform_type : mac_ 16:42:30 INFO - 2015-11-05 16:42:30,609 INFO : Initialising browser for v8_7 test... 16:42:30 INFO - 2015-11-05 16:42:30,623 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/tmpXFtP9S/profile http://localhost:50032/getInfo.html 16:42:33 INFO - 2015-11-05 16:42:33,479 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:42:33 INFO - 2015-11-05 16:42:33,479 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:42:33 INFO - 2015-11-05 16:42:33,479 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:42:33 INFO - 2015-11-05 16:42:33,479 DEBUG : BROWSER_OUTPUT: __metrics 16:42:34 INFO - 2015-11-05 16:42:34,133 INFO : Browser initialized. 16:42:34 INFO - 2015-11-05 16:42:34,133 INFO : Running cycle 1/1 for v8_7 test... 16:42:34 INFO - 2015-11-05 16:42:34,133 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/tmpXFtP9S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:42:46 INFO - 2015-11-05 16:42:46,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 233271296 16:42:46 INFO - 2015-11-05 16:42:46,111 DEBUG : BROWSER_OUTPUT: 16:43:07 INFO - 2015-11-05 16:43:07,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50032/tests/v8_7/run.html (next: http://localhost:50032/tests/v8_7/run.html) 16:43:07 INFO - 2015-11-05 16:43:07,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 254382080 16:43:07 INFO - 2015-11-05 16:43:07,838 DEBUG : BROWSER_OUTPUT: 16:43:07 INFO - 2015-11-05 16:43:07,838 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:43:07 INFO - 2015-11-05 16:43:07,838 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:43:07 INFO - 2015-11-05 16:43:07,838 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:43:07 INFO - 2015-11-05 16:43:07,839 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:43:07 INFO - 2015-11-05 16:43:07,839 DEBUG : BROWSER_OUTPUT: |0;Richards;173.82235355466713 16:43:07 INFO - 2015-11-05 16:43:07,839 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;200.7628990162618 16:43:07 INFO - 2015-11-05 16:43:07,839 DEBUG : BROWSER_OUTPUT: |2;Encrypt;337.4957813027337 16:43:07 INFO - 2015-11-05 16:43:07,839 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6211.180124223602 16:43:07 INFO - 2015-11-05 16:43:07,839 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1184.8341232227488 16:43:07 INFO - 2015-11-05 16:43:07,839 DEBUG : BROWSER_OUTPUT: |5;Earley;841.7508417508418 16:43:07 INFO - 2015-11-05 16:43:07,839 DEBUG : BROWSER_OUTPUT: |6;Boyer;13835.616438356165 16:43:07 INFO - 2015-11-05 16:43:07,839 DEBUG : BROWSER_OUTPUT: |7;RegExp;30515.151515151516 16:43:07 INFO - 2015-11-05 16:43:07,839 DEBUG : BROWSER_OUTPUT: |8;Splay;697.8367062107467 16:43:07 INFO - 2015-11-05 16:43:07,840 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6078.787878787879 16:43:07 INFO - 2015-11-05 16:43:07,840 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:43:07 INFO - 2015-11-05 16:43:07,840 DEBUG : BROWSER_OUTPUT: __startTimestamp1446770587836__endTimestamp 16:43:07 INFO - 2015-11-05 16:43:07,840 DEBUG : BROWSER_OUTPUT: 16:43:07 INFO - 2015-11-05 16:43:07,840 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:43:07 INFO - 2015-11-05 16:43:07,840 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:43:07 INFO - 2015-11-05 16:43:07,840 DEBUG : BROWSER_OUTPUT: 16:43:07 INFO - 2015-11-05 16:43:07,840 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:173.82 Median:173.82 stddev:0.00 (0.0%) 16:43:07 INFO - 2015-11-05 16:43:07,840 DEBUG : BROWSER_OUTPUT: Values: 173.8 16:43:07 INFO - 2015-11-05 16:43:07,840 DEBUG : BROWSER_OUTPUT: 16:43:07 INFO - 2015-11-05 16:43:07,840 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:200.76 Median:200.76 stddev:0.00 (0.0%) 16:43:07 INFO - 2015-11-05 16:43:07,840 DEBUG : BROWSER_OUTPUT: Values: 200.8 16:43:07 INFO - 2015-11-05 16:43:07,841 DEBUG : BROWSER_OUTPUT: 16:43:07 INFO - 2015-11-05 16:43:07,841 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:337.50 Median:337.50 stddev:0.00 (0.0%) 16:43:07 INFO - 2015-11-05 16:43:07,841 DEBUG : BROWSER_OUTPUT: Values: 337.5 16:43:07 INFO - 2015-11-05 16:43:07,841 DEBUG : BROWSER_OUTPUT: 16:43:07 INFO - 2015-11-05 16:43:07,841 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6211.18 Median:6211.18 stddev:0.00 (0.0%) 16:43:07 INFO - 2015-11-05 16:43:07,841 DEBUG : BROWSER_OUTPUT: Values: 6211.2 16:43:07 INFO - 2015-11-05 16:43:07,841 DEBUG : BROWSER_OUTPUT: 16:43:07 INFO - 2015-11-05 16:43:07,841 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1184.83 Median:1184.83 stddev:0.00 (0.0%) 16:43:07 INFO - 2015-11-05 16:43:07,841 DEBUG : BROWSER_OUTPUT: Values: 1184.8 16:43:07 INFO - 2015-11-05 16:43:07,841 DEBUG : BROWSER_OUTPUT: 16:43:07 INFO - 2015-11-05 16:43:07,841 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:841.75 Median:841.75 stddev:0.00 (0.0%) 16:43:07 INFO - 2015-11-05 16:43:07,842 DEBUG : BROWSER_OUTPUT: Values: 841.8 16:43:07 INFO - 2015-11-05 16:43:07,842 DEBUG : BROWSER_OUTPUT: 16:43:07 INFO - 2015-11-05 16:43:07,842 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13835.62 Median:13835.62 stddev:0.00 (0.0%) 16:43:07 INFO - 2015-11-05 16:43:07,842 DEBUG : BROWSER_OUTPUT: Values: 13835.6 16:43:07 INFO - 2015-11-05 16:43:07,842 DEBUG : BROWSER_OUTPUT: 16:43:07 INFO - 2015-11-05 16:43:07,842 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30515.15 Median:30515.15 stddev:0.00 (0.0%) 16:43:07 INFO - 2015-11-05 16:43:07,842 DEBUG : BROWSER_OUTPUT: Values: 30515.2 16:43:07 INFO - 2015-11-05 16:43:07,842 DEBUG : BROWSER_OUTPUT: 16:43:07 INFO - 2015-11-05 16:43:07,842 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:697.84 Median:697.84 stddev:0.00 (0.0%) 16:43:07 INFO - 2015-11-05 16:43:07,842 DEBUG : BROWSER_OUTPUT: Values: 697.8 16:43:07 INFO - 2015-11-05 16:43:07,842 DEBUG : BROWSER_OUTPUT: 16:43:07 INFO - 2015-11-05 16:43:07,843 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6078.79 Median:6078.79 stddev:0.00 (0.0%) 16:43:07 INFO - 2015-11-05 16:43:07,843 DEBUG : BROWSER_OUTPUT: Values: 6078.8 16:43:07 INFO - 2015-11-05 16:43:07,843 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:43:07 INFO - 2015-11-05 16:43:07,843 DEBUG : BROWSER_OUTPUT: 16:43:08 INFO - 2015-11-05 16:43:08,505 INFO : Browser exited with error code: 0 16:43:08 INFO - 2015-11-05 16:43:08,527 INFO : Completed test v8_7 (00:00:37) 16:43:08 INFO - 2015-11-05 16:43:08,888 INFO : Completed test suite (00:20:07) 16:43:08 INFO - 2015-11-05 16:43:08,888 DEBUG : Working with test: dromaeo_css 16:43:08 INFO - 2015-11-05 16:43:08,888 DEBUG : Generating results file: dromaeo_css 16:43:08 INFO - 2015-11-05 16:43:08,889 DEBUG : Working with test: kraken 16:43:08 INFO - 2015-11-05 16:43:08,889 DEBUG : Generating results file: kraken 16:43:08 INFO - 2015-11-05 16:43:08,889 INFO : javascript benchmark 16:43:08 INFO - 2015-11-05 16:43:08,889 DEBUG : Working with test: v8_7 16:43:08 INFO - 2015-11-05 16:43:08,889 DEBUG : Generating results file: v8_7 16:43:08 INFO - 2015-11-05 16:43:08,889 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:43:08 INFO - 2015-11-05 16:43:08,941 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 16:43:08 INFO - 2015-11-05 16:43:08,941 DEBUG : process_Request line: dromaeo_css 6343.88 graph.html#tests=[[72,64,57]] 16:43:08 INFO - 2015-11-05 16:43:08,941 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:43:08 INFO - 2015-11-05 16:43:08,967 DEBUG : process_Request line: kraken 1627.20 graph.html#tests=[[232,64,57]] 16:43:08 INFO - 2015-11-05 16:43:08,968 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:43:08 INFO - 2015-11-05 16:43:08,994 DEBUG : process_Request line: v8_7 18542.84 graph.html#tests=[[230,64,57]] 16:43:08 INFO - 2015-11-05 16:43:08,995 INFO : javascript benchmark 16:43:09 INFO - 2015-11-05 16:43:08,997 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [311.41143239277784, 315.81051369178493, 316.80041573808495, 321.86642543344516, 325.07029894501727, 11265.380404077772, 11696.239744416607, 17065.573360665974, 17619.383321583748, 17683.469495915127, 11299.435028248576, 11356.432178391067, 11390.7152321192, 11433.314001159915, 11709.70725731857, 4180.393842892787, 4298.419713338691, 4301.827926882921, 4302.569743025703, 4312.935305970413, 4177.248095342837, 4233.386159006942, 4244.087521182945, 4318.870433886988, 4325.0, 4222.134462435209, 4257.425247591582, 4280.4221430107, 4426.933595996063, 4465.263231566803, 4267.551907049746, 4418.381426600278, 4420.182266280733, 4422.712523685982, 4457.99695068607, 3665.0, 3739.046543131484, 3786.3941769316775, 3791.469194312798, 3810.504634397538, 12666.303353315656, 12733.0, 12748.61754147377, 22951.31146065621, 22977.88511057451, 1911.961760764777, 1914.6745053340965, 1917.9808201917942, 1962.2347284559035, 2026.63520566298, 13429.865701342958, 13430.0, 13505.86494135056, 13704.862951370458, 13979.37092830825, 1567.482730698878, 1665.1840598106962, 1665.7917760279965, 1677.6728537935107, 1730.7057800174, 51703.74148129235, 54855.451445485436, 57593.424065759646, 63989.68005159991, 67237.0, 16276.75584866228, 16648.667026659397, 16651.41720039817, 16766.664666706598, 16890.74663880043, 23489.765102349098, 23609.527809443716, 23658.4085397863, 23671.644925326134, 23696.526069478514, 9530.904690953003, 9658.3722058066, 9707.805843883083, 9758.024197580327, 9769.071938165864, 8227.917720822836, 8308.916910830936, 8313.0, 8327.458715183615, 8336.62485188168, 7685.692572297157, 7901.881471777928, 7914.920850791534, 7917.920820791834, 7922.286994170552, 3203.7757356985253, 3211.855466504013, 3224.2584205632365, 3233.417984762765, 3257.560229369005, 379.28694055176095, 387.4343458550548, 395.2608621877051, 403.16745919675776, 419.24326590503824, 10909.563617455371, 11019.504122314514, 11187.272827266364, 11247.0, 11273.267237629529, 434.9391085248068, 436.7706953849191, 452.7351499372904, 454.4069988664824, 469.4296429837764, 5909.379515150933, 6056.121862330026, 6065.5450841187085, 6075.3924607539775, 6143.56995010345, 506617.0, 523165.0, 534129.0, 545541.0, 546322.0, 65722.67138664372, 68608.6569567159, 68875.0, 68924.3107568928, 69678.30321696718, 439.21380728496274, 446.3037661248463, 448.4081013062726, 450.14921797801526, 450.9481409637868, 10134.087932086148, 10319.587216511256, 10397.896021039693, 10460.110890574386, 10509.789804204025, 32172.517412239304, 32848.67151328552, 33311.50032749559, 33355.49966750452, 33519.0, 44738.3289250655, 44956.550434495235, 45256.54743452524, 45442.545574545155, 46080.53919460763, 5747.827565173052, 5815.883682326415, 5827.621204621686, 5865.384134665798, 5878.559108066997, 10806.837897431702, 10861.565537378416, 10935.890641093487, 10995.175361847734, 11082.445877706245, 8106.959465202636, 8296.377771667028, 9362.391444556082, 9375.953120234355, 9513.90486095158, 8330.750077497685, 8553.657853685783, 8763.60563774619, 8864.689735859214, 8964.955175224082, 9005.864912026456, 9066.138716821892, 9100.954495227481, 9171.724848254564, 9185.0, 5435.782568697366, 5528.723563821713, 5556.72216389187, 5562.3047119110115, 5591.30108736408, 8880.777980550538, 9009.63961441535, 9078.45529268246, 9265.675701350421, 9310.208632266333], "dojo.html": [3047.8018928769643, 3141.4816555268394, 3169.0492852144353, 3209.582754241949, 3296.060622722523, 5098.107831129551, 5151.0, 5153.227015947609, 5160.612954028449, 5170.482951704837, 4854.271859221119, 4969.503049695038, 4975.651704380694, 5048.671836330636, 5059.924101138486, 4638.165130276549, 4708.952910470885, 4777.713337199762, 4789.305550695164, 4815.0610630926985, 15.758609617873415, 4645.233536466479, 4673.369095172142, 4774.73738944358, 4783.736894470802, 4671.579557839811, 4699.859004229878, 4720.834770783006, 4764.0471905619015, 4775.9283610745515, 4692.906141877143, 4696.319033740123, 4729.929051064237, 4753.619710423158, 4808.134535783557, 4531.796069176895, 4568.565986231336, 4616.515265897099, 4730.550597693248, 4738.265568836836, 4781.450133234688, 4971.602271818246, 4975.477574854661, 5048.747562621891, 5123.333966584358, 5301.7084060376665, 5368.248445217672, 5373.0, 5400.243965844785, 5418.756155972991, 5251.422343542207, 5382.515573598395, 5448.182772584105, 5460.781568737246, 5559.416261292587, 5035.62232832539, 5044.142495775727, 5074.59403247743, 5083.923741143886, 5089.287499750038, 5505.917411238835, 5531.363893152339, 5543.6396634218645, 5574.1917421973585, 5597.272354593958, 5105.387353517602, 5206.271122042917, 5243.318368612056, 5286.1806420004195, 5296.04671159195, 5460.071787796084, 5466.617336786467, 5477.3427188737605, 5477.835664930059, 5511.834644960658, 5247.790088396498, 5343.091674415281, 5363.383210930715, 5385.838424847261, 5416.8104116355735, 5189.065968125774, 5198.402183748842, 5201.505856943584, 5206.791728330824, 5285.63000589955, 4165.875023749292, 4178.937315940263, 4184.958150418518, 4205.915881682349, 4234.3860140279485, 3702.0929872181487, 3774.9433758493647, 3817.4655548223272, 3872.361060425055, 3889.4554762333296, 5067.569256613229, 5101.668391554537, 5124.436312005676, 5130.9230361544605, 5132.794688212504, 5415.214793854948, 5526.088195447786, 5534.169874518854, 5539.972300138474, 5540.972295138498, 4968.180250258739, 5045.7981680732355, 5124.718140502234, 5217.843464696065, 5224.8171314004585, 4714.952850471452, 4728.905421891543, 4746.4541577719, 4801.831935882227, 4807.927881081787, 5504.422035686275, 5511.063119269814, 5525.778968841281, 5548.029094908375, 5556.333240011144, 5324.201369794562, 5484.149956756709, 5490.3411590609385, 5522.972385138049, 5542.61201715876, 5422.918656220081, 5432.945670543244, 5492.395836457907, 5493.2034854946605, 5501.889962200814, 5291.259223708606, 5304.045271851104, 5321.0, 5324.627276090637, 5357.491038351351, 5300.178472336794, 5309.309789727466, 5318.468153184651, 5376.542993845411, 5386.973065134649, 5174.249733788655, 5202.947970520247, 5271.71005594696, 5291.497307755757, 5301.469853014668, 5142.202958541432, 5191.143461328838, 5276.366835979707, 5301.416844147064, 5339.439358867418, 5193.844184674465, 5233.790648374023, 5241.9737901310245, 5244.134717771525, 5282.864184200415, 5043.36957880265, 5309.044372013074, 5314.256004159498, 5314.5216930476445, 5364.436734142859, 4992.15133427311, 4993.976234871915, 5084.6440749147205, 5139.460356662496, 5182.792688292426], "mootools.html": [1470.0518165783064, 1588.5472640297514, 1664.5672125247431, 1688.0462538665654, 1710.5210541048502, 6481.1250481185025, 6591.077249185118, 6937.514373993822, 7176.964115179423, 7279.0, 6825.35159159879, 6923.446124310056, 7042.718291268356, 7087.89368159478, 7102.9644851775665, 2044.8057434543693, 2088.0, 2096.90563924623, 2105.2421128393767, 2108.4939614492487, 2081.8022287882627, 2101.0, 2108.5150415404464, 2120.321497120914, 2127.7340332458443, 2037.4906273431643, 2061.670132778748, 2065.266830275253, 2083.708280840676, 2087.5720477302193, 2068.1934045722182, 2071.720317757106, 2071.8135367816894, 2087.425957861585, 2098.3914664747203, 2019.4446527205137, 2043.1827269092332, 2067.1937944201773, 2069.5860827834495, 2092.9162833486644, 7075.39859111971, 7098.290170982912, 7126.144862616467, 7153.713851445936, 7173.641317934134, 4247.8088486018205, 4329.675274354436, 4348.043430445297, 4348.586884246023, 4406.405135306724, 2405.9759402406103, 2483.192962287246, 2655.2830735701446, 2727.1136880513914, 2728.086091159464, 774.0865778381508, 809.6882700160422, 814.771863878115, 830.2859540794911, 831.1522247307712, 9062.0, 9087.772805679844, 9101.499417532033, 9119.088091190828, 9156.954215228949, 3945.270125026879, 4011.859584914514, 4031.657309128698, 4062.7156099073372, 4100.91798164035, 8015.919840801634, 8016.679332826621, 8050.0, 8051.677932882736, 8060.758177254692, 4442.68901176921, 4447.177272204653, 4476.127155204769, 4480.843170489017, 4509.458864936229, 4046.4537287465814, 4099.959000410017, 4111.280525907954, 4119.155573107506, 4136.544980052192, 3400.9319813604084, 3429.6741809528053, 3452.7065199457825, 3459.550258466383, 3472.930541389158, 1113.1039513191959, 1113.265244938353, 1118.2731224703846, 1119.4458742922307, 1138.65271092316, 1249.9312537810326, 1262.1354372255034, 1262.8042653388738, 1264.0456455376132, 1277.118788036252, 6587.242467116247, 6610.0745895574655, 6694.430973367318, 6701.195856497252, 6717.462602991749, 428.1650780977045, 435.9515365545867, 437.5864807756703, 437.72621670937417, 442.5729171349663, 5277.129273669878, 5370.892582148335, 5383.865403364947, 5391.649542779707, 5393.5954803389905, 7560.621968901533, 7746.38028957682, 8056.0, 8204.343652507785, 8286.46138001028, 8100.0, 8142.918570814216, 8224.876626850602, 8241.217084376975, 8247.670093196204, 6501.739930402826, 6562.967185164043, 6589.901151482732, 6605.636689982001, 6661.500387470862, 6561.770338038145, 6647.268800432045, 6652.201735791736, 6662.56693314933, 6664.933350666625, 7310.488265821342, 7434.73978410753, 7441.55350678961, 7462.029936108272, 7464.962675186806, 7457.962710186414, 7552.546847189186, 7639.541627502145, 7659.693612255447, 7677.193894641206, 6176.845578860564, 6246.5002799775, 6247.750089996531, 6248.4376406123665, 6282.623042617458, 6641.900371494528, 6793.864122717419, 6846.178458585002, 6860.965695171492, 6884.4148247399535, 6152.077188421773, 6232.875342493216, 6381.457576105898, 6460.12788273577, 6500.869982600416, 6206.503479721521, 6299.11812346281, 6306.148669929501, 6321.0834429008455, 6338.954072577973, 6196.1635179252025, 6317.368263173646, 6328.493720502257, 6347.936520634919, 6351.777687780906, 5563.693996830213, 5584.832455026356, 5621.297337832771, 5648.802291919763, 5654.264945557051, 5980.132880732356, 6002.129691194839, 6005.6396616203165, 6013.067974463965, 6064.909026364519], "ext.html": [516.6512603992304, 543.909461529633, 549.4532939724975, 552.8424399046272, 557.7155650618183, 36791.63208367916, 37458.4381234281, 37759.24481510368, 37783.0, 37980.240395192115, 40092.398614020814, 40665.18669626606, 40669.38995915056, 40768.796156019256, 40864.795676021655, 8662.6101825418, 8781.38530302879, 8788.516631585293, 8819.823603527926, 8868.778280542974, 8416.368772342068, 8573.699920502784, 8647.65409383624, 8694.652213911437, 8709.564521773918, 8530.87203691945, 8605.053444121173, 8607.526586037766, 8627.396082274243, 8642.697505587306, 8502.914970850305, 8518.190771876692, 8673.739787806377, 8707.303415726727, 8711.912880871174, 8493.362997775192, 8601.913980860236, 8620.051794302623, 8637.870431943526, 8648.524331161783, 37603.43594846079, 37989.0, 38054.23891522182, 38070.238595227944, 38408.231835363134, 2861.9427611447654, 2971.2423332050407, 3009.232645675361, 3190.9310381022387, 3277.115178901683, 26069.348266293495, 26469.867650661818, 26663.466730665474, 27109.593356099675, 27232.45535089307, 2285.931422057341, 2299.6855471082317, 2305.619572770491, 2319.1766922742354, 2320.0951628864755, 257544.0, 258353.9999999981, 258631.0, 258833.0, 261520.9999999981, 39935.60064399319, 40514.1897162061, 40763.0, 54861.725691371284, 55027.724861375435, 39594.0, 39927.0, 39985.20029599392, 40131.799341003694, 40252.59747402547, 13957.092788968685, 14508.637284067772, 14548.127112373291, 14666.853331466762, 14723.116613003254, 11701.473433695504, 11753.236039657395, 11760.647180584596, 11788.410579470992, 11815.054795616503, 13258.337083145803, 13282.867171328357, 13349.599512014462, 13354.131981421177, 13454.394552245172, 5970.283565972024, 6072.149899014142, 6134.693265336716, 6181.660008699565, 6186.876262474725, 853.906070332263, 928.7724507495707, 1008.0473952115327, 1070.208046045936, 1098.9890101099047, 27260.86369568179, 27355.452890942466, 27519.44961100767, 27579.0, 27672.446551068864, 1005.5927349423495, 1010.4392062405288, 1027.0705011964185, 1052.7999680060916, 1119.2445099557929, 14301.57095287143, 14606.780898286534, 14739.0, 15226.497905481801, 15391.0, 348207.0, 349331.0, 349903.0, 350263.0, 352237.0, 55829.0, 55927.88144237174, 56051.0, 56170.438295617336, 56196.719016404655, 1352.4319785690034, 1358.7825947848296, 1359.8572149924116, 1375.4291968833022, 1533.8236102848093, 28746.0, 28774.856125719238, 28796.0, 29083.272918177216, 29136.854315728287, 47003.764981176246, 47361.52638473571, 47578.52421475741, 47589.5241047599, 47654.0, 266398.0, 269915.0, 269945.0, 270824.0, 271207.0, 26654.46691066129, 26942.326441838326, 31062.22344441407, 31725.36549269048, 42644.343468025305, 42033.15933681248, 42183.78908105563, 42587.57412425836, 43419.0, 43446.78276608597, 34288.828555857064, 35414.82292588521, 35973.0, 36030.0, 36121.27757444889, 34695.479567805996, 34985.65014349824, 34988.65011349854, 35085.82457087698, 35294.47058294179, 35829.64170358263, 35849.46225806563, 35880.820595896854, 37814.810925945196, 38414.58232303321, 29762.70237297686, 30985.845070774503, 31028.53457198099, 31044.53433198549, 31314.21714457157, 23445.0, 30008.699913001463, 31051.534226987063, 31500.0, 32082.67917320797], "prototype.html": [295.7294075920533, 300.7924532072871, 305.11060259344026, 305.6103468078201, 306.20692406666734, 5808.564357673175, 5860.970695146523, 5868.76524939003, 5881.558883083764, 5892.852678683024, 5761.279840019997, 5761.654300741959, 5768.625039372438, 5780.306363236417, 5791.739371728272, 4297.5057868345075, 4442.133783912139, 4455.532169122244, 4455.910881782371, 4503.954960450386, 4359.912801743979, 4394.6703997200175, 4400.845970391037, 4403.273459879116, 4429.42417485728, 4329.307310830268, 4333.956660433402, 4352.6300264477395, 4352.890013046669, 4365.716228445157, 4330.545292744279, 4342.869713908588, 4343.739375637456, 4348.652107831366, 4364.018095928423, 3735.8979101165223, 3737.9626203737885, 3740.532433445819, 3783.356829339019, 3783.375743002401, 5573.024720673866, 5573.247611572427, 5673.063944449161, 5704.429557044304, 5705.942940570582, 4927.5318844710055, 4928.063667903087, 4932.0629080474955, 4937.703737775745, 4938.407391113054, 6059.66671833049, 6074.939250607482, 6078.209832721718, 6084.665343406111, 6103.847403814896, 3923.234969181011, 4031.7984100794843, 4052.53395859477, 4057.6956728245204, 4085.387191921206, 6414.8717025659225, 6480.157579514633, 6486.708098135548, 6497.382748638872, 6506.707198176094, 4165.021220013295, 4175.164967006611, 4176.874693759192, 4187.623113919762, 4197.706160568792, 4212.452381190487, 4223.68322375823, 4266.743995360288, 4269.935950960738, 4270.743755374688, 4810.2063159578975, 4955.934474088089, 4964.801407943642, 4988.201887698024, 4991.800327986913, 6113.0, 6151.938480615226, 6162.198914141222, 6171.9691401542705, 6215.720292586844, 1496.4313560846808, 1505.503183949294, 1511.4029958166464, 1517.484055421162, 1517.833038365779, 960.865478832964, 973.6543527047937, 975.5609975511048, 983.3509883476871, 989.8911119776819, 5940.821775346746, 5959.344472108065, 5977.731002104916, 5988.520918326523, 6001.219841420588, 6372.426481616677, 6400.103985442041, 6414.294427612959, 6421.068945002949, 6460.741570337133, 5916.3787802281, 5946.226990491295, 5959.255093113361, 5970.432808883149, 5974.701264936736, 3385.153711572107, 3510.227749895019, 3543.2204914919193, 3547.592026916886, 3548.8757893473603, 6385.936140638627, 6481.513886458534, 6506.3818937200895, 6536.771213007617, 6554.934450655528, 6443.548951573345, 6476.935230647728, 6509.2839787623325, 6518.315576864456, 6520.869582608321, 6458.418742313214, 6470.352964703586, 6472.190976127984, 6475.352464753581, 6516.706748196248, 6257.311695713559, 6347.174867267226, 6370.362963703593, 6377.713002914973, 6378.840528986812, 6235.688215589294, 6240.594361366497, 6255.218097737783, 6256.249250090018, 6285.528585356025, 6525.1517302750335, 6527.804165875032, 6540.705668245036, 6546.672666366758, 6554.082428460115, 4087.080406908422, 4137.50349958007, 4142.502899652061, 4166.604172603597, 4177.101923086551, 6157.630542167484, 6271.874562508816, 6427.55007149495, 6443.0, 6452.806415807533, 6197.845053873689, 6220.968895155495, 6225.159603453476, 6227.875442491216, 6239.75040998355, 6245.68771561411, 6255.812325630239, 6256.0303153011355, 6258.186435763321, 6263.843403914939, 5939.732712027882, 6037.124616930609, 6064.666443345482, 6121.32665406796, 6134.877302453837, 6290.654014029273, 6291.748330066929, 6292.056191571301, 6292.402221788922, 6298.401651843067, 6047.48596369296, 6108.17539632144, 6108.602940808833, 6128.417800308964, 6188.504919606511], "yui.html": [685.6811582614083, 710.2081179484869, 711.9110111236096, 715.6242972439469, 724.54353757133, 12801.935990320047, 12877.871221287784, 13074.607761767138, 13097.7380452391, 13100.606981790537, 12277.754444911096, 12423.875761242385, 12431.937840310786, 12450.626481205556, 12455.750884982295, 823.5305875650881, 826.6528058215564, 845.6997765793147, 847.8685803700405, 852.3735054734765, 830.6926437218208, 845.0746432656232, 849.9320054395633, 850.8255807559435, 853.185208126241, 862.3532350736947, 877.2674816528206, 880.1198801198801, 886.835935351962, 886.8980067292247, 867.5748883047293, 868.3400615532178, 874.2263097158997, 875.4178471316567, 876.9736907892742, 631.0156156396037, 631.8388810853249, 635.4693830651412, 637.3053371824687, 643.3212960326854, 12709.936450317782, 12783.61649150527, 12813.93593032029, 12965.092443528956, 12966.027547933849, 8813.603387847497, 9141.817163656757, 9372.203362714177, 9576.23390128788, 9656.951715241448, 8371.874421883676, 8492.66029358825, 8555.614997325136, 8638.524881131536, 8644.783880402978, 2783.178962206154, 2834.7732181425436, 2943.7644988400875, 2956.127942257039, 2973.04862444018, 40149.0, 40779.18441631181, 40785.59214407847, 40923.7953810232, 45606.31590526145, 6290.654014029181, 6389.616623002635, 6498.902516462257, 6559.212894452697, 6618.271990081087, 11486.712832179262, 11512.597059103058, 11545.595904143314, 11581.247218930743, 11597.304161750153, 5712.857178570569, 5718.056520674126, 5733.541316694655, 5861.413858614104, 5951.432327981157, 3481.2515309208643, 3699.408094704834, 3726.832292546842, 3764.6235376462682, 3784.0918179636687, 2566.8459892406518, 2600.726923672987, 2615.856127912983, 2619.1749598876295, 2619.3975385661406, 368.7934756536348, 370.73492452896306, 375.7557587568103, 379.23394742620303, 382.1516233960603, 487.5928599619287, 542.2814770429197, 550.7604192176416, 566.832784328624, 575.7840809696364, 7333.853322933512, 7438.2933621306975, 7469.589172595451, 7698.538087714643, 7700.229977002255, 430.2148578843623, 463.594354939428, 485.35447854353623, 557.3005877623557, 562.353293712226, 3482.703970162514, 3523.4320727276117, 3523.4714792781288, 3579.4093974493917, 3676.117731744362, 56827.71586142043, 56905.43094569084, 57391.0, 57915.0, 61120.38879611236, 49976.75011624918, 50175.74912125416, 50204.49795501998, 50410.74794626003, 50544.49455505471, 46807.999999999316, 46858.29712554315, 47008.294875576896, 47896.521034789206, 48238.75880620575, 7692.730754423568, 7760.68957241704, 7773.41699372538, 7987.201279872199, 8019.438639295194, 33214.335713285116, 34268.48597271093, 34405.0, 34823.12942176466, 35020.47469287912, 44839.775801120784, 45358.546414535434, 45955.31067034064, 46498.76750616225, 47034.0, 7215.458840587082, 7293.927060729325, 7351.632418378953, 7410.296021877913, 7446.25537446251, 10412.791744165226, 10547.261691681815, 10609.628662996758, 10682.893171068501, 10782.245242832927, 9971.850422243817, 10325.028856776431, 10494.317869338469, 10688.946555267174, 10742.785144297226, 9988.200943924323, 10324.690259292232, 10381.896181038093, 10474.633387831389, 10517.579296828348, 9881.20950323958, 9991.100800927952, 10225.84661230097, 10258.948705256425, 10295.352743560994, 8622.396432249683, 8683.292415040894, 8720.984962964647, 8865.290776737716, 9003.61404227867, 8456.2812160967, 8869.778255543662, 8914.197722205032, 9005.774855628662, 9090.454572725657]}, "summary": {"suite": 6343.8827329708365, "subtests": {"jquery.html": {"filtered": 7375.871538582085, "value": 7375.871538582085}, "dojo.html": {"filtered": 4974.407012926408, "value": 4974.407012926408}, "mootools.html": {"filtered": 4001.3005095827875, "value": 4001.3005095827875}, "ext.html": {"filtered": 17408.921591767274, "value": 17408.921591767274}, "prototype.html": {"filtered": 4591.899818784876, "value": 4591.899818784876}, "yui.html": {"filtered": 5553.529558475701, "value": 5553.529558475701}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0029.e"}, "testrun": {"date": 1446769381, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151105140536", "branch": "Fx-Team", "revision": "319e09c9668b8d2937c49dabdfd84a30d8771ac1"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 172.0, 172.0, 177.0, 179.0, 188.0, 195.0, 182.0, 181.0, 178.0], "ai-astar": [112.0, 101.0, 110.0, 109.0, 109.0, 120.0, 111.0, 112.0, 111.0, 109.0], "imaging-gaussian-blur": [127.0, 121.0, 129.0, 125.0, 136.0, 130.0, 125.0, 124.0, 130.0, 130.0], "audio-beat-detection": [162.0, 132.0, 156.0, 164.0, 138.0, 153.0, 155.0, 130.0, 179.0, 145.0], "json-stringify-tinderbox": [69.0, 68.0, 69.0, 72.0, 71.0, 73.0, 74.0, 77.0, 77.0, 77.0], "stanford-crypto-pbkdf2": [143.0, 152.0, 161.0, 164.0, 156.0, 173.0, 162.0, 165.0, 169.0, 175.0], "json-parse-financial": [64.0, 63.0, 63.0, 63.0, 63.0, 64.0, 66.0, 75.0, 69.0, 69.0], "stanford-crypto-sha256-iterative": [71.0, 71.0, 71.0, 71.0, 74.0, 78.0, 76.0, 79.0, 80.0, 80.0], "audio-fft": [71.0, 77.0, 78.0, 69.0, 73.0, 74.0, 78.0, 137.0, 74.0, 90.0], "imaging-darkroom": [133.0, 127.0, 143.0, 143.0, 136.0, 142.0, 142.0, 137.0, 144.0, 143.0], "stanford-crypto-ccm": [129.0, 136.0, 143.0, 153.0, 143.0, 142.0, 141.0, 154.0, 147.0, 139.0], "audio-oscillator": [89.0, 90.0, 131.0, 92.0, 97.0, 100.0, 142.0, 98.0, 100.0, 140.0], "stanford-crypto-aes": [90.0, 92.0, 93.0, 94.0, 97.0, 98.0, 99.0, 98.0, 93.0, 95.0], "imaging-desaturate": [109.0, 116.0, 117.0, 116.0, 116.0, 126.0, 117.0, 118.0, 116.0, 116.0]}, "summary": {"suite": 1627.2000000000003, "subtests": {"audio-fft": {"filtered": 82.1, "value": 82.1}, "stanford-crypto-pbkdf2": {"filtered": 162.0, "value": 162.0}, "audio-beat-detection": {"filtered": 151.4, "value": 151.4}, "stanford-crypto-ccm": {"filtered": 142.7, "value": 142.7}, "imaging-darkroom": {"filtered": 139.0, "value": 139.0}, "json-parse-financial": {"filtered": 65.9, "value": 65.9}, "audio-oscillator": {"filtered": 107.9, "value": 107.9}, "ai-astar": {"filtered": 110.4, "value": 110.4}, "audio-dft": {"filtered": 178.7, "value": 178.7}, "stanford-crypto-sha256-iterative": {"filtered": 75.1, "value": 75.1}, "json-stringify-tinderbox": {"filtered": 72.7, "value": 72.7}, "imaging-gaussian-blur": {"filtered": 127.7, "value": 127.7}, "stanford-crypto-aes": {"filtered": 94.9, "value": 94.9}, "imaging-desaturate": {"filtered": 116.7, "value": 116.7}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0029.e"}, "testrun": {"date": 1446769381, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151105140536", "branch": "Fx-Team", "revision": "319e09c9668b8d2937c49dabdfd84a30d8771ac1"}}, {"talos_counters": {}, "results": {"DeltaBlue": [200.7628990162618], "Encrypt": [337.4957813027337], "NavierStokes": [6078.787878787879], "Decrypt": [6211.180124223602], "Splay": [697.8367062107467], "Richards": [173.82235355466713], "RegExp": [30515.151515151516], "Earley": [841.7508417508418], "Boyer": [13835.616438356165], "RayTrace": [1184.8341232227488]}, "summary": {"suite": 18542.83564351637, "subtests": {"DeltaBlue": {"filtered": 329.3337579999999, "value": 329.3337579999999}, "Encrypt": {"filtered": 788.6943030000001, "value": 788.6943030000001}, "NavierStokes": {"filtered": 244.12761714855432, "value": 244.12761714855432}, "Decrypt": {"filtered": 42.855141000000025, "value": 42.855141000000025}, "Splay": {"filtered": 116.776603, "value": 116.776603}, "RegExp": {"filtered": 29.853530287984096, "value": 29.853530287984096}, "Richards": {"filtered": 203.092406, "value": 203.092406}, "Earley": {"filtered": 791.7580439999996, "value": 791.7580439999996}, "Boyer": {"filtered": 48.170098019801976, "value": 48.170098019801976}, "RayTrace": {"filtered": 624.5507160000001, "value": 624.5507160000001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0029.e"}, "testrun": {"date": 1446769381, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151105140536", "branch": "Fx-Team", "revision": "319e09c9668b8d2937c49dabdfd84a30d8771ac1"}}] 16:43:09 INFO - RETURN: dromaeo_css: 6343.88 16:43:09 INFO - RETURN: kraken: 1627.20 16:43:09 INFO - RETURN: v8_7: 18542.84 16:43:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "18542.84"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "1627.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "6343.88"}}} 16:43:09 INFO - Return code: 0 16:43:09 INFO - # TBPL SUCCESS # 16:43:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:43:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:43:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:43:09 INFO - 2015-11-05 16:43:09.125 screenresolution[2531:19652] starting screenresolution argv=screenresolution get 16:43:09 INFO - 2015-11-05 16:43:09.128 screenresolution[2531:19652] Display 0: 1600x1200x32@60 16:43:09 INFO - 2015-11-05 16:43:09.135 screenresolution[2532:19655] starting screenresolution argv=screenresolution list 16:43:09 INFO - Available Modes on Display 0 16:43:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:43:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:43:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:43:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:43:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:43:09 INFO - Intel HD Graphics 3000: 16:43:09 INFO - Chipset Model: Intel HD Graphics 3000 16:43:09 INFO - Type: GPU 16:43:09 INFO - Bus: Built-In 16:43:09 INFO - VRAM (Total): 512 MB 16:43:09 INFO - VRAM (Dynamic, Max): 10 16:43:09 INFO - Vendor: Intel (0x8086) 16:43:09 INFO - Device ID: 0x0116 16:43:09 INFO - Revision ID: 0x0009 16:43:09 INFO - Displays: 16:43:09 INFO - Display: 16:43:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:43:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:43:09 INFO - Display Serial Number: 1600x1200 60 16:43:09 INFO - Main Display: Yes 16:43:09 INFO - Mirror: Off 16:43:09 INFO - Online: Yes 16:43:09 INFO - Rotation: Supported 16:43:09 INFO - Return code: 0 16:43:09 INFO - Running post-action listener: _resource_record_post_action 16:43:09 INFO - Running post-run listener: _resource_record_post_run 16:43:10 INFO - Total resource usage - Wall time: 1247s; CPU: 30.0%; Read bytes: 745472; Write bytes: 687632384; Read time: 157; Write time: 71045 16:43:10 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 342075904; Write bytes: 336721920; Read time: 33445; Write time: 3724 16:43:10 INFO - run-tests - Wall time: 1209s; CPU: 30.0%; Read bytes: 708608; Write bytes: 342439936; Read time: 137; Write time: 66402 16:43:10 INFO - Running post-run listener: _upload_blobber_files 16:43:10 INFO - Blob upload gear active. 16:43:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:43:10 INFO - Copying logs to upload dir... 16:43:10 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1297.256762 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2015-11-05 16:43:10.609025) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-05 16:43:10.612734) ========= 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.L7cpMrKHAy/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.95wtk6II3e/Listeners TMPDIR=/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009951 build_url: 'https://queue.taskcluster.net/v1/task/bpFw7qZKRZK_bDs3CS3XBg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-05 16:43:10.664949) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 16:43:10.665452) ========= 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.L7cpMrKHAy/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.95wtk6II3e/Listeners TMPDIR=/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005265 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 16:43:10.729926) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 16:43:10.730313) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 16:43:10.732025) ========= ========= Total master_lag: 0.32 =========