builder: mozilla-aurora_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0098 starttime: 1449007787.15 results: success (0) buildid: 20151201091731 builduid: 1a0b6662c10f4040a71070ae15db43d3 revision: e576dd92d0f27df387320ed59fce50803549828c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:47.149113) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:47.149485) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:47.149790) ========= 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.TPIzYUDd7l/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.ZLL42Kxsz3/Listeners TMPDIR=/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/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.005768 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:47.172968) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:47.173335) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:47.193622) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:47.193891) ========= 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.TPIzYUDd7l/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.ZLL42Kxsz3/Listeners TMPDIR=/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/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.005286 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:47.241807) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:47.242083) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:47.242441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:47.242716) ========= 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.TPIzYUDd7l/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.ZLL42Kxsz3/Listeners TMPDIR=/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/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-12-01 14:09:47-- 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.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% 1.62G=0s 2015-12-01 14:09:47 (1.62 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153917 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:47.410633) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:47.410947) ========= 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.TPIzYUDd7l/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.ZLL42Kxsz3/Listeners TMPDIR=/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/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.019865 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:47.459938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:47.460272) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e576dd92d0f27df387320ed59fce50803549828c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e576dd92d0f27df387320ed59fce50803549828c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TPIzYUDd7l/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.ZLL42Kxsz3/Listeners TMPDIR=/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/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-12-01 14:09:47,533 truncating revision to first 12 chars 2015-12-01 14:09:47,533 Setting DEBUG logging. 2015-12-01 14:09:47,533 attempt 1/10 2015-12-01 14:09:47,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e576dd92d0f2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-01 14:09:47,821 unpacking tar archive at: mozilla-aurora-e576dd92d0f2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538600 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:48.035239) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:48.035531) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:48.043713) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:48.043977) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-01 14:09:48.044363) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2015-12-01 14:09:48.044646) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TPIzYUDd7l/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.ZLL42Kxsz3/Listeners TMPDIR=/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/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 14:09:48 INFO - MultiFileLogger online at 20151201 14:09:48 in /builds/slave/test 14:09:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:09:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:09:48 INFO - {'append_to_log': False, 14:09:48 INFO - 'base_work_dir': '/builds/slave/test', 14:09:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:09:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:09:48 INFO - 'branch': 'Mozilla-Aurora', 14:09:48 INFO - 'buildbot_json_path': 'buildprops.json', 14:09:48 INFO - 'config_files': ('talos/mac_config.py',), 14:09:48 INFO - 'default_actions': ('clobber', 14:09:48 INFO - 'read-buildbot-config', 14:09:48 INFO - 'download-and-extract', 14:09:48 INFO - 'populate-webroot', 14:09:48 INFO - 'create-virtualenv', 14:09:48 INFO - 'install', 14:09:48 INFO - 'run-tests'), 14:09:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:09:48 INFO - 'download_minidump_stackwalk': True, 14:09:48 INFO - 'download_symbols': 'ondemand', 14:09:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:09:48 INFO - 'tooltool.py': '/tools/tooltool.py', 14:09:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:09:48 INFO - '/tools/misc-python/virtualenv.py')}, 14:09:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:09:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:09:48 INFO - 'installer_path': 'installer.exe', 14:09:48 INFO - 'log_level': 'info', 14:09:48 INFO - 'log_name': 'talos', 14:09:48 INFO - 'log_to_console': True, 14:09:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:09:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:09:48 INFO - 'opt_config_files': (), 14:09:48 INFO - 'pip_index': False, 14:09:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:09:48 INFO - 'cmd': ('bash', 14:09:48 INFO - '-c', 14:09:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:09:48 INFO - 'enabled': True, 14:09:48 INFO - 'halt_on_failure': False, 14:09:48 INFO - 'name': 'check_screen_resolution'},), 14:09:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:09:48 INFO - 'cmd': ('bash', 14:09:48 INFO - '-c', 14:09:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:09:48 INFO - 'enabled': True, 14:09:48 INFO - 'halt_on_failure': False, 14:09:48 INFO - 'name': 'check_screen_resolution'},), 14:09:48 INFO - 'run_cmd_checks_enabled': True, 14:09:48 INFO - 'sps_profile': False, 14:09:48 INFO - 'sps_profile_interval': 0, 14:09:48 INFO - 'suite': 'dromaeojs-e10s', 14:09:48 INFO - 'system_bits': '64', 14:09:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:09:48 INFO - 'title': 't-yosemite-r5-0098', 14:09:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:09:48 INFO - 'use_talos_json': True, 14:09:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:09:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:09:48 INFO - 'work_dir': 'build'} 14:09:48 INFO - ##### 14:09:48 INFO - ##### Running clobber step. 14:09:48 INFO - ##### 14:09:48 INFO - Running pre-action listener: _resource_record_pre_action 14:09:48 INFO - Running main action method: clobber 14:09:48 INFO - rmtree: /builds/slave/test/build 14:09:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:09:50 INFO - Running post-action listener: _resource_record_post_action 14:09:50 INFO - ##### 14:09:50 INFO - ##### Running read-buildbot-config step. 14:09:50 INFO - ##### 14:09:50 INFO - Running pre-action listener: _resource_record_pre_action 14:09:50 INFO - Running main action method: read_buildbot_config 14:09:50 INFO - Using buildbot properties: 14:09:50 INFO - { 14:09:50 INFO - "properties": { 14:09:50 INFO - "buildnumber": 0, 14:09:50 INFO - "product": "firefox", 14:09:50 INFO - "script_repo_revision": "production", 14:09:50 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs-e10s", 14:09:50 INFO - "repository": "", 14:09:50 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs-e10s", 14:09:50 INFO - "buildid": "20151201091731", 14:09:50 INFO - "slavename": "t-yosemite-r5-0098", 14:09:50 INFO - "pgo_build": "False", 14:09:50 INFO - "basedir": "/builds/slave/test", 14:09:50 INFO - "project": "", 14:09:50 INFO - "platform": "yosemite", 14:09:50 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:09:50 INFO - "slavebuilddir": "test", 14:09:50 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:09:50 INFO - "branch": "mozilla-aurora", 14:09:50 INFO - "repo_path": "releases/mozilla-aurora", 14:09:50 INFO - "stage_platform": "macosx64", 14:09:50 INFO - "builduid": "1a0b6662c10f4040a71070ae15db43d3", 14:09:50 INFO - "revision": "e576dd92d0f27df387320ed59fce50803549828c" 14:09:50 INFO - }, 14:09:50 INFO - "sourcestamp": { 14:09:50 INFO - "repository": "", 14:09:50 INFO - "hasPatch": false, 14:09:50 INFO - "project": "", 14:09:50 INFO - "branch": "mozilla-aurora-macosx64-talos", 14:09:50 INFO - "changes": [ 14:09:50 INFO - { 14:09:50 INFO - "category": null, 14:09:50 INFO - "files": [ 14:09:50 INFO - { 14:09:50 INFO - "url": null, 14:09:50 INFO - "name": "https://queue.taskcluster.net/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 14:09:50 INFO - } 14:09:50 INFO - ], 14:09:50 INFO - "repository": "", 14:09:50 INFO - "rev": "e576dd92d0f27df387320ed59fce50803549828c", 14:09:50 INFO - "who": "ryanvm@gmail.com", 14:09:50 INFO - "when": 1449007771, 14:09:50 INFO - "number": 6729602, 14:09:50 INFO - "comments": "Bug 1228359 - Allow experiments to register chrome. r=felipe, a=lizzard\n\nSimple obvious fix. Adds tests by making BootstrapMonitor (which\ntest_experiments.js and others use for verifying bootstrap startup and shutdown)\nverify the list of registered chrome manifests at various points. Without the\nfix this makes test_experiment fail as expected.", 14:09:50 INFO - "project": "", 14:09:50 INFO - "at": "Tue 01 Dec 2015 14:09:31", 14:09:50 INFO - "branch": "mozilla-aurora-macosx64-talos", 14:09:50 INFO - "revlink": "", 14:09:50 INFO - "properties": [ 14:09:50 INFO - [ 14:09:50 INFO - "buildid", 14:09:50 INFO - "20151201091731", 14:09:50 INFO - "Change" 14:09:50 INFO - ], 14:09:50 INFO - [ 14:09:50 INFO - "builduid", 14:09:50 INFO - "1a0b6662c10f4040a71070ae15db43d3", 14:09:50 INFO - "Change" 14:09:50 INFO - ], 14:09:50 INFO - [ 14:09:50 INFO - "pgo_build", 14:09:50 INFO - "False", 14:09:50 INFO - "Change" 14:09:50 INFO - ] 14:09:50 INFO - ], 14:09:50 INFO - "revision": "e576dd92d0f27df387320ed59fce50803549828c" 14:09:50 INFO - } 14:09:50 INFO - ], 14:09:50 INFO - "revision": "e576dd92d0f27df387320ed59fce50803549828c" 14:09:50 INFO - } 14:09:50 INFO - } 14:09:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 14:09:50 INFO - Running post-action listener: _resource_record_post_action 14:09:50 INFO - ##### 14:09:50 INFO - ##### Running download-and-extract step. 14:09:50 INFO - ##### 14:09:50 INFO - Running pre-action listener: _resource_record_pre_action 14:09:50 INFO - Running main action method: download_and_extract 14:09:50 INFO - mkdir: /builds/slave/test/build/tests 14:09: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')]} 14:09:50 INFO - https://queue.taskcluster.net/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:09:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/test_packages.json 14:09:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/test_packages.json 14:09:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:09:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:10:03 INFO - Downloaded 1149 bytes. 14:10:03 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:10:03 INFO - Using the following test package requirements: 14:10:03 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 14:10:03 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:10:03 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 14:10:03 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:10:03 INFO - u'jsshell-mac.zip'], 14:10:03 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:10:03 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 14:10:03 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 14:10:03 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:10:03 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 14:10:03 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:10:03 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 14:10:03 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:10:03 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 14:10:03 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 14:10:03 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:10:03 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 14:10:03 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:10: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')]} 14:10:03 INFO - https://queue.taskcluster.net/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:10:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:10:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:10:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:10:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:10:14 INFO - Downloaded 17490120 bytes. 14:10:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 14:10:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:10:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 14:10:19 INFO - Return code: 0 14:10:19 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 14:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:19 INFO - https://queue.taskcluster.net/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:10:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:10:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:10:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:10:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:10:27 INFO - Downloaded 17490120 bytes. 14:10:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 14:10:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:10:27 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 14:10:33 INFO - Return code: 0 14:10: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')]} 14:10:33 INFO - https://queue.taskcluster.net/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:10:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 14:10:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 14:10:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 14:10:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 14:10:35 INFO - Downloaded 11131307 bytes. 14:10:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 14:10:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 14:10:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 14:10:35 INFO - Return code: 0 14:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:35 INFO - https://queue.taskcluster.net/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 14:10:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:10:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:10:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 14:10:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 14:10:42 INFO - Downloaded 108648812 bytes. 14:10:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:10:42 INFO - mkdir: /builds/slave/test/properties 14:10:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:10:42 INFO - Writing to file /builds/slave/test/properties/build_url 14:10:42 INFO - Contents: 14:10:42 INFO - build_url:https://queue.taskcluster.net/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:10:42 INFO - Running post-action listener: _resource_record_post_action 14:10:42 INFO - Running post-action listener: set_extra_try_arguments 14:10:42 INFO - ##### 14:10:42 INFO - ##### Running populate-webroot step. 14:10:42 INFO - ##### 14:10:42 INFO - Running pre-action listener: _resource_record_pre_action 14:10:42 INFO - Running main action method: populate_webroot 14:10:42 INFO - Guessing talos json url... 14:10:42 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')]} 14:10:42 INFO - https://queue.taskcluster.net/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 14:10:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 14:10:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 14:10:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 14:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 14:10:42 INFO - Downloaded 107 bytes. 14:10:42 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 14:10:42 INFO - Contents: 14:10:42 INFO - 20151201091731 14:10:42 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/e576dd92d0f27df387320ed59fce50803549828c 14:10:42 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')]} 14:10:42 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e576dd92d0/testing/talos/talos.json 14:10:42 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e576dd92d0/testing/talos/talos.json to /builds/slave/test/build/talos.json 14:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/e576dd92d0/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 14:10:43 INFO - Downloaded 4264 bytes. 14:10:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:10:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:10:43 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:10:43 INFO - '../fennec_ids.txt'], 14:10:43 INFO - 'tests': ['tcheck2']}, 14:10:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:10:43 INFO - '--tppagecycles', 14:10:43 INFO - '7'], 14:10:43 INFO - 'tests': ['tsvgm']}}, 14:10:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:10:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:10:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:10:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:10:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:10:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:10:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:43 INFO - 'talos_options': ['--e10s'], 14:10:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:43 INFO - 'tests': ['damp', 'tps']}, 14:10:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:43 INFO - 'talos_options': ['--e10s'], 14:10:43 INFO - 'tests': ['damp', 'tps']}, 14:10:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:10:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:10:43 INFO - 'other': {'tests': ['a11yr', 14:10:43 INFO - 'ts_paint', 14:10:43 INFO - 'tpaint', 14:10:43 INFO - 'sessionrestore', 14:10:43 INFO - 'sessionrestore_no_auto_restore']}, 14:10:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:10:43 INFO - 'tests': ['a11yr', 14:10:43 INFO - 'ts_paint', 14:10:43 INFO - 'tpaint', 14:10:43 INFO - 'sessionrestore', 14:10:43 INFO - 'sessionrestore_no_auto_restore']}, 14:10:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:10:43 INFO - 'tests': ['a11yr', 14:10:43 INFO - 'ts_paint', 14:10:43 INFO - 'tpaint', 14:10:43 INFO - 'sessionrestore', 14:10:43 INFO - 'sessionrestore_no_auto_restore']}, 14:10:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:10:43 INFO - 'tests': ['a11yr', 14:10:43 INFO - 'ts_paint', 14:10:43 INFO - 'tpaint', 14:10:43 INFO - 'sessionrestore', 14:10:43 INFO - 'sessionrestore_no_auto_restore']}, 14:10:43 INFO - 'other_l64': {'tests': ['a11yr', 14:10:43 INFO - 'ts_paint', 14:10:43 INFO - 'tpaint', 14:10:43 INFO - 'sessionrestore', 14:10:43 INFO - 'sessionrestore_no_auto_restore']}, 14:10:43 INFO - 'other_nol64': {'tests': ['a11yr', 14:10:43 INFO - 'ts_paint', 14:10:43 INFO - 'tpaint', 14:10:43 INFO - 'sessionrestore', 14:10:43 INFO - 'sessionrestore_no_auto_restore']}, 14:10:43 INFO - 'svgr': {'tests': ['tsvgx', 14:10:43 INFO - 'tsvgr_opacity', 14:10:43 INFO - 'tart', 14:10:43 INFO - 'tscrollx', 14:10:43 INFO - 'cart']}, 14:10:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:10:43 INFO - 'tests': ['tsvgx', 14:10:43 INFO - 'tsvgr_opacity', 14:10:43 INFO - 'tart', 14:10:43 INFO - 'tscrollx', 14:10:43 INFO - 'cart']}, 14:10:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:43 INFO - 'tests': ['tp5o']}, 14:10:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:43 INFO - 'talos_options': ['--e10s'], 14:10:43 INFO - 'tests': ['tp5o']}, 14:10:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:43 INFO - 'talos_options': ['--xperf_path', 14:10:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:43 INFO - 'tests': ['tp5n']}, 14:10:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:43 INFO - 'talos_options': ['--e10s', 14:10:43 INFO - '--xperf_path', 14:10:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 14:10:43 INFO - 'C:/slave/talos-data/talos/xperf.config'], 14:10:43 INFO - 'tests': ['tp5n']}}, 14:10:43 INFO - 'talos.zip': {'path': '', 14:10:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:10:43 INFO - Running post-action listener: _resource_record_post_action 14:10:43 INFO - ##### 14:10:43 INFO - ##### Running create-virtualenv step. 14:10:43 INFO - ##### 14:10:43 INFO - Running pre-action listener: _resource_record_pre_action 14:10:43 INFO - Running main action method: create_virtualenv 14:10:43 INFO - Creating virtualenv /builds/slave/test/build/venv 14:10:43 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 14:10:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:10:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:10:43 INFO - Using real prefix '/tools/python27' 14:10:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:10:44 INFO - Installing distribute.............................................................................................................................................................................................done. 14:10:47 INFO - Installing pip.................done. 14:10:47 INFO - Return code: 0 14:10:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:10:47 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')]} 14:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:47 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')]} 14:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:47 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 0x10fafba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb68228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd868e4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fab09f0>, '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 0x10f80fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa7a990>, '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.TPIzYUDd7l/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.ZLL42Kxsz3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/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 14:10:47 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 14:10:47 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 14:10:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPIzYUDd7l/Render', 14:10:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:47 INFO - 'HOME': '/Users/cltbld', 14:10:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:47 INFO - 'LOGNAME': 'cltbld', 14:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:47 INFO - 'MOZ_NO_REMOTE': '1', 14:10:47 INFO - 'NO_EM_RESTART': '1', 14:10:47 INFO - 'PAGER': '/bin/cat', 14:10:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:47 INFO - 'PWD': '/builds/slave/test', 14:10:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:47 INFO - 'SHELL': '/bin/bash', 14:10:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZLL42Kxsz3/Listeners', 14:10:47 INFO - 'TMPDIR': '/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/', 14:10:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:47 INFO - 'USER': 'cltbld', 14:10:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:47 INFO - 'XPC_FLAGS': '0x0', 14:10:47 INFO - 'XPC_SERVICE_NAME': '0', 14:10:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:47 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 14:10:47 INFO - Cleaning up... 14:10:47 INFO - Return code: 0 14:10:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:10:47 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')]} 14:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:48 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 0x10fafba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb68228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd868e4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fab09f0>, '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 0x10f80fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa7a990>, '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.TPIzYUDd7l/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.ZLL42Kxsz3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/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 14:10:48 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 14:10:48 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 14:10:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPIzYUDd7l/Render', 14:10:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:48 INFO - 'HOME': '/Users/cltbld', 14:10:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:48 INFO - 'LOGNAME': 'cltbld', 14:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:48 INFO - 'MOZ_NO_REMOTE': '1', 14:10:48 INFO - 'NO_EM_RESTART': '1', 14:10:48 INFO - 'PAGER': '/bin/cat', 14:10:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:48 INFO - 'PWD': '/builds/slave/test', 14:10:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:48 INFO - 'SHELL': '/bin/bash', 14:10:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZLL42Kxsz3/Listeners', 14:10:48 INFO - 'TMPDIR': '/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/', 14:10:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:48 INFO - 'USER': 'cltbld', 14:10:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:48 INFO - 'XPC_FLAGS': '0x0', 14:10:48 INFO - 'XPC_SERVICE_NAME': '0', 14:10:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:48 INFO - Downloading/unpacking psutil>=0.7.1 14:10:48 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 14:10:48 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 14:10:48 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 14:10:48 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 14:10:48 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 14:10:48 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 14:10:50 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:10:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:10:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:50 INFO - Installing collected packages: psutil 14:10:50 INFO - Running setup.py install for psutil 14:10:50 INFO - building 'psutil._psutil_osx' extension 14:10:50 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 14:10:51 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 14:10:51 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 14:10:51 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 14:10:51 INFO - building 'psutil._psutil_posix' extension 14:10:51 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 14:10:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:10:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:10:51 INFO - ^ 14:10:51 INFO - 1 warning generated. 14:10:51 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 14:10:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:51 INFO - Successfully installed psutil 14:10:51 INFO - Cleaning up... 14:10:51 INFO - Return code: 0 14:10:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fafba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb68228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd868e4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fab09f0>, '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 0x10f80fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa7a990>, '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.TPIzYUDd7l/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.ZLL42Kxsz3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/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 14:10:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:10:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPIzYUDd7l/Render', 14:10:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:51 INFO - 'HOME': '/Users/cltbld', 14:10:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:51 INFO - 'LOGNAME': 'cltbld', 14:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:51 INFO - 'MOZ_NO_REMOTE': '1', 14:10:51 INFO - 'NO_EM_RESTART': '1', 14:10:51 INFO - 'PAGER': '/bin/cat', 14:10:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:51 INFO - 'PWD': '/builds/slave/test', 14:10:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:51 INFO - 'SHELL': '/bin/bash', 14:10:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZLL42Kxsz3/Listeners', 14:10:51 INFO - 'TMPDIR': '/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/', 14:10:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:51 INFO - 'USER': 'cltbld', 14:10:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:51 INFO - 'XPC_FLAGS': '0x0', 14:10:51 INFO - 'XPC_SERVICE_NAME': '0', 14:10:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:10:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:10:54 INFO - Installing collected packages: mozsystemmonitor 14:10:54 INFO - Running setup.py install for mozsystemmonitor 14:10:54 INFO - Successfully installed mozsystemmonitor 14:10:54 INFO - Cleaning up... 14:10:55 INFO - Return code: 0 14:10:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fafba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb68228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd868e4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fab09f0>, '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 0x10f80fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa7a990>, '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.TPIzYUDd7l/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.ZLL42Kxsz3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/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 14:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:10:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPIzYUDd7l/Render', 14:10:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:55 INFO - 'HOME': '/Users/cltbld', 14:10:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:55 INFO - 'LOGNAME': 'cltbld', 14:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:55 INFO - 'MOZ_NO_REMOTE': '1', 14:10:55 INFO - 'NO_EM_RESTART': '1', 14:10:55 INFO - 'PAGER': '/bin/cat', 14:10:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:55 INFO - 'PWD': '/builds/slave/test', 14:10:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:55 INFO - 'SHELL': '/bin/bash', 14:10:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZLL42Kxsz3/Listeners', 14:10:55 INFO - 'TMPDIR': '/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/', 14:10:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:55 INFO - 'USER': 'cltbld', 14:10:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:55 INFO - 'XPC_FLAGS': '0x0', 14:10:55 INFO - 'XPC_SERVICE_NAME': '0', 14:10:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:55 INFO - Downloading/unpacking blobuploader==1.2.4 14:10:55 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 14:10:55 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 14:10:55 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 14:10:55 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 14:10:55 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 14:10:55 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 14:10:57 INFO - Downloading blobuploader-1.2.4.tar.gz 14:10:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:10:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:10:57 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 14:10:57 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 14:10:57 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 14:10:57 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 14:10:57 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 14:10:57 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 14:10:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:10:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:58 INFO - Downloading docopt-0.6.1.tar.gz 14:10:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:10:59 INFO - Installing collected packages: blobuploader, requests, docopt 14:10:59 INFO - Running setup.py install for blobuploader 14:10:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:10:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:10:59 INFO - Running setup.py install for requests 14:10:59 INFO - Running setup.py install for docopt 14:10:59 INFO - Successfully installed blobuploader requests docopt 14:10:59 INFO - Cleaning up... 14:11:00 INFO - Return code: 0 14:11:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:00 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')]} 14:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:00 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')]} 14:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:00 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 0x10fafba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb68228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd868e4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fab09f0>, '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 0x10f80fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa7a990>, '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.TPIzYUDd7l/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.ZLL42Kxsz3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/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 14:11:00 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 14:11:00 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 14:11:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPIzYUDd7l/Render', 14:11:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:00 INFO - 'HOME': '/Users/cltbld', 14:11:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:00 INFO - 'LOGNAME': 'cltbld', 14:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:00 INFO - 'MOZ_NO_REMOTE': '1', 14:11:00 INFO - 'NO_EM_RESTART': '1', 14:11:00 INFO - 'PAGER': '/bin/cat', 14:11:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:00 INFO - 'PWD': '/builds/slave/test', 14:11:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:00 INFO - 'SHELL': '/bin/bash', 14:11:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZLL42Kxsz3/Listeners', 14:11:00 INFO - 'TMPDIR': '/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/', 14:11:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:00 INFO - 'USER': 'cltbld', 14:11:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:00 INFO - 'XPC_FLAGS': '0x0', 14:11:00 INFO - 'XPC_SERVICE_NAME': '0', 14:11:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:00 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-fAe5t4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:00 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-uPkhD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:00 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-T4lIyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:00 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-zgw6PF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:00 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-MUc0aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:00 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-5YAdpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:01 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-4_XNKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:01 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-Aj412z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:01 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-8Gz_YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:01 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-K1aJaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:01 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-8d1zdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:01 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-qte5HI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:01 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-83ArWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:01 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-J8n47N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:02 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-5qWVgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:02 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-4bFxEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:02 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-C9qpWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:11:02 INFO - Running setup.py install for manifestparser 14:11:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:11:02 INFO - Running setup.py install for mozcrash 14:11:02 INFO - Running setup.py install for mozdebug 14:11:02 INFO - Running setup.py install for mozdevice 14:11:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:11:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:11:03 INFO - Running setup.py install for mozfile 14:11:03 INFO - Running setup.py install for mozhttpd 14:11:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:11:03 INFO - Running setup.py install for mozinfo 14:11:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:11:03 INFO - Running setup.py install for mozInstall 14:11:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:11:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:11:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:11:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:11:03 INFO - Running setup.py install for mozleak 14:11:03 INFO - Running setup.py install for mozlog 14:11:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:11:04 INFO - Running setup.py install for moznetwork 14:11:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:11:04 INFO - Running setup.py install for mozprocess 14:11:04 INFO - Running setup.py install for mozprofile 14:11:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:11:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:11:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:11:04 INFO - Running setup.py install for mozrunner 14:11:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:11:04 INFO - Running setup.py install for mozscreenshot 14:11:05 INFO - Running setup.py install for moztest 14:11:05 INFO - Running setup.py install for mozversion 14:11:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:11:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:05 INFO - Cleaning up... 14:11:05 INFO - Return code: 0 14:11:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:05 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 0x10fafba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb68228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd868e4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fab09f0>, '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 0x10f80fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa7a990>, '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.TPIzYUDd7l/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.ZLL42Kxsz3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/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 14:11:05 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 14:11:05 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 14:11:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPIzYUDd7l/Render', 14:11:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:05 INFO - 'HOME': '/Users/cltbld', 14:11:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:05 INFO - 'LOGNAME': 'cltbld', 14:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:05 INFO - 'MOZ_NO_REMOTE': '1', 14:11:05 INFO - 'NO_EM_RESTART': '1', 14:11:05 INFO - 'PAGER': '/bin/cat', 14:11:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:05 INFO - 'PWD': '/builds/slave/test', 14:11:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:05 INFO - 'SHELL': '/bin/bash', 14:11:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZLL42Kxsz3/Listeners', 14:11:05 INFO - 'TMPDIR': '/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/', 14:11:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:05 INFO - 'USER': 'cltbld', 14:11:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:05 INFO - 'XPC_FLAGS': '0x0', 14:11:05 INFO - 'XPC_SERVICE_NAME': '0', 14:11:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:05 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-Pr662k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:05 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)) 14:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:05 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-QrZivu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:05 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)) 14:11:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:05 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-O91WAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:06 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)) 14:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:06 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-Qbuc0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 14:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:06 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-IaK3yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:06 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)) 14:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:06 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-zL2DJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:06 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)) 14:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:06 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-Rxenh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 14:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:06 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-ovWDoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:06 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)) 14:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:06 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-Lyx3kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:06 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)) 14:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:06 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-K3lKYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:06 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)) 14:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:06 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-AZRpSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:07 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)) 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:07 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-Kr2KYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:07 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)) 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:07 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-no4MfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:07 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)) 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:07 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-MmquhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:07 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)) 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:07 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-FrJgdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:07 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)) 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:07 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-FRKUjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:07 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)) 14:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:07 INFO - Running setup.py (path:/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/pip-TU3Qh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:07 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)) 14:11:07 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)) 14:11:07 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)) 14:11:07 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)) 14:11:07 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:07 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:07 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 14:11:07 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 14:11:07 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 14:11:07 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 14:11:07 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 14:11:07 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 14:11:10 INFO - Downloading blessings-1.5.1.tar.gz 14:11:10 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 14:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:11:10 INFO - Installing collected packages: blessings 14:11:10 INFO - Running setup.py install for blessings 14:11:10 INFO - Successfully installed blessings 14:11:10 INFO - Cleaning up... 14:11:10 INFO - Return code: 0 14:11:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:11:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:11 INFO - Reading from file tmpfile_stdout 14:11:11 INFO - Current package versions: 14:11:11 INFO - blessings == 1.5.1 14:11:11 INFO - blobuploader == 1.2.4 14:11:11 INFO - docopt == 0.6.1 14:11:11 INFO - manifestparser == 1.1 14:11:11 INFO - mozInstall == 1.12 14:11:11 INFO - mozcrash == 0.16 14:11:11 INFO - mozdebug == 0.1 14:11:11 INFO - mozdevice == 0.46 14:11:11 INFO - mozfile == 1.2 14:11:11 INFO - mozhttpd == 0.7 14:11:11 INFO - mozinfo == 0.8 14:11:11 INFO - mozleak == 0.1 14:11:11 INFO - mozlog == 3.0 14:11:11 INFO - moznetwork == 0.27 14:11:11 INFO - mozprocess == 0.22 14:11:11 INFO - mozprofile == 0.27 14:11:11 INFO - mozrunner == 6.11 14:11:11 INFO - mozscreenshot == 0.1 14:11:11 INFO - mozsystemmonitor == 0.0 14:11:11 INFO - moztest == 0.7 14:11:11 INFO - mozversion == 1.4 14:11:11 INFO - psutil == 3.1.1 14:11:11 INFO - requests == 1.2.3 14:11:11 INFO - wsgiref == 0.1.2 14:11:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:11 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 0x10fafba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb68228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd868e4ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fab09f0>, '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 0x10f80fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa7a990>, '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.TPIzYUDd7l/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.ZLL42Kxsz3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/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 14:11:11 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 14:11:11 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 14:11:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPIzYUDd7l/Render', 14:11:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:11 INFO - 'HOME': '/Users/cltbld', 14:11:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:11 INFO - 'LOGNAME': 'cltbld', 14:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:11 INFO - 'MOZ_NO_REMOTE': '1', 14:11:11 INFO - 'NO_EM_RESTART': '1', 14:11:11 INFO - 'PAGER': '/bin/cat', 14:11:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:11 INFO - 'PWD': '/builds/slave/test', 14:11:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:11 INFO - 'SHELL': '/bin/bash', 14:11:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZLL42Kxsz3/Listeners', 14:11:11 INFO - 'TMPDIR': '/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/', 14:11:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:11 INFO - 'USER': 'cltbld', 14:11:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:11 INFO - 'XPC_FLAGS': '0x0', 14:11:11 INFO - 'XPC_SERVICE_NAME': '0', 14:11:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:11 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)) 14:11:11 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)) 14:11:11 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)) 14:11:11 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)) 14:11:11 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)) 14:11:11 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)) 14:11:11 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)) 14:11:11 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)) 14:11:11 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)) 14:11:11 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)) 14:11:11 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)) 14:11:11 INFO - Cleaning up... 14:11:11 INFO - Return code: 0 14:11:11 INFO - Running post-action listener: _resource_record_post_action 14:11:11 INFO - Running post-action listener: _start_resource_monitoring 14:11:11 INFO - Starting resource monitoring. 14:11:11 INFO - ##### 14:11:11 INFO - ##### Running install step. 14:11:11 INFO - ##### 14:11:11 INFO - Running pre-action listener: _resource_record_pre_action 14:11:11 INFO - Running main action method: install 14:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:11 INFO - Reading from file tmpfile_stdout 14:11:11 INFO - Detecting whether we're running mozinstall >=1.0... 14:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:11:11 INFO - Reading from file tmpfile_stdout 14:11:11 INFO - Output received: 14:11:11 INFO - Usage: mozinstall [options] installer 14:11:11 INFO - Options: 14:11:11 INFO - -h, --help show this help message and exit 14:11:11 INFO - -d DEST, --destination=DEST 14:11:11 INFO - Directory to install application into. [default: 14:11:11 INFO - "/builds/slave/test"] 14:11:11 INFO - --app=APP Application being installed. [default: firefox] 14:11:11 INFO - mkdir: /builds/slave/test/build/application 14:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 14:11:50 INFO - Reading from file tmpfile_stdout 14:11:50 INFO - Output received: 14:11:50 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:11:50 INFO - Running post-action listener: _resource_record_post_action 14:11:50 INFO - ##### 14:11:50 INFO - ##### Running run-tests step. 14:11:50 INFO - ##### 14:11:50 INFO - Running pre-action listener: _resource_record_pre_action 14:11:50 INFO - Running main action method: run_tests 14:11:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:11:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:11:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:11:50 INFO - 2015-12-01 14:11:50.542 screenresolution[1940:14076] starting screenresolution argv=screenresolution get 14:11:50 INFO - 2015-12-01 14:11:50.545 screenresolution[1940:14076] Display 0: 1600x1200x32@60 14:11:50 INFO - 2015-12-01 14:11:50.552 screenresolution[1941:14078] starting screenresolution argv=screenresolution list 14:11:50 INFO - Available Modes on Display 0 14:11:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:11:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:11:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:11:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:11:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:11:50 INFO - Intel HD Graphics 3000: 14:11:50 INFO - Chipset Model: Intel HD Graphics 3000 14:11:50 INFO - Type: GPU 14:11:50 INFO - Bus: Built-In 14:11:50 INFO - VRAM (Total): 512 MB 14:11:50 INFO - VRAM (Dynamic, Max): 10 14:11:50 INFO - Vendor: Intel (0x8086) 14:11:50 INFO - Device ID: 0x0116 14:11:50 INFO - Revision ID: 0x0009 14:11:50 INFO - Displays: 14:11:50 INFO - Display: 14:11:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:11:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:11:50 INFO - Display Serial Number: 1600x1200 60 14:11:50 INFO - Main Display: Yes 14:11:50 INFO - Mirror: Off 14:11:50 INFO - Online: Yes 14:11:50 INFO - Rotation: Supported 14:11:50 INFO - Return code: 0 14:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:11:50 INFO - Python 2.7.3 14:11:50 INFO - Return code: 0 14:11:50 INFO - grabbing minidump binary from tooltool 14:11: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')]} 14:11:50 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 0x10fab09f0>, '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 0x10f80fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa7a990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:11:50 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 14:11:50 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 14:11:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:11:50 INFO - Return code: 0 14:11:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:11:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:11:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:11:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:11:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0098', '--webServer', 'localhost'] in /builds/slave/test/build 14:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0098 --webServer localhost 14:11:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPIzYUDd7l/Render', 14:11:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:50 INFO - 'HOME': '/Users/cltbld', 14:11:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:50 INFO - 'LOGNAME': 'cltbld', 14:11:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:11:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:50 INFO - 'MOZ_NO_REMOTE': '1', 14:11:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:11:50 INFO - 'NO_EM_RESTART': '1', 14:11:50 INFO - 'PAGER': '/bin/cat', 14:11:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:50 INFO - 'PWD': '/builds/slave/test', 14:11:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:11:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:50 INFO - 'SHELL': '/bin/bash', 14:11:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZLL42Kxsz3/Listeners', 14:11:50 INFO - 'TMPDIR': '/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/', 14:11:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:50 INFO - 'USER': 'cltbld', 14:11:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:50 INFO - 'XPC_FLAGS': '0x0', 14:11:50 INFO - 'XPC_SERVICE_NAME': '0', 14:11:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:11:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0098', '--webServer', 'localhost'] with output_timeout 3600 14:11:51 INFO - mozversion INFO | application_buildid: 20151201091731 14:11:51 INFO - mozversion INFO | application_changeset: e576dd92d0f27df387320ed59fce50803549828c 14:11:51 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 14:11:51 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:11:51 INFO - mozversion INFO | application_name: Firefox 14:11:51 INFO - mozversion INFO | application_remotingname: firefox-dev 14:11:51 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:11:51 INFO - mozversion INFO | application_vendor: Mozilla 14:11:51 INFO - mozversion INFO | application_version: 44.0a2 14:11:51 INFO - mozversion INFO | platform_buildid: 20151201091731 14:11:51 INFO - mozversion INFO | platform_changeset: e576dd92d0f27df387320ed59fce50803549828c 14:11:51 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:11:51 INFO - mozversion INFO | platform_version: 44.0a2 14:11:51 INFO - 2015-12-01 14:11:51,190 DEBUG : using testdate: 1449007911 14:11:51 INFO - 2015-12-01 14:11:51,190 DEBUG : actual date: 1449007911 14:11:51 INFO - 2015-12-01 14:11:51,200 INFO : starting webserver on 'localhost:49651' 14:11:51 INFO - 2015-12-01 14:11:51,201 INFO : Starting test suite t-yosemite-r5-0098.e 14:11:51 INFO - 2015-12-01 14:11:51,201 INFO : Starting test dromaeo_css 14:11:51 INFO - 2015-12-01 14:11:51,201 DEBUG : operating with platform_type : mac_ 14:11:51 INFO - 2015-12-01 14:11:51,202 INFO : Initialising browser for dromaeo_css test... 14:11:51 INFO - 2015-12-01 14:11:51,229 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/tmpnDuqwc/profile http://localhost:49651/getInfo.html 14:11:54 INFO - 2015-12-01 14:11:54,133 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:11:54 INFO - 2015-12-01 14:11:54,133 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:11:54 INFO - 2015-12-01 14:11:54,133 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:11:54 INFO - 2015-12-01 14:11:54,135 DEBUG : BROWSER_OUTPUT: __metrics 14:11:54 INFO - 2015-12-01 14:11:54,755 INFO : Browser initialized. 14:11:54 INFO - 2015-12-01 14:11:54,755 INFO : Running cycle 1/1 for dromaeo_css test... 14:11:54 INFO - 2015-12-01 14:11:54,756 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/tmpnDuqwc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:12:06 INFO - 2015-12-01 14:12:06,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 210669568 14:12:06 INFO - 2015-12-01 14:12:06,737 DEBUG : BROWSER_OUTPUT: 14:12:56 INFO - 2015-12-01 14:12:56,572 DEBUG : BROWSER_OUTPUT: 1449007976570 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] 14:15:07 INFO - 2015-12-01 14:15:07,366 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49651/tests/dromaeo/cssquery-ext.html) 14:15:08 INFO - 2015-12-01 14:15:08,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 235872256 14:15:08 INFO - 2015-12-01 14:15:08,647 DEBUG : BROWSER_OUTPUT: 14:18:10 INFO - 2015-12-01 14:18:10,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/dromaeo/cssquery-ext.html (next: http://localhost:49651/tests/dromaeo/cssquery-jquery.html) 14:18:11 INFO - 2015-12-01 14:18:11,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 242880512 14:18:11 INFO - 2015-12-01 14:18:11,319 DEBUG : BROWSER_OUTPUT: 14:21:13 INFO - 2015-12-01 14:21:13,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49651/tests/dromaeo/cssquery-mootools.html) 14:21:13 INFO - 2015-12-01 14:21:13,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 242753536 14:21:13 INFO - 2015-12-01 14:21:13,658 DEBUG : BROWSER_OUTPUT: 14:24:15 INFO - 2015-12-01 14:24:15,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49651/tests/dromaeo/cssquery-prototype.html) 14:24:15 INFO - 2015-12-01 14:24:15,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 247816192 14:24:15 INFO - 2015-12-01 14:24:15,947 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2015-12-01 14:27:18,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49651/tests/dromaeo/cssquery-yui.html) 14:27:19 INFO - 2015-12-01 14:27:19,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 254312448 14:27:19 INFO - 2015-12-01 14:27:19,158 DEBUG : BROWSER_OUTPUT: 14:30:21 INFO - 2015-12-01 14:30:21,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/dromaeo/cssquery-yui.html (next: http://localhost:49651/tests/dromaeo/cssquery-dojo.html) 14:30:21 INFO - 2015-12-01 14:30:21,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 257863680 14:30:21 INFO - 2015-12-01 14:30:21,518 DEBUG : BROWSER_OUTPUT: 14:30:21 INFO - 2015-12-01 14:30:21,518 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:30:21 INFO - 2015-12-01 14:30:21,518 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:30:21 INFO - 2015-12-01 14:30:21,518 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:30:21 INFO - 2015-12-01 14:30:21,518 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:30:21 INFO - 2015-12-01 14:30:21,522 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2957.3493831357096;2966.3622321200937;3003.8948636797704;3028.136980960426;3180.3480286541253;4932.309476673264;4990.600751939845;5047.293378926948;5054.848354549369;5062.822801201959;4984.601231901448;5023.497650234975;5032.471590483002;5051;5064.56951159151;4550.68145229834;4578.10726908253;4654.441467023962;4675.462321832999;4684.156851766681;4474.172278128541;4552.044070745131;4554.157480866033;4579.473360563545;4679;4505.031418245077;4514.954850451486;4575.016371480131;4588.77056147193;4615.538446155391;4438.267685831834;4524.389207456984;4534.795934182936;4602.631789456836;4655.092257009867;4600.079984003212;4616.1229366420275;4631.0506346198945;4645.279981602857;4720.362751028636;4917.5574198321965;4942.308076869242;4966.950330496721;4992.47579004203;5039.370078740158;5162.1224391853475;5172.508611681922;5195.688258704452;5313.38896026958;5375.623706340558;5377.677339359651;5390.811321603725;5391.029614669397;5398.433164517708;5437.265969094161;4902;4974.42794078682;4992.675476094042;5006.199008158714;5017.774200161001;5292.761825717852;5414.91877621836;5422.972885135549;5423.647462914898;5448.83653490396;5105.668131571436;5239.528442440199;5243.632945693841;5253.763580638804;5257.894842103136;5154.226865970135;5227.555657769056;5330;5338.679679219259;5347.839564813062;5096.362954630671;5159.74201289934;5194.454582268883;5219.973900130475;5240.659357141773;5262.473752624707;5343.919841202385;5357.383900851374;5364.168553874156;5385.892282154335;3948.269570129535;4081.3265811141423;4112.424260603518;4172.290710579209;4172.937405938914;3792.5259342582176;3796.52543432071;3807.1814559869763;3809.1619843634357;3811.599782022903;4825.203841366206;4946.678465899705;4962.503749625009;4987.202047672355;4988.401391833003;5305.44292849253;5321.308229930084;5421.581585575747;5446.21029950655;5459.972700136474;4874.4150701916;4960.603151747924;4971.055499455092;4978.701277923336;5007.073691367109;4673.836415725434;4717.952820471752;4728.71627702339;4737.076270127361;4777.856664300077;5221.242919776687;5246.868828279247;5257.001169777883;5360.839174824761;5424.186372044067;5342.732863356894;5347.144456886879;5353;5354.571634269327;5362.436944120967;5244.76398562058;5366.463353664602;5434.347878254476;5435.809746658848;5484.369297530835;5276.657017294017;5290.629655924203;5329.307190065267;5358.785648574013;5409.567234621142;5326.786928522971;5333.573314134782;5346.8395948121615;5356.919646205232;5370.409254982027;5028.924566131438;5071.77177027042;5145.948540514547;5205.141151709925;5220.9477905220465;5129.640925135354;5210.739463026909;5233.031889100528;5266.552343050884;5272.815451459181;5174.27560141588;5202.2196670499725;5246.658967167122;5252.42223355423;5369.1140961740875;5062.291279220985;5338.065838478173;5357.892842143213;5374.140137577969;5430.266913966564;5048.671836330626;5098.97450512745;5109.029284435946;5122.74386280677;5220.738963051908 14:30:21 INFO - 2015-12-01 14:30:21,523 DEBUG : BROWSER_OUTPUT: |1;ext.html;516.3519782672747;518.5747686896747;542.8859939412723;543.6710789972068;558.4276116980097;37184.442233366484;38147;38199;38265;38776.030599235;39950.400743988794;40087.99780005494;40383.596164038354;40407.19185616286;40887;8243.258106770405;8442.57787110645;8487.363447741413;8493.405461617689;8509.234168924795;8242.752717418458;8353.665853365857;8353.95823020884;8367;8378.874316885252;8221.630026648816;8238.217369349903;8293.460925039883;8339;8372.204640559137;8214.890989716372;8349.499030058216;8366.45618034832;8372.330213582898;8402.873956890651;8118.2693557580105;8196.016478022615;8302.335813134934;8310.25207731301;8330.333573314181;36730.44904326437;37168.814155929045;37206.25587488262;37324.44013339802;37404.43893341602;2753.2566207124164;2810.4519618674367;3102.10039088664;3251;3284.8850290239725;25338.49323013548;25692;26397.604035939476;26578;26714.065007724636;2162.7512836023902;2227.2538699535676;2258.3337915315024;2270.909163633453;2332.498512819735;239287;240330;241210;243119.78440107862;245018;50312.49687503078;52904.20643690348;57214.71392643094;57804.71097644485;60228.698856505434;58716;59238.11142832861;59368;59415.70292148598;60374;15792.684146317239;15938;15977.281022354022;15988.120653363943;16024.439144629881;11734.413279335999;11891.76216475683;11912.344821034752;11944.64166075019;12019.819702704466;18966.43100706981;19103.904480477508;19147.521311967314;19147.90426047861;19250.22999080021;8174.550399728072;8426.620802063799;8429.114942931026;8448.11294814048;8491.23578877904;855.9657613695507;909.6088681866728;958.8897276813116;988.3723835364451;1007.677543186188;26425.603615945776;26594.867025665135;26759.206091624015;26906.461870762476;26910.5963410549;998.1116806042628;1012.0840639221516;1029.5727273181697;1038.2265212416798;1120.523777394604;13770.449182032606;13948.442062317597;15299.847001530065;15635.530934071769;16152.273147708147;404685;412583;414759;415945;417969;54123.72938135363;54548;54572;55433;55498.44501555013;1349.3388239762446;1350.27085373897;1350.2776014832018;1353.7901625248103;1368.3979049218312;26177;27040.32399189957;27538;27600.171994840188;27851.721482784913;44471;44531;44547.554524455634;44639.330410044524;44679.776601116784;291982;292726;293284.7350342728;295053;298213;29483.41033179367;41559.58440415678;42946.78526607347;43087.56912430836;43095.78452107719;43029.56970430256;43537.78231108824;44150.55849441465;44440.777796110815;45032.324515131644;33459.665403346626;34385.82807085948;34403.4839477403;34517.65482345144;35976.82011589925;33601.83199083989;33635.66364336325;34019.65980340264;34078;34202.14494637554;34048.65951340554;34102;34456.65543344535;34697;35074.473882892285;29181.854090729412;29648.407031859675;29868.964457291466;30138.69861301359;31316.530252046694;22723;22748.77251227533;23033.193838215582;23042.539149217257;23156.6526502106 14:30:21 INFO - 2015-12-01 14:30:21,525 DEBUG : BROWSER_OUTPUT: |2;jquery.html;322.83858070964516;325.50848219189015;329.08678417391735;329.41857621298396;331.70975396528036;9082.500462474562;9219.95390023049;10251.282410231286;16330.183490825455;16537.17314134293;17840.910795446005;18035.63928721425;18048.27806887723;18314.175862086206;18778.718319225223;5510.256115424427;5589.133684278923;5614.9719251403685;5615.522680572136;5622.212890195376;3789.962100379002;3908.589598092202;5561.221428999943;6180.84547886302;6416.518761092913;6205.255369355684;6322.841928951767;6368.235811702602;6384.425401713845;6399.520035997296;6343.492520598341;6352;6387.361263873622;6390.265119511246;6503.991881258389;5990.9101363479585;6047.69761511927;6109.480694140959;6118.847028824271;6169.722362493699;22219.22232721847;22890.198843040413;22945.42636434086;23117.422064448354;23440;1927.6722957097186;1933.5649478867283;2068.2450905419564;2122.4587730128874;2209.845310828243;12484.687882802911;12669.429875655618;12841.1011229214;13107.803382949263;13119.47522099115;1597.480818733916;1630.4293497275978;1649.5051484554585;1666.5417010322137;1708.9658206835793;62220.066699;64572;65613;66161;66629.66685166543;15737.213139342986;16183.676326473405;16292.918535407247;16306.18469076565;16354.754678679828;23416.414589635395;23596.29211123669;24119.75880241175;24393.512129757306;24452.633210501856;9476;9694.272929530314;9733.853992190123;9774.5601447935;9805.313628045968;8205.261526462647;8222.095569487352;8248.958755206186;8249.628766705513;8263.338932885476;7569.810754731066;7629.122650895107;7662.195469475736;7679.2320767923875;7695;969.60730903984;993.7515621094726;1000.6697789729371;1002.7994401119805;1051.7116532248087;333.44647884511596;403.1332634835128;406.5263967477914;424.47789219259863;440.8324836562086;8944.50805205707;9310.115539023918;9327.673531426368;9700.466474343837;10699.14406847466;423.14524660186254;427.78610694652673;434.8586709319421;439.88123206734;440.01656298173555;5258;5795.072788353843;5880.617759845596;6022.126791615191;6119.112728654321;346316;351439;354637;358554;511238;65184.674076629315;70350.2964970354;70613.64693176502;71210.64394677994;71216.64391678009;431.1635427271084;431.268999046613;431.268999046613;431.84885290148827;433.5729306633027;9827.705168844946;10193.592256309961;10421.739456513647;10648.680539583826;10835.891641083488;31987.680123198472;32819.34361312808;32940.67059329472;32969;33083.17292067718;42766;42818.14363712771;43146.784266079725;43150.568494315914;43614.56385436105;5741.971290143522;5855.3559108498885;5981.730822112929;6009.54928380382;6015.759369625166;9371.812563748823;9648.855267170858;10538.525766340686;10871.782564348827;10987.83518247211;9069.410488318239;9083.137101975302;9246.029166937375;9324.207442367204;9475.715728528156;9029.142231487998;9245.58394872219;9389.530523473935;9516.809663806547;9552.761180970532;9600.711978640651;9790.657326993522;9861.802763944825;9867.111959923353;9867.309288349747;5872.5301975842685;5946.464818166386;5952.5833191676165;5958.34458209588;5983.640981541122;9442.527873606155;9624;9695.272854535797;9723.562439690373;9826.606935722491 14:30:21 INFO - 2015-12-01 14:30:21,528 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1462.9466783915577;1571.434283657883;1625.2117722904388;1632.9265183066757;1657.2708008476277;6671;6749.696263668135;6923.273056329089;6925.896111558324;6951.443884489241;6831.282715314895;6891.724331026753;6950.4092152167;6968.989496523001;6989.650517474131;1963.901804909756;2005.1377907499768;2011.9195232190696;2025.48350170707;2041.6222998745206;2022.0900594732357;2038.9082491287927;2042.1423002339054;2053.250563544303;2055.177928828473;1959.559099202675;1976.9308074217406;1979.8119178678003;1988.3438465306415;2003.8597298189134;1980.9702854457194;2006.7892871248528;2007.7490313710787;2009.1862795567672;2009.5980803839218;2021.6361055010093;2029.2187507809451;2051.825594824442;2070.0167420475304;2078.490769761403;6938.098047253875;6950.54821436605;6967.059446974644;6991.545549539263;7017.438604911595;4213.30480470722;4262;4277.272863613193;4290.80691368886;4306.5478124796755;2501.9992003198686;2540.2633236361435;2557.09223225754;2571.56283431817;2574.2534664947143;760.3119177144692;764.5450956680766;768.270143363801;785.9764207073797;788.1173086143556;8745.912540874637;8755.474671519729;8755.518446485441;8760.474371537664;8763.298936085097;3650.1969566695284;3674.4855720198657;3680.6319368063514;3698.556173259226;3698.7965661888857;7201.243869393743;7221.4583906207245;7283.963580182171;7309.780706578811;7363.116426028803;4183.748975061506;4195.328747400401;4209.789510524462;4210.34739615354;4216.24107660624;3479.373712731682;3540.6105328413855;3763.5483741951143;3905.4337121117846;3907.5310962684093;3095.071478556424;3120.1731541141617;3130.98434507826;3131.9217019574694;3216.790908590934;933.5565606336936;937.6530683646957;942.8302905476943;944.0417975754615;946.6639343033262;929.4376901974208;937.4937533731845;943.7451887990204;970.2432102959702;1249.2816630437353;6420.1974753155855;6512.804615861532;6526.902096468557;6533.705983230766;6557.540972131905;428.64850822325394;438.8749206476203;1071.3411252079916;1145.919785614999;1155.774623948322;5051.722155281422;5178.689278643294;5189.040027594907;5194.480551944851;5204.0372531081875;7753.573553454501;7838.921610783933;7995.2804247618;7997.5601341925585;8016.639251233709;7963.522188668582;7969.442139050211;7989.640466178919;7990.960045199853;7991.760247192594;6370.4903607712195;6386;6409.55133140685;6490.8052758417325;6591.868162636721;5958.553108516792;5986.820395388146;5989.251343582052;5992.280926288873;6047.9395206047375;7203.387712044535;7253.9844421782045;7295.088113985752;7391.2239214881665;7456.850862982818;7070.929290707027;7267.7819665410125;7472.29013243741;7525.3227209551405;7568.621568921642;5662.631928924607;5800.274965629296;6137.478314343152;6183.628982261079;6245.843853903689;6225.844353891189;6294.370562943669;6299.433051025429;6302.905456418249;6344.555881088279;6032;6170.876582468415;6174.567780255339;6206.565540412128;6277;6034.607750496204;6048.909266361096;6083.270007599116;6141.170941922784;6164.167837341902;6053.364396738279;6100.267967843887;6129.908051379144;6153.538484613761;6171.59884607499;5414.10667239901;5440.483154100354;5449.291592093003;5474.863128421821;5509.484891654827;5444.020076386289;5517.144842549411;5540.529055030368;5541.085720856175;5544.057510223352 14:30:21 INFO - 2015-12-01 14:30:21,530 DEBUG : BROWSER_OUTPUT: |4;prototype.html;299.4295866374556;301.99999999999994;310.58691939720177;311.4316372619969;311.9532070189473;5607.355154157273;5713.285839270091;5753.482186603205;5772.797952071678;5789.797357092497;5540.445955404458;5573.637713548616;5612.494875461208;5660.688662123582;5669.489745922866;4134.11116609928;4151.377293405998;4174.290370636999;4197.454330936974;4223.049813791888;4142.17156568686;4154.231467178582;4196.055887425336;4218.578142185772;4326.0266440051055;4186.309258972281;4232.957670423302;4242.596953289432;4248.766317852517;4249.46881639795;4183.6653067754505;4242.300020496615;4253.3619957006385;4260.318349064135;4279.058607106416;3600.71194304455;3647.8905632831056;3664.725145614063;3668.3580373434543;3669.541307336583;5275.788968441258;5377.784888604451;5440.265564148829;5513.952349053707;5515.61390702651;4827.324174615556;4842.467328593852;4842.539958703917;4857.61139108874;4860.392450943632;5869.735861886225;5872.324682661506;5873.3245676746865;5907.675077870758;5992.580519363646;3873.748206366577;3993.920121597581;3996.3805610130185;4011.5186177658575;4022.8189731462153;6038.96980515099;6102.176206212193;6108.847278818021;6132.877342453126;6146.907796383058;4025.376066709665;4047.494063242095;4056.7363121397607;4059.8579049733116;4066.1054567994993;4075.1238483726142;4115.609017143366;4124.608162224584;4126.525449573338;4127.752334859858;4690.906181876343;4722.7874745635845;4736.478987311393;4751.192297309466;4819.228923372314;5907.320658124285;5909.409059094056;5938.6436813791315;5939.584229103922;5978.581499295007;1463.239115659851;1469.9265036748334;1473.7199932012884;1494.8430414806505;1499.7450433426343;941.1153515695224;944.8818897637796;959.822432849911;964.4550828781715;981.2052237687353;5602.971985140048;5603.663780173202;5648.491635752802;5648.604597678123;5659.717014149276;6145.262568491809;6149.754009839557;6151.692415379213;6154.476869466145;6159.784407545714;5554.0835762099605;5564.777408903679;5612.017896868032;5624.437556244425;5644.8871022579315;3327.234736010683;3388;3392.6946574807894;3395.7283417326553;3404.42124838778;6067.939320606737;6202.906956395657;6235.875282494325;6249.218847644044;6272.247330320391;6130.080487926757;6247.9062814057825;6327.3988971047675;6327.968360158262;6352.110704501373;6099.207103076572;6189.535784816157;6230.844228894314;6256.6871656417;6280.497560195082;5973.880522389615;6074.605150665193;6109.419605137505;6118.449339559461;6153.38466153399;5957.76168953237;6063.272407311151;6064.332923378337;6073.0283154695035;6151.477124444473;6258.874822503615;6310.6529140895855;6335.524835637253;6344.333844946399;6355.777547785805;3917.941230881596;3947.9407808883466;3962.247173037229;3975.2248311578965;3988.12261302513;6013.488853447506;6106.847328816815;6170.197874276315;6222.719977601109;6229.283632382334;5924.763009479745;5938.2280303560265;5958.374370691015;6014.548908831943;6035.9094613579955;5918.556108291809;5953.970230148995;5956.523478121653;5988.221531200916;6020.729067192075;5637.379888212376;5754.309482862083;5785.479306862402;5788.334341550607;5818.592698511064;6053.697315134314;6068.393160683896;6075.726592303268;6080.48315893154;6128.50971922254;5868.38381969887;5886.735096920735;5895.174675545341;5898.675572843363;5918.704064796657 14:30:21 INFO - 2015-12-01 14:30:21,533 DEBUG : BROWSER_OUTPUT: |5;yui.html;654.7708302094267;684.9760258390954;705.4708968273794;709.9503034787564;714.1073657927591;12670.619881403562;12871.356432178378;13058.869411305895;13094.148880322773;13164.012699047575;12751.171173873692;12937.288449135294;12945.741085178292;12992.350382480885;13047.15193512421;639.6162302618438;647.7344288841576;812.5937031484258;818.0551463060145;819.4468733604793;806.5080301016376;808.3250485844297;821.0434843407423;824.3858325547476;824.5382585751968;840.8150206954491;847.576211894053;850.2050582705159;850.2857599616322;855.2772906893696;834.2825170353491;839.8152406470567;843.9113893041234;844.5777111444278;849.9999999999969;614.7725341623583;614.9016157414837;615.2186722861941;618.7401291457554;621.3258614403378;12485.93757031209;12489.313087780169;12633.620991370273;12809.487620495169;12860.678483037906;8259.297959673435;8594.355423343275;8754.255888249507;8902.777430564287;8975.551222438851;8341.916580834175;8385.119562445978;8422.620982055761;8465.66137354505;8489.490630562124;2682.825616334932;2688.932776680579;2689.663792025997;2689.973100268992;2722.8502432366213;43062.569374306484;43424.78287608573;43563.346549801776;43641.12717745627;44049.339259911125;6201.844953876099;6249.468795152463;6399.6800159992745;6521.967390163114;6585.86828263432;11253.831192532118;11302;11347.716307092389;11359.09127269833;11404;5289.788408463695;5382.273393091961;5401.702906340189;5434.864128396743;5565.0817615093865;3297.1262615406936;3455.740819438552;3489.4068008438626;3491.1097670093964;3504.6144924058335;2295.540891821642;2297.471581536256;2329.6971393719045;2342.0631747300877;2368.4315764216462;368.6000689252138;371.44654464847724;372.7316332240782;381.9427085937076;381.95989421110386;489.58385372433145;493.8320970869921;500.2421331682504;542.8127296082845;547.9999001821611;6568.573042752206;6724.798256052326;7809.297163255221;7813.140554538996;7859.764207073797;441.67316186022754;442.8737809724213;443.8912466445677;515.9742012899341;546.1289243656362;3189.744820414361;3211.4701074322943;3313.122022663996;3357.4124528207467;3369.4945758136478;56716;57052;57319.71340143356;57830.13254801181;57837.4216257832;48638.02723945501;49065.754671226416;49669.25496117561;49909;49966.25050624244;41201.79399102985;42028.78985605053;42043.7897810509;42649.57350426456;45152.548474514835;7089.397401220954;7226.385757210696;7362.226966168475;7650.693972241048;7682.692692292246;33428.164295891824;34011.48982765211;34358;34418.48372274368;34714.479282811284;41185.1762964745;43567.56432435762;44036;44748.32877506775;45730.54269457263;6740.494462915203;6788.083608712761;6922.411595014279;6943.0591737997765;7167.247439018828;10406.063454288847;10483.423411712429;10528.894711052792;10545.156387488829;10936.179786515884;9403.952980235055;9409.811803764023;9830.36102653354;9831.655892043744;10344;9325.487098209664;9699.17557007634;9720.319577629782;10025.398476091457;10025.799484010426;9210.125038121369;9350.579223934803;9401.529923503935;9416.811663766823;9597.47213903242;7976.32201262876;7990.3208227299;8116.513009219466;8228.83542329162;8538.487690738575;8114.959425202836;8122.675092996214;8320.209580089882;8365.079841217339;8527.957360213159 14:30:21 INFO - 2015-12-01 14:30:21,533 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:30:21 INFO - 2015-12-01 14:30:21,533 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:30:21 INFO - 2015-12-01 14:30:21,533 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,270 14:30:21 INFO - 2015-12-01 14:30:21,534 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:30:21 INFO - 2015-12-01 14:30:21,534 DEBUG : BROWSER_OUTPUT: __startTimestamp1449009021517__endTimestamp 14:30:21 INFO - 2015-12-01 14:30:21,534 DEBUG : BROWSER_OUTPUT: 14:30:21 INFO - 2015-12-01 14:30:21,534 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:30:21 INFO - 2015-12-01 14:30:21,535 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:30:21 INFO - 2015-12-01 14:30:21,535 DEBUG : BROWSER_OUTPUT: 14:30:21 INFO - 2015-12-01 14:30:21,535 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4961.50 Median:5109.03 stddev:517.70 (10.1%) stddev-sans-first:494.83 14:30:21 INFO - 2015-12-01 14:30:21,535 DEBUG : BROWSER_OUTPUT: Values: 2957.3 2966.4 3003.9 3028.1 3180.3 4932.3 4990.6 5047.3 5054.8 5062.8 4984.6 5023.5 5032.5 5051.0 5064.6 4550.7 4578.1 4654.4 4675.5 4684.2 4474.2 4552.0 4554.2 4579.5 4679.0 4505.0 4515.0 4575.0 4588.8 4615.5 4438.3 4524.4 4534.8 4602.6 4655.1 4600.1 4616.1 4631.1 4645.3 4720.4 4917.6 4942.3 4967.0 4992.5 5039.4 5162.1 5172.5 5195.7 5313.4 5375.6 5377.7 5390.8 5391.0 5398.4 5437.3 4902.0 4974.4 4992.7 5006.2 5017.8 5292.8 5414.9 5423.0 5423.6 5448.8 5105.7 5239.5 5243.6 5253.8 5257.9 5154.2 5227.6 5330.0 5338.7 5347.8 5096.4 5159.7 5194.5 5220.0 5240.7 5262.5 5343.9 5357.4 5364.2 5385.9 3948.3 4081.3 4112.4 4172.3 4172.9 3792.5 3796.5 3807.2 3809.2 3811.6 4825.2 4946.7 4962.5 4987.2 4988.4 5305.4 5321.3 5421.6 5446.2 5460.0 4874.4 4960.6 4971.1 4978.7 5007.1 4673.8 4718.0 4728.7 4737.1 4777.9 5221.2 5246.9 5257.0 5360.8 5424.2 5342.7 5347.1 5353.0 5354.6 5362.4 5244.8 5366.5 5434.3 5435.8 5484.4 5276.7 5290.6 5329.3 5358.8 5409.6 5326.8 5333.6 5346.8 5356.9 5370.4 5028.9 5071.8 5145.9 5205.1 5220.9 5129.6 5210.7 5233.0 5266.6 5272.8 5174.3 5202.2 5246.7 5252.4 5369.1 5062.3 5338.1 5357.9 5374.1 5430.3 5048.7 5099.0 5109.0 5122.7 5220.7 14:30:21 INFO - 2015-12-01 14:30:21,535 DEBUG : BROWSER_OUTPUT: 14:30:21 INFO - 2015-12-01 14:30:21,535 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47794.74 Median:36353.63 stddev:85509.19 (235.2%) stddev-sans-first:85675.39 14:30:21 INFO - 2015-12-01 14:30:21,535 DEBUG : BROWSER_OUTPUT: Values: 516.4 518.6 542.9 543.7 558.4 37184.4 38147.0 38199.0 38265.0 38776.0 39950.4 40088.0 40383.6 40407.2 40887.0 8243.3 8442.6 8487.4 8493.4 8509.2 8242.8 8353.7 8354.0 8367.0 8378.9 8221.6 8238.2 8293.5 8339.0 8372.2 8214.9 8349.5 8366.5 8372.3 8402.9 8118.3 8196.0 8302.3 8310.3 8330.3 36730.4 37168.8 37206.3 37324.4 37404.4 2753.3 2810.5 3102.1 3251.0 3284.9 25338.5 25692.0 26397.6 26578.0 26714.1 2162.8 2227.3 2258.3 2270.9 2332.5 239287.0 240330.0 241210.0 243119.8 245018.0 50312.5 52904.2 57214.7 57804.7 60228.7 58716.0 59238.1 59368.0 59415.7 60374.0 15792.7 15938.0 15977.3 15988.1 16024.4 11734.4 11891.8 11912.3 11944.6 12019.8 18966.4 19103.9 19147.5 19147.9 19250.2 8174.6 8426.6 8429.1 8448.1 8491.2 856.0 909.6 958.9 988.4 1007.7 26425.6 26594.9 26759.2 26906.5 26910.6 998.1 1012.1 1029.6 1038.2 1120.5 13770.4 13948.4 15299.8 15635.5 16152.3 404685.0 412583.0 414759.0 415945.0 417969.0 54123.7 54548.0 54572.0 55433.0 55498.4 1349.3 1350.3 1350.3 1353.8 1368.4 26177.0 27040.3 27538.0 27600.2 27851.7 44471.0 44531.0 44547.6 44639.3 44679.8 291982.0 292726.0 293284.7 295053.0 298213.0 29483.4 41559.6 42946.8 43087.6 43095.8 43029.6 43537.8 44150.6 44440.8 45032.3 33459.7 34385.8 34403.5 34517.7 35976.8 33601.8 33635.7 34019.7 34078.0 34202.1 34048.7 34102.0 34456.7 34697.0 35074.5 29181.9 29648.4 29869.0 30138.7 31316.5 22723.0 22748.8 23033.2 23042.5 23156.7 14:30:21 INFO - 2015-12-01 14:30:21,536 DEBUG : BROWSER_OUTPUT: 14:30:21 INFO - 2015-12-01 14:30:21,537 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23581.38 Median:5615.25 stddev:64087.75 (1141.3%) stddev-sans-first:64243.74 14:30:21 INFO - 2015-12-01 14:30:21,537 DEBUG : BROWSER_OUTPUT: Values: 322.8 325.5 329.1 329.4 331.7 9082.5 9220.0 10251.3 16330.2 16537.2 17840.9 18035.6 18048.3 18314.2 18778.7 5510.3 5589.1 5615.0 5615.5 5622.2 3790.0 3908.6 5561.2 6180.8 6416.5 6205.3 6322.8 6368.2 6384.4 6399.5 6343.5 6352.0 6387.4 6390.3 6504.0 5990.9 6047.7 6109.5 6118.8 6169.7 22219.2 22890.2 22945.4 23117.4 23440.0 1927.7 1933.6 2068.2 2122.5 2209.8 12484.7 12669.4 12841.1 13107.8 13119.5 1597.5 1630.4 1649.5 1666.5 1709.0 62220.1 64572.0 65613.0 66161.0 66629.7 15737.2 16183.7 16292.9 16306.2 16354.8 23416.4 23596.3 24119.8 24393.5 24452.6 9476.0 9694.3 9733.9 9774.6 9805.3 8205.3 8222.1 8249.0 8249.6 8263.3 7569.8 7629.1 7662.2 7679.2 7695.0 969.6 993.8 1000.7 1002.8 1051.7 333.4 403.1 406.5 424.5 440.8 8944.5 9310.1 9327.7 9700.5 10699.1 423.1 427.8 434.9 439.9 440.0 5258.0 5795.1 5880.6 6022.1 6119.1 346316.0 351439.0 354637.0 358554.0 511238.0 65184.7 70350.3 70613.6 71210.6 71216.6 431.2 431.3 431.3 431.8 433.6 9827.7 10193.6 10421.7 10648.7 10835.9 31987.7 32819.3 32940.7 32969.0 33083.2 42766.0 42818.1 43146.8 43150.6 43614.6 5742.0 5855.4 5981.7 6009.5 6015.8 9371.8 9648.9 10538.5 10871.8 10987.8 9069.4 9083.1 9246.0 9324.2 9475.7 9029.1 9245.6 9389.5 9516.8 9552.8 9600.7 9790.7 9861.8 9867.1 9867.3 5872.5 5946.5 5952.6 5958.3 5983.6 9442.5 9624.0 9695.3 9723.6 9826.6 14:30:21 INFO - 2015-12-01 14:30:21,537 DEBUG : BROWSER_OUTPUT: 14:30:21 INFO - 2015-12-01 14:30:21,537 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4721.27 Median:6051.14 stddev:2400.80 (39.7%) stddev-sans-first:2395.05 14:30:21 INFO - 2015-12-01 14:30:21,539 DEBUG : BROWSER_OUTPUT: Values: 1462.9 1571.4 1625.2 1632.9 1657.3 6671.0 6749.7 6923.3 6925.9 6951.4 6831.3 6891.7 6950.4 6969.0 6989.7 1963.9 2005.1 2011.9 2025.5 2041.6 2022.1 2038.9 2042.1 2053.3 2055.2 1959.6 1976.9 1979.8 1988.3 2003.9 1981.0 2006.8 2007.7 2009.2 2009.6 2021.6 2029.2 2051.8 2070.0 2078.5 6938.1 6950.5 6967.1 6991.5 7017.4 4213.3 4262.0 4277.3 4290.8 4306.5 2502.0 2540.3 2557.1 2571.6 2574.3 760.3 764.5 768.3 786.0 788.1 8745.9 8755.5 8755.5 8760.5 8763.3 3650.2 3674.5 3680.6 3698.6 3698.8 7201.2 7221.5 7284.0 7309.8 7363.1 4183.7 4195.3 4209.8 4210.3 4216.2 3479.4 3540.6 3763.5 3905.4 3907.5 3095.1 3120.2 3131.0 3131.9 3216.8 933.6 937.7 942.8 944.0 946.7 929.4 937.5 943.7 970.2 1249.3 6420.2 6512.8 6526.9 6533.7 6557.5 428.6 438.9 1071.3 1145.9 1155.8 5051.7 5178.7 5189.0 5194.5 5204.0 7753.6 7838.9 7995.3 7997.6 8016.6 7963.5 7969.4 7989.6 7991.0 7991.8 6370.5 6386.0 6409.6 6490.8 6591.9 5958.6 5986.8 5989.3 5992.3 6047.9 7203.4 7254.0 7295.1 7391.2 7456.9 7070.9 7267.8 7472.3 7525.3 7568.6 5662.6 5800.3 6137.5 6183.6 6245.8 6225.8 6294.4 6299.4 6302.9 6344.6 6032.0 6170.9 6174.6 6206.6 6277.0 6034.6 6048.9 6083.3 6141.2 6164.2 6053.4 6100.3 6129.9 6153.5 6171.6 5414.1 5440.5 5449.3 5474.9 5509.5 5444.0 5517.1 5540.5 5541.1 5544.1 14:30:21 INFO - 2015-12-01 14:30:21,539 DEBUG : BROWSER_OUTPUT: 14:30:21 INFO - 2015-12-01 14:30:21,539 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4927.98 Median:5665.09 stddev:1512.32 (26.7%) stddev-sans-first:1476.12 14:30:21 INFO - 2015-12-01 14:30:21,540 DEBUG : BROWSER_OUTPUT: Values: 299.4 302.0 310.6 311.4 312.0 5607.4 5713.3 5753.5 5772.8 5789.8 5540.4 5573.6 5612.5 5660.7 5669.5 4134.1 4151.4 4174.3 4197.5 4223.0 4142.2 4154.2 4196.1 4218.6 4326.0 4186.3 4233.0 4242.6 4248.8 4249.5 4183.7 4242.3 4253.4 4260.3 4279.1 3600.7 3647.9 3664.7 3668.4 3669.5 5275.8 5377.8 5440.3 5514.0 5515.6 4827.3 4842.5 4842.5 4857.6 4860.4 5869.7 5872.3 5873.3 5907.7 5992.6 3873.7 3993.9 3996.4 4011.5 4022.8 6039.0 6102.2 6108.8 6132.9 6146.9 4025.4 4047.5 4056.7 4059.9 4066.1 4075.1 4115.6 4124.6 4126.5 4127.8 4690.9 4722.8 4736.5 4751.2 4819.2 5907.3 5909.4 5938.6 5939.6 5978.6 1463.2 1469.9 1473.7 1494.8 1499.7 941.1 944.9 959.8 964.5 981.2 5603.0 5603.7 5648.5 5648.6 5659.7 6145.3 6149.8 6151.7 6154.5 6159.8 5554.1 5564.8 5612.0 5624.4 5644.9 3327.2 3388.0 3392.7 3395.7 3404.4 6067.9 6202.9 6235.9 6249.2 6272.2 6130.1 6247.9 6327.4 6328.0 6352.1 6099.2 6189.5 6230.8 6256.7 6280.5 5973.9 6074.6 6109.4 6118.4 6153.4 5957.8 6063.3 6064.3 6073.0 6151.5 6258.9 6310.7 6335.5 6344.3 6355.8 3917.9 3947.9 3962.2 3975.2 3988.1 6013.5 6106.8 6170.2 6222.7 6229.3 5924.8 5938.2 5958.4 6014.5 6035.9 5918.6 5954.0 5956.5 5988.2 6020.7 5637.4 5754.3 5785.5 5788.3 5818.6 6053.7 6068.4 6075.7 6080.5 6128.5 5868.4 5886.7 5895.2 5898.7 5918.7 14:30:21 INFO - 2015-12-01 14:30:21,541 DEBUG : BROWSER_OUTPUT: 14:30:21 INFO - 2015-12-01 14:30:21,541 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12365.14 Median:547.06 stddev:15502.42 (2833.7%) stddev-sans-first:15520.97 14:30:21 INFO - 2015-12-01 14:30:21,541 DEBUG : BROWSER_OUTPUT: Values: 654.8 685.0 705.5 710.0 714.1 12670.6 12871.4 13058.9 13094.1 13164.0 12751.2 12937.3 12945.7 12992.4 13047.2 639.6 647.7 812.6 818.1 819.4 806.5 808.3 821.0 824.4 824.5 840.8 847.6 850.2 850.3 855.3 834.3 839.8 843.9 844.6 850.0 614.8 614.9 615.2 618.7 621.3 12485.9 12489.3 12633.6 12809.5 12860.7 8259.3 8594.4 8754.3 8902.8 8975.6 8341.9 8385.1 8422.6 8465.7 8489.5 2682.8 2688.9 2689.7 2690.0 2722.9 43062.6 43424.8 43563.3 43641.1 44049.3 6201.8 6249.5 6399.7 6522.0 6585.9 11253.8 11302.0 11347.7 11359.1 11404.0 5289.8 5382.3 5401.7 5434.9 5565.1 3297.1 3455.7 3489.4 3491.1 3504.6 2295.5 2297.5 2329.7 2342.1 2368.4 368.6 371.4 372.7 381.9 382.0 489.6 493.8 500.2 542.8 548.0 6568.6 6724.8 7809.3 7813.1 7859.8 441.7 442.9 443.9 516.0 546.1 3189.7 3211.5 3313.1 3357.4 3369.5 56716.0 57052.0 57319.7 57830.1 57837.4 48638.0 49065.8 49669.3 49909.0 49966.3 41201.8 42028.8 42043.8 42649.6 45152.5 7089.4 7226.4 7362.2 7650.7 7682.7 33428.2 34011.5 34358.0 34418.5 34714.5 41185.2 43567.6 44036.0 44748.3 45730.5 6740.5 6788.1 6922.4 6943.1 7167.2 10406.1 10483.4 10528.9 10545.2 10936.2 9404.0 9409.8 9830.4 9831.7 10344.0 9325.5 9699.2 9720.3 10025.4 10025.8 9210.1 9350.6 9401.5 9416.8 9597.5 7976.3 7990.3 8116.5 8228.8 8538.5 8115.0 8122.7 8320.2 8365.1 8528.0 14:30:21 INFO - 2015-12-01 14:30:21,541 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:30:21 INFO - 2015-12-01 14:30:21,541 DEBUG : BROWSER_OUTPUT: 14:30:22 INFO - 2015-12-01 14:30:22,150 INFO : Browser exited with error code: 0 14:30:22 INFO - 2015-12-01 14:30:22,181 INFO : Completed test dromaeo_css (00:18:30) 14:30:22 INFO - 2015-12-01 14:30:22,181 INFO : Starting test kraken 14:30:22 INFO - 2015-12-01 14:30:22,181 DEBUG : operating with platform_type : mac_ 14:30:22 INFO - 2015-12-01 14:30:22,182 INFO : Initialising browser for kraken test... 14:30:22 INFO - 2015-12-01 14:30:22,196 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/tmpdWke4j/profile http://localhost:49651/getInfo.html 14:30:25 INFO - 2015-12-01 14:30:25,007 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:30:25 INFO - 2015-12-01 14:30:25,007 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:30:25 INFO - 2015-12-01 14:30:25,007 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:30:25 INFO - 2015-12-01 14:30:25,007 DEBUG : BROWSER_OUTPUT: __metrics 14:30:25 INFO - 2015-12-01 14:30:25,599 INFO : Browser initialized. 14:30:25 INFO - 2015-12-01 14:30:25,599 INFO : Running cycle 1/1 for kraken test... 14:30:25 INFO - 2015-12-01 14:30:25,599 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/tmpdWke4j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:30:37 INFO - 2015-12-01 14:30:37,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 209739776 14:30:37 INFO - 2015-12-01 14:30:37,597 DEBUG : BROWSER_OUTPUT: 14:30:40 INFO - 2015-12-01 14:30:40,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49651/tests/kraken/driver.html?testName=audio-beat-detection) 14:30:40 INFO - 2015-12-01 14:30:40,831 DEBUG : BROWSER_OUTPUT: RSS: Main: 229646336 14:30:40 INFO - 2015-12-01 14:30:40,832 DEBUG : BROWSER_OUTPUT: 14:30:43 INFO - 2015-12-01 14:30:43,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49651/tests/kraken/driver.html?testName=audio-dft) 14:30:44 INFO - 2015-12-01 14:30:44,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 236937216 14:30:44 INFO - 2015-12-01 14:30:44,321 DEBUG : BROWSER_OUTPUT: 14:30:47 INFO - 2015-12-01 14:30:47,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49651/tests/kraken/driver.html?testName=audio-fft) 14:30:48 INFO - 2015-12-01 14:30:48,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 237547520 14:30:48 INFO - 2015-12-01 14:30:48,048 DEBUG : BROWSER_OUTPUT: 14:30:50 INFO - 2015-12-01 14:30:50,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49651/tests/kraken/driver.html?testName=audio-oscillator) 14:30:50 INFO - 2015-12-01 14:30:50,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 237543424 14:30:50 INFO - 2015-12-01 14:30:50,783 DEBUG : BROWSER_OUTPUT: 14:30:53 INFO - 2015-12-01 14:30:53,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49651/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:30:53 INFO - 2015-12-01 14:30:53,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 238350336 14:30:53 INFO - 2015-12-01 14:30:53,633 DEBUG : BROWSER_OUTPUT: 14:30:56 INFO - 2015-12-01 14:30:56,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49651/tests/kraken/driver.html?testName=imaging-darkroom) 14:30:57 INFO - 2015-12-01 14:30:57,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 237375488 14:30:57 INFO - 2015-12-01 14:30:57,517 DEBUG : BROWSER_OUTPUT: 14:31:00 INFO - 2015-12-01 14:31:00,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49651/tests/kraken/driver.html?testName=imaging-desaturate) 14:31:01 INFO - 2015-12-01 14:31:01,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 237649920 14:31:01 INFO - 2015-12-01 14:31:01,479 DEBUG : BROWSER_OUTPUT: 14:31:04 INFO - 2015-12-01 14:31:04,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49651/tests/kraken/driver.html?testName=json-parse-financial) 14:31:05 INFO - 2015-12-01 14:31:05,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 243032064 14:31:05 INFO - 2015-12-01 14:31:05,210 DEBUG : BROWSER_OUTPUT: 14:31:06 INFO - 2015-12-01 14:31:06,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49651/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:31:07 INFO - 2015-12-01 14:31:07,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 241438720 14:31:07 INFO - 2015-12-01 14:31:07,475 DEBUG : BROWSER_OUTPUT: 14:31:09 INFO - 2015-12-01 14:31:09,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49651/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:31:10 INFO - 2015-12-01 14:31:10,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 241844224 14:31:10 INFO - 2015-12-01 14:31:10,006 DEBUG : BROWSER_OUTPUT: 14:31:12 INFO - 2015-12-01 14:31:12,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49651/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:31:12 INFO - 2015-12-01 14:31:12,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 241930240 14:31:12 INFO - 2015-12-01 14:31:12,812 DEBUG : BROWSER_OUTPUT: 14:31:15 INFO - 2015-12-01 14:31:15,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:16 INFO - 2015-12-01 14:31:16,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 241717248 14:31:16 INFO - 2015-12-01 14:31:16,167 DEBUG : BROWSER_OUTPUT: 14:31:18 INFO - 2015-12-01 14:31:18,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:19 INFO - 2015-12-01 14:31:19,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 242143232 14:31:19 INFO - 2015-12-01 14:31:19,506 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49651/tests/kraken/driver.html?testName=ai-astar) 14:31:21 INFO - 2015-12-01 14:31:21,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 241647616 14:31:21 INFO - 2015-12-01 14:31:21,532 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,533 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:31:21 INFO - 2015-12-01 14:31:21,533 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:31:21 INFO - 2015-12-01 14:31:21,534 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:31:21 INFO - 2015-12-01 14:31:21,534 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:31:21 INFO - 2015-12-01 14:31:21,534 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;115;110;113;118;133;115;111;115;122 14:31:21 INFO - 2015-12-01 14:31:21,534 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;163;144;186;177;148;169;147;180;176;154 14:31:21 INFO - 2015-12-01 14:31:21,534 DEBUG : BROWSER_OUTPUT: |2;audio-dft;179;184;186;191;189;198;203;191;186;185 14:31:21 INFO - 2015-12-01 14:31:21,534 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;84;89;131;79;76;81;82;134;77 14:31:21 INFO - 2015-12-01 14:31:21,534 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;97;141;97;104;104;145;103;100;144 14:31:21 INFO - 2015-12-01 14:31:21,535 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;130;131;137;136;142;137;137;142;140;137 14:31:21 INFO - 2015-12-01 14:31:21,535 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;142;148;148;147;142;143;148;148;144;142 14:31:21 INFO - 2015-12-01 14:31:21,535 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;120;130;122;122;123;124;120;120;123;122 14:31:21 INFO - 2015-12-01 14:31:21,535 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;67;67;70;71;75;76;77;84;71;74 14:31:21 INFO - 2015-12-01 14:31:21,535 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;76;68;73;76;74;76;75;79;79 14:31:21 INFO - 2015-12-01 14:31:21,535 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;95;95;97;98;98;100;97;95;99 14:31:21 INFO - 2015-12-01 14:31:21,535 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;138;150;143;149;142;147;151;155;141;142 14:31:21 INFO - 2015-12-01 14:31:21,535 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;162;168;165;171;174;159;166;171;165;169 14:31:21 INFO - 2015-12-01 14:31:21,536 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;74;70;76;76;77;77;78;83;79;81 14:31:21 INFO - 2015-12-01 14:31:21,536 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:31:21 INFO - 2015-12-01 14:31:21,536 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:31:21 INFO - 2015-12-01 14:31:21,536 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,692 14:31:21 INFO - 2015-12-01 14:31:21,536 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:31:21 INFO - 2015-12-01 14:31:21,536 DEBUG : BROWSER_OUTPUT: __startTimestamp1449009081532__endTimestamp 14:31:21 INFO - 2015-12-01 14:31:21,536 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,538 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:31:21 INFO - 2015-12-01 14:31:21,538 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:31:21 INFO - 2015-12-01 14:31:21,538 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,538 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:116.60 Median:115.00 stddev:6.69 (5.8%) stddev-sans-first:7.03 14:31:21 INFO - 2015-12-01 14:31:21,538 DEBUG : BROWSER_OUTPUT: Values: 114.0 115.0 110.0 113.0 118.0 133.0 115.0 111.0 115.0 122.0 14:31:21 INFO - 2015-12-01 14:31:21,539 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,539 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:164.40 Median:172.50 stddev:15.36 (8.9%) stddev-sans-first:16.28 14:31:21 INFO - 2015-12-01 14:31:21,539 DEBUG : BROWSER_OUTPUT: Values: 163.0 144.0 186.0 177.0 148.0 169.0 147.0 180.0 176.0 154.0 14:31:21 INFO - 2015-12-01 14:31:21,539 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,539 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:189.20 Median:190.00 stddev:7.02 (3.7%) stddev-sans-first:6.40 14:31:21 INFO - 2015-12-01 14:31:21,540 DEBUG : BROWSER_OUTPUT: Values: 179.0 184.0 186.0 191.0 189.0 198.0 203.0 191.0 186.0 185.0 14:31:21 INFO - 2015-12-01 14:31:21,540 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,540 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.70 Median:80.00 stddev:22.45 (28.1%) stddev-sans-first:22.98 14:31:21 INFO - 2015-12-01 14:31:21,540 DEBUG : BROWSER_OUTPUT: Values: 74.0 84.0 89.0 131.0 79.0 76.0 81.0 82.0 134.0 77.0 14:31:21 INFO - 2015-12-01 14:31:21,540 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,541 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:113.00 Median:144.50 stddev:21.18 (14.7%) stddev-sans-first:21.44 14:31:21 INFO - 2015-12-01 14:31:21,542 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 141.0 97.0 104.0 104.0 145.0 103.0 100.0 144.0 14:31:21 INFO - 2015-12-01 14:31:21,542 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,542 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:136.90 Median:137.00 stddev:4.01 (2.9%) stddev-sans-first:3.39 14:31:21 INFO - 2015-12-01 14:31:21,542 DEBUG : BROWSER_OUTPUT: Values: 130.0 131.0 137.0 136.0 142.0 137.0 137.0 142.0 140.0 137.0 14:31:21 INFO - 2015-12-01 14:31:21,542 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,542 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.20 Median:147.50 stddev:2.82 (1.9%) stddev-sans-first:2.74 14:31:21 INFO - 2015-12-01 14:31:21,543 DEBUG : BROWSER_OUTPUT: Values: 142.0 148.0 148.0 147.0 142.0 143.0 148.0 148.0 144.0 142.0 14:31:21 INFO - 2015-12-01 14:31:21,543 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,543 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:122.60 Median:122.50 stddev:2.95 (2.4%) stddev-sans-first:2.98 14:31:21 INFO - 2015-12-01 14:31:21,543 DEBUG : BROWSER_OUTPUT: Values: 120.0 130.0 122.0 122.0 123.0 124.0 120.0 120.0 123.0 122.0 14:31:21 INFO - 2015-12-01 14:31:21,543 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,543 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.20 Median:74.50 stddev:5.16 (6.9%) stddev-sans-first:4.96 14:31:21 INFO - 2015-12-01 14:31:21,544 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 70.0 71.0 75.0 76.0 77.0 84.0 71.0 74.0 14:31:21 INFO - 2015-12-01 14:31:21,544 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,544 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:74.40 Median:76.00 stddev:3.86 (5.1%) stddev-sans-first:3.33 14:31:21 INFO - 2015-12-01 14:31:21,544 DEBUG : BROWSER_OUTPUT: Values: 68.0 76.0 68.0 73.0 76.0 74.0 76.0 75.0 79.0 79.0 14:31:21 INFO - 2015-12-01 14:31:21,544 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,544 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:96.50 Median:97.00 stddev:2.59 (2.7%) stddev-sans-first:1.83 14:31:21 INFO - 2015-12-01 14:31:21,544 DEBUG : BROWSER_OUTPUT: Values: 91.0 95.0 95.0 97.0 98.0 98.0 100.0 97.0 95.0 99.0 14:31:21 INFO - 2015-12-01 14:31:21,544 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,545 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:148.00 stddev:5.39 (3.6%) stddev-sans-first:4.92 14:31:21 INFO - 2015-12-01 14:31:21,545 DEBUG : BROWSER_OUTPUT: Values: 138.0 150.0 143.0 149.0 142.0 147.0 151.0 155.0 141.0 142.0 14:31:21 INFO - 2015-12-01 14:31:21,545 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,545 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:168.50 stddev:4.52 (2.7%) stddev-sans-first:4.42 14:31:21 INFO - 2015-12-01 14:31:21,545 DEBUG : BROWSER_OUTPUT: Values: 162.0 168.0 165.0 171.0 174.0 159.0 166.0 171.0 165.0 169.0 14:31:21 INFO - 2015-12-01 14:31:21,545 DEBUG : BROWSER_OUTPUT: 14:31:21 INFO - 2015-12-01 14:31:21,545 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.10 Median:77.50 stddev:3.60 (4.7%) stddev-sans-first:3.64 14:31:21 INFO - 2015-12-01 14:31:21,545 DEBUG : BROWSER_OUTPUT: Values: 74.0 70.0 76.0 76.0 77.0 77.0 78.0 83.0 79.0 81.0 14:31:21 INFO - 2015-12-01 14:31:21,546 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:31:21 INFO - 2015-12-01 14:31:21,546 DEBUG : BROWSER_OUTPUT: 14:31:22 INFO - 2015-12-01 14:31:22,150 INFO : Browser exited with error code: 0 14:31:22 INFO - 2015-12-01 14:31:22,203 INFO : Completed test kraken (00:01:00) 14:31:22 INFO - 2015-12-01 14:31:22,204 INFO : Starting test v8_7 14:31:22 INFO - 2015-12-01 14:31:22,204 DEBUG : operating with platform_type : mac_ 14:31:22 INFO - 2015-12-01 14:31:22,204 INFO : Initialising browser for v8_7 test... 14:31:22 INFO - 2015-12-01 14:31:22,219 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/tmpEapFCs/profile http://localhost:49651/getInfo.html 14:31:24 INFO - 2015-12-01 14:31:24,934 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:31:24 INFO - 2015-12-01 14:31:24,934 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:31:24 INFO - 2015-12-01 14:31:24,935 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:31:24 INFO - 2015-12-01 14:31:24,935 DEBUG : BROWSER_OUTPUT: __metrics 14:31:25 INFO - 2015-12-01 14:31:25,568 INFO : Browser initialized. 14:31:25 INFO - 2015-12-01 14:31:25,568 INFO : Running cycle 1/1 for v8_7 test... 14:31:25 INFO - 2015-12-01 14:31:25,568 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/T/tmpEapFCs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:31:37 INFO - 2015-12-01 14:31:37,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 209895424 14:31:37 INFO - 2015-12-01 14:31:37,505 DEBUG : BROWSER_OUTPUT: 14:31:59 INFO - 2015-12-01 14:31:59,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49651/tests/v8_7/run.html (next: http://localhost:49651/tests/v8_7/run.html) 14:31:59 INFO - 2015-12-01 14:31:59,368 DEBUG : BROWSER_OUTPUT: RSS: Main: 230846464 14:31:59 INFO - 2015-12-01 14:31:59,368 DEBUG : BROWSER_OUTPUT: 14:31:59 INFO - 2015-12-01 14:31:59,368 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:31:59 INFO - 2015-12-01 14:31:59,368 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:31:59 INFO - 2015-12-01 14:31:59,369 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:31:59 INFO - 2015-12-01 14:31:59,369 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:31:59 INFO - 2015-12-01 14:31:59,369 DEBUG : BROWSER_OUTPUT: |0;Richards;177.43080198722498 14:31:59 INFO - 2015-12-01 14:31:59,369 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;204.58265139116202 14:31:59 INFO - 2015-12-01 14:31:59,369 DEBUG : BROWSER_OUTPUT: |2;Encrypt;359.45363048166786 14:31:59 INFO - 2015-12-01 14:31:59,369 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6223.60248447205 14:31:59 INFO - 2015-12-01 14:31:59,369 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1091.6030534351146 14:31:59 INFO - 2015-12-01 14:31:59,369 DEBUG : BROWSER_OUTPUT: |5;Earley;745.156482861401 14:31:59 INFO - 2015-12-01 14:31:59,369 DEBUG : BROWSER_OUTPUT: |6;Boyer;13808.219178082192 14:31:59 INFO - 2015-12-01 14:31:59,369 DEBUG : BROWSER_OUTPUT: |7;RegExp;31562.5 14:31:59 INFO - 2015-12-01 14:31:59,369 DEBUG : BROWSER_OUTPUT: |8;Splay;664.8936170212766 14:31:59 INFO - 2015-12-01 14:31:59,369 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6320.754716981132 14:31:59 INFO - 2015-12-01 14:31:59,369 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:31:59 INFO - 2015-12-01 14:31:59,369 DEBUG : BROWSER_OUTPUT: __startTimestamp1449009119360__endTimestamp 14:31:59 INFO - 2015-12-01 14:31:59,370 DEBUG : BROWSER_OUTPUT: 14:31:59 INFO - 2015-12-01 14:31:59,370 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:31:59 INFO - 2015-12-01 14:31:59,370 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:31:59 INFO - 2015-12-01 14:31:59,370 DEBUG : BROWSER_OUTPUT: 14:31:59 INFO - 2015-12-01 14:31:59,370 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:177.43 Median:177.43 stddev:0.00 (0.0%) 14:31:59 INFO - 2015-12-01 14:31:59,370 DEBUG : BROWSER_OUTPUT: Values: 177.4 14:31:59 INFO - 2015-12-01 14:31:59,370 DEBUG : BROWSER_OUTPUT: 14:31:59 INFO - 2015-12-01 14:31:59,370 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:204.58 Median:204.58 stddev:0.00 (0.0%) 14:31:59 INFO - 2015-12-01 14:31:59,370 DEBUG : BROWSER_OUTPUT: Values: 204.6 14:31:59 INFO - 2015-12-01 14:31:59,370 DEBUG : BROWSER_OUTPUT: 14:31:59 INFO - 2015-12-01 14:31:59,370 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:359.45 Median:359.45 stddev:0.00 (0.0%) 14:31:59 INFO - 2015-12-01 14:31:59,370 DEBUG : BROWSER_OUTPUT: Values: 359.5 14:31:59 INFO - 2015-12-01 14:31:59,370 DEBUG : BROWSER_OUTPUT: 14:31:59 INFO - 2015-12-01 14:31:59,370 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6223.60 Median:6223.60 stddev:0.00 (0.0%) 14:31:59 INFO - 2015-12-01 14:31:59,370 DEBUG : BROWSER_OUTPUT: Values: 6223.6 14:31:59 INFO - 2015-12-01 14:31:59,371 DEBUG : BROWSER_OUTPUT: 14:31:59 INFO - 2015-12-01 14:31:59,371 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1091.60 Median:1091.60 stddev:0.00 (0.0%) 14:31:59 INFO - 2015-12-01 14:31:59,371 DEBUG : BROWSER_OUTPUT: Values: 1091.6 14:31:59 INFO - 2015-12-01 14:31:59,371 DEBUG : BROWSER_OUTPUT: 14:31:59 INFO - 2015-12-01 14:31:59,371 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:745.16 Median:745.16 stddev:0.00 (0.0%) 14:31:59 INFO - 2015-12-01 14:31:59,371 DEBUG : BROWSER_OUTPUT: Values: 745.2 14:31:59 INFO - 2015-12-01 14:31:59,371 DEBUG : BROWSER_OUTPUT: 14:31:59 INFO - 2015-12-01 14:31:59,371 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13808.22 Median:13808.22 stddev:0.00 (0.0%) 14:31:59 INFO - 2015-12-01 14:31:59,371 DEBUG : BROWSER_OUTPUT: Values: 13808.2 14:31:59 INFO - 2015-12-01 14:31:59,371 DEBUG : BROWSER_OUTPUT: 14:31:59 INFO - 2015-12-01 14:31:59,371 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31562.50 Median:31562.50 stddev:0.00 (0.0%) 14:31:59 INFO - 2015-12-01 14:31:59,371 DEBUG : BROWSER_OUTPUT: Values: 31562.5 14:31:59 INFO - 2015-12-01 14:31:59,371 DEBUG : BROWSER_OUTPUT: 14:31:59 INFO - 2015-12-01 14:31:59,371 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:664.89 Median:664.89 stddev:0.00 (0.0%) 14:31:59 INFO - 2015-12-01 14:31:59,372 DEBUG : BROWSER_OUTPUT: Values: 664.9 14:31:59 INFO - 2015-12-01 14:31:59,372 DEBUG : BROWSER_OUTPUT: 14:31:59 INFO - 2015-12-01 14:31:59,372 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6320.75 Median:6320.75 stddev:0.00 (0.0%) 14:31:59 INFO - 2015-12-01 14:31:59,372 DEBUG : BROWSER_OUTPUT: Values: 6320.8 14:31:59 INFO - 2015-12-01 14:31:59,372 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:31:59 INFO - 2015-12-01 14:31:59,372 DEBUG : BROWSER_OUTPUT: 14:31:59 INFO - 2015-12-01 14:31:59,995 INFO : Browser exited with error code: 0 14:32:00 INFO - 2015-12-01 14:32:00,017 INFO : Completed test v8_7 (00:00:37) 14:32:00 INFO - 2015-12-01 14:32:00,502 INFO : Completed test suite (00:20:09) 14:32:00 INFO - 2015-12-01 14:32:00,502 DEBUG : Working with test: dromaeo_css 14:32:00 INFO - 2015-12-01 14:32:00,502 DEBUG : Generating results file: dromaeo_css 14:32:00 INFO - 2015-12-01 14:32:00,503 DEBUG : Working with test: kraken 14:32:00 INFO - 2015-12-01 14:32:00,503 DEBUG : Generating results file: kraken 14:32:00 INFO - 2015-12-01 14:32:00,503 INFO : javascript benchmark 14:32:00 INFO - 2015-12-01 14:32:00,503 DEBUG : Working with test: v8_7 14:32:00 INFO - 2015-12-01 14:32:00,503 DEBUG : Generating results file: v8_7 14:32:00 INFO - 2015-12-01 14:32:00,503 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:32:00 INFO - 2015-12-01 14:32:00,565 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,57]] 14:32:00 INFO - 2015-12-01 14:32:00,565 DEBUG : process_Request line: dromaeo_css 6271.94 graph.html#tests=[[72,52,57]] 14:32:00 INFO - 2015-12-01 14:32:00,565 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:32:00 INFO - 2015-12-01 14:32:00,596 DEBUG : process_Request line: kraken 1712.60 graph.html#tests=[[232,52,57]] 14:32:00 INFO - 2015-12-01 14:32:00,596 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:32:00 INFO - 2015-12-01 14:32:00,629 DEBUG : process_Request line: v8_7 18688.50 graph.html#tests=[[230,52,57]] 14:32:00 INFO - 2015-12-01 14:32:00,629 INFO : javascript benchmark 14:32:00 INFO - 2015-12-01 14:32:00,631 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [322.83858070964516, 325.50848219189015, 329.08678417391735, 329.41857621298396, 331.70975396528036, 9082.500462474562, 9219.95390023049, 10251.282410231286, 16330.183490825455, 16537.17314134293, 17840.910795446005, 18035.63928721425, 18048.27806887723, 18314.175862086206, 18778.718319225223, 5510.256115424427, 5589.133684278923, 5614.9719251403685, 5615.522680572136, 5622.212890195376, 3789.962100379002, 3908.589598092202, 5561.221428999943, 6180.84547886302, 6416.518761092913, 6205.255369355684, 6322.841928951767, 6368.235811702602, 6384.425401713845, 6399.520035997296, 6343.492520598341, 6352.0, 6387.361263873622, 6390.265119511246, 6503.991881258389, 5990.9101363479585, 6047.69761511927, 6109.480694140959, 6118.847028824271, 6169.722362493699, 22219.22232721847, 22890.198843040413, 22945.42636434086, 23117.422064448354, 23440.0, 1927.6722957097186, 1933.5649478867283, 2068.2450905419564, 2122.4587730128874, 2209.845310828243, 12484.687882802911, 12669.429875655618, 12841.1011229214, 13107.803382949263, 13119.47522099115, 1597.480818733916, 1630.4293497275978, 1649.5051484554585, 1666.5417010322137, 1708.9658206835793, 62220.066699, 64572.0, 65613.0, 66161.0, 66629.66685166543, 15737.213139342986, 16183.676326473405, 16292.918535407247, 16306.18469076565, 16354.754678679828, 23416.414589635395, 23596.29211123669, 24119.75880241175, 24393.512129757306, 24452.633210501856, 9476.0, 9694.272929530314, 9733.853992190123, 9774.5601447935, 9805.313628045968, 8205.261526462647, 8222.095569487352, 8248.958755206186, 8249.628766705513, 8263.338932885476, 7569.810754731066, 7629.122650895107, 7662.195469475736, 7679.2320767923875, 7695.0, 969.60730903984, 993.7515621094726, 1000.6697789729371, 1002.7994401119805, 1051.7116532248087, 333.44647884511596, 403.1332634835128, 406.5263967477914, 424.47789219259863, 440.8324836562086, 8944.50805205707, 9310.115539023918, 9327.673531426368, 9700.466474343837, 10699.14406847466, 423.14524660186254, 427.78610694652673, 434.8586709319421, 439.88123206734, 440.01656298173555, 5258.0, 5795.072788353843, 5880.617759845596, 6022.126791615191, 6119.112728654321, 346316.0, 351439.0, 354637.0, 358554.0, 511238.0, 65184.674076629315, 70350.2964970354, 70613.64693176502, 71210.64394677994, 71216.64391678009, 431.1635427271084, 431.268999046613, 431.268999046613, 431.84885290148827, 433.5729306633027, 9827.705168844946, 10193.592256309961, 10421.739456513647, 10648.680539583826, 10835.891641083488, 31987.680123198472, 32819.34361312808, 32940.67059329472, 32969.0, 33083.17292067718, 42766.0, 42818.14363712771, 43146.784266079725, 43150.568494315914, 43614.56385436105, 5741.971290143522, 5855.3559108498885, 5981.730822112929, 6009.54928380382, 6015.759369625166, 9371.812563748823, 9648.855267170858, 10538.525766340686, 10871.782564348827, 10987.83518247211, 9069.410488318239, 9083.137101975302, 9246.029166937375, 9324.207442367204, 9475.715728528156, 9029.142231487998, 9245.58394872219, 9389.530523473935, 9516.809663806547, 9552.761180970532, 9600.711978640651, 9790.657326993522, 9861.802763944825, 9867.111959923353, 9867.309288349747, 5872.5301975842685, 5946.464818166386, 5952.5833191676165, 5958.34458209588, 5983.640981541122, 9442.527873606155, 9624.0, 9695.272854535797, 9723.562439690373, 9826.606935722491], "dojo.html": [2957.3493831357096, 2966.3622321200937, 3003.8948636797704, 3028.136980960426, 3180.3480286541253, 4932.309476673264, 4990.600751939845, 5047.293378926948, 5054.848354549369, 5062.822801201959, 4984.601231901448, 5023.497650234975, 5032.471590483002, 5051.0, 5064.56951159151, 4550.68145229834, 4578.10726908253, 4654.441467023962, 4675.462321832999, 4684.156851766681, 4474.172278128541, 4552.044070745131, 4554.157480866033, 4579.473360563545, 4679.0, 4505.031418245077, 4514.954850451486, 4575.016371480131, 4588.77056147193, 4615.538446155391, 4438.267685831834, 4524.389207456984, 4534.795934182936, 4602.631789456836, 4655.092257009867, 4600.079984003212, 4616.1229366420275, 4631.0506346198945, 4645.279981602857, 4720.362751028636, 4917.5574198321965, 4942.308076869242, 4966.950330496721, 4992.47579004203, 5039.370078740158, 5162.1224391853475, 5172.508611681922, 5195.688258704452, 5313.38896026958, 5375.623706340558, 5377.677339359651, 5390.811321603725, 5391.029614669397, 5398.433164517708, 5437.265969094161, 4902.0, 4974.42794078682, 4992.675476094042, 5006.199008158714, 5017.774200161001, 5292.761825717852, 5414.91877621836, 5422.972885135549, 5423.647462914898, 5448.83653490396, 5105.668131571436, 5239.528442440199, 5243.632945693841, 5253.763580638804, 5257.894842103136, 5154.226865970135, 5227.555657769056, 5330.0, 5338.679679219259, 5347.839564813062, 5096.362954630671, 5159.74201289934, 5194.454582268883, 5219.973900130475, 5240.659357141773, 5262.473752624707, 5343.919841202385, 5357.383900851374, 5364.168553874156, 5385.892282154335, 3948.269570129535, 4081.3265811141423, 4112.424260603518, 4172.290710579209, 4172.937405938914, 3792.5259342582176, 3796.52543432071, 3807.1814559869763, 3809.1619843634357, 3811.599782022903, 4825.203841366206, 4946.678465899705, 4962.503749625009, 4987.202047672355, 4988.401391833003, 5305.44292849253, 5321.308229930084, 5421.581585575747, 5446.21029950655, 5459.972700136474, 4874.4150701916, 4960.603151747924, 4971.055499455092, 4978.701277923336, 5007.073691367109, 4673.836415725434, 4717.952820471752, 4728.71627702339, 4737.076270127361, 4777.856664300077, 5221.242919776687, 5246.868828279247, 5257.001169777883, 5360.839174824761, 5424.186372044067, 5342.732863356894, 5347.144456886879, 5353.0, 5354.571634269327, 5362.436944120967, 5244.76398562058, 5366.463353664602, 5434.347878254476, 5435.809746658848, 5484.369297530835, 5276.657017294017, 5290.629655924203, 5329.307190065267, 5358.785648574013, 5409.567234621142, 5326.786928522971, 5333.573314134782, 5346.8395948121615, 5356.919646205232, 5370.409254982027, 5028.924566131438, 5071.77177027042, 5145.948540514547, 5205.141151709925, 5220.9477905220465, 5129.640925135354, 5210.739463026909, 5233.031889100528, 5266.552343050884, 5272.815451459181, 5174.27560141588, 5202.2196670499725, 5246.658967167122, 5252.42223355423, 5369.1140961740875, 5062.291279220985, 5338.065838478173, 5357.892842143213, 5374.140137577969, 5430.266913966564, 5048.671836330626, 5098.97450512745, 5109.029284435946, 5122.74386280677, 5220.738963051908], "mootools.html": [1462.9466783915577, 1571.434283657883, 1625.2117722904388, 1632.9265183066757, 1657.2708008476277, 6671.0, 6749.696263668135, 6923.273056329089, 6925.896111558324, 6951.443884489241, 6831.282715314895, 6891.724331026753, 6950.4092152167, 6968.989496523001, 6989.650517474131, 1963.901804909756, 2005.1377907499768, 2011.9195232190696, 2025.48350170707, 2041.6222998745206, 2022.0900594732357, 2038.9082491287927, 2042.1423002339054, 2053.250563544303, 2055.177928828473, 1959.559099202675, 1976.9308074217406, 1979.8119178678003, 1988.3438465306415, 2003.8597298189134, 1980.9702854457194, 2006.7892871248528, 2007.7490313710787, 2009.1862795567672, 2009.5980803839218, 2021.6361055010093, 2029.2187507809451, 2051.825594824442, 2070.0167420475304, 2078.490769761403, 6938.098047253875, 6950.54821436605, 6967.059446974644, 6991.545549539263, 7017.438604911595, 4213.30480470722, 4262.0, 4277.272863613193, 4290.80691368886, 4306.5478124796755, 2501.9992003198686, 2540.2633236361435, 2557.09223225754, 2571.56283431817, 2574.2534664947143, 760.3119177144692, 764.5450956680766, 768.270143363801, 785.9764207073797, 788.1173086143556, 8745.912540874637, 8755.474671519729, 8755.518446485441, 8760.474371537664, 8763.298936085097, 3650.1969566695284, 3674.4855720198657, 3680.6319368063514, 3698.556173259226, 3698.7965661888857, 7201.243869393743, 7221.4583906207245, 7283.963580182171, 7309.780706578811, 7363.116426028803, 4183.748975061506, 4195.328747400401, 4209.789510524462, 4210.34739615354, 4216.24107660624, 3479.373712731682, 3540.6105328413855, 3763.5483741951143, 3905.4337121117846, 3907.5310962684093, 3095.071478556424, 3120.1731541141617, 3130.98434507826, 3131.9217019574694, 3216.790908590934, 933.5565606336936, 937.6530683646957, 942.8302905476943, 944.0417975754615, 946.6639343033262, 929.4376901974208, 937.4937533731845, 943.7451887990204, 970.2432102959702, 1249.2816630437353, 6420.1974753155855, 6512.804615861532, 6526.902096468557, 6533.705983230766, 6557.540972131905, 428.64850822325394, 438.8749206476203, 1071.3411252079916, 1145.919785614999, 1155.774623948322, 5051.722155281422, 5178.689278643294, 5189.040027594907, 5194.480551944851, 5204.0372531081875, 7753.573553454501, 7838.921610783933, 7995.2804247618, 7997.5601341925585, 8016.639251233709, 7963.522188668582, 7969.442139050211, 7989.640466178919, 7990.960045199853, 7991.760247192594, 6370.4903607712195, 6386.0, 6409.55133140685, 6490.8052758417325, 6591.868162636721, 5958.553108516792, 5986.820395388146, 5989.251343582052, 5992.280926288873, 6047.9395206047375, 7203.387712044535, 7253.9844421782045, 7295.088113985752, 7391.2239214881665, 7456.850862982818, 7070.929290707027, 7267.7819665410125, 7472.29013243741, 7525.3227209551405, 7568.621568921642, 5662.631928924607, 5800.274965629296, 6137.478314343152, 6183.628982261079, 6245.843853903689, 6225.844353891189, 6294.370562943669, 6299.433051025429, 6302.905456418249, 6344.555881088279, 6032.0, 6170.876582468415, 6174.567780255339, 6206.565540412128, 6277.0, 6034.607750496204, 6048.909266361096, 6083.270007599116, 6141.170941922784, 6164.167837341902, 6053.364396738279, 6100.267967843887, 6129.908051379144, 6153.538484613761, 6171.59884607499, 5414.10667239901, 5440.483154100354, 5449.291592093003, 5474.863128421821, 5509.484891654827, 5444.020076386289, 5517.144842549411, 5540.529055030368, 5541.085720856175, 5544.057510223352], "ext.html": [516.3519782672747, 518.5747686896747, 542.8859939412723, 543.6710789972068, 558.4276116980097, 37184.442233366484, 38147.0, 38199.0, 38265.0, 38776.030599235, 39950.400743988794, 40087.99780005494, 40383.596164038354, 40407.19185616286, 40887.0, 8243.258106770405, 8442.57787110645, 8487.363447741413, 8493.405461617689, 8509.234168924795, 8242.752717418458, 8353.665853365857, 8353.95823020884, 8367.0, 8378.874316885252, 8221.630026648816, 8238.217369349903, 8293.460925039883, 8339.0, 8372.204640559137, 8214.890989716372, 8349.499030058216, 8366.45618034832, 8372.330213582898, 8402.873956890651, 8118.2693557580105, 8196.016478022615, 8302.335813134934, 8310.25207731301, 8330.333573314181, 36730.44904326437, 37168.814155929045, 37206.25587488262, 37324.44013339802, 37404.43893341602, 2753.2566207124164, 2810.4519618674367, 3102.10039088664, 3251.0, 3284.8850290239725, 25338.49323013548, 25692.0, 26397.604035939476, 26578.0, 26714.065007724636, 2162.7512836023902, 2227.2538699535676, 2258.3337915315024, 2270.909163633453, 2332.498512819735, 239287.0, 240330.0, 241210.0, 243119.78440107862, 245018.0, 50312.49687503078, 52904.20643690348, 57214.71392643094, 57804.71097644485, 60228.698856505434, 58716.0, 59238.11142832861, 59368.0, 59415.70292148598, 60374.0, 15792.684146317239, 15938.0, 15977.281022354022, 15988.120653363943, 16024.439144629881, 11734.413279335999, 11891.76216475683, 11912.344821034752, 11944.64166075019, 12019.819702704466, 18966.43100706981, 19103.904480477508, 19147.521311967314, 19147.90426047861, 19250.22999080021, 8174.550399728072, 8426.620802063799, 8429.114942931026, 8448.11294814048, 8491.23578877904, 855.9657613695507, 909.6088681866728, 958.8897276813116, 988.3723835364451, 1007.677543186188, 26425.603615945776, 26594.867025665135, 26759.206091624015, 26906.461870762476, 26910.5963410549, 998.1116806042628, 1012.0840639221516, 1029.5727273181697, 1038.2265212416798, 1120.523777394604, 13770.449182032606, 13948.442062317597, 15299.847001530065, 15635.530934071769, 16152.273147708147, 404685.0, 412583.0, 414759.0, 415945.0, 417969.0, 54123.72938135363, 54548.0, 54572.0, 55433.0, 55498.44501555013, 1349.3388239762446, 1350.27085373897, 1350.2776014832018, 1353.7901625248103, 1368.3979049218312, 26177.0, 27040.32399189957, 27538.0, 27600.171994840188, 27851.721482784913, 44471.0, 44531.0, 44547.554524455634, 44639.330410044524, 44679.776601116784, 291982.0, 292726.0, 293284.7350342728, 295053.0, 298213.0, 29483.41033179367, 41559.58440415678, 42946.78526607347, 43087.56912430836, 43095.78452107719, 43029.56970430256, 43537.78231108824, 44150.55849441465, 44440.777796110815, 45032.324515131644, 33459.665403346626, 34385.82807085948, 34403.4839477403, 34517.65482345144, 35976.82011589925, 33601.83199083989, 33635.66364336325, 34019.65980340264, 34078.0, 34202.14494637554, 34048.65951340554, 34102.0, 34456.65543344535, 34697.0, 35074.473882892285, 29181.854090729412, 29648.407031859675, 29868.964457291466, 30138.69861301359, 31316.530252046694, 22723.0, 22748.77251227533, 23033.193838215582, 23042.539149217257, 23156.6526502106], "prototype.html": [299.4295866374556, 301.99999999999994, 310.58691939720177, 311.4316372619969, 311.9532070189473, 5607.355154157273, 5713.285839270091, 5753.482186603205, 5772.797952071678, 5789.797357092497, 5540.445955404458, 5573.637713548616, 5612.494875461208, 5660.688662123582, 5669.489745922866, 4134.11116609928, 4151.377293405998, 4174.290370636999, 4197.454330936974, 4223.049813791888, 4142.17156568686, 4154.231467178582, 4196.055887425336, 4218.578142185772, 4326.0266440051055, 4186.309258972281, 4232.957670423302, 4242.596953289432, 4248.766317852517, 4249.46881639795, 4183.6653067754505, 4242.300020496615, 4253.3619957006385, 4260.318349064135, 4279.058607106416, 3600.71194304455, 3647.8905632831056, 3664.725145614063, 3668.3580373434543, 3669.541307336583, 5275.788968441258, 5377.784888604451, 5440.265564148829, 5513.952349053707, 5515.61390702651, 4827.324174615556, 4842.467328593852, 4842.539958703917, 4857.61139108874, 4860.392450943632, 5869.735861886225, 5872.324682661506, 5873.3245676746865, 5907.675077870758, 5992.580519363646, 3873.748206366577, 3993.920121597581, 3996.3805610130185, 4011.5186177658575, 4022.8189731462153, 6038.96980515099, 6102.176206212193, 6108.847278818021, 6132.877342453126, 6146.907796383058, 4025.376066709665, 4047.494063242095, 4056.7363121397607, 4059.8579049733116, 4066.1054567994993, 4075.1238483726142, 4115.609017143366, 4124.608162224584, 4126.525449573338, 4127.752334859858, 4690.906181876343, 4722.7874745635845, 4736.478987311393, 4751.192297309466, 4819.228923372314, 5907.320658124285, 5909.409059094056, 5938.6436813791315, 5939.584229103922, 5978.581499295007, 1463.239115659851, 1469.9265036748334, 1473.7199932012884, 1494.8430414806505, 1499.7450433426343, 941.1153515695224, 944.8818897637796, 959.822432849911, 964.4550828781715, 981.2052237687353, 5602.971985140048, 5603.663780173202, 5648.491635752802, 5648.604597678123, 5659.717014149276, 6145.262568491809, 6149.754009839557, 6151.692415379213, 6154.476869466145, 6159.784407545714, 5554.0835762099605, 5564.777408903679, 5612.017896868032, 5624.437556244425, 5644.8871022579315, 3327.234736010683, 3388.0, 3392.6946574807894, 3395.7283417326553, 3404.42124838778, 6067.939320606737, 6202.906956395657, 6235.875282494325, 6249.218847644044, 6272.247330320391, 6130.080487926757, 6247.9062814057825, 6327.3988971047675, 6327.968360158262, 6352.110704501373, 6099.207103076572, 6189.535784816157, 6230.844228894314, 6256.6871656417, 6280.497560195082, 5973.880522389615, 6074.605150665193, 6109.419605137505, 6118.449339559461, 6153.38466153399, 5957.76168953237, 6063.272407311151, 6064.332923378337, 6073.0283154695035, 6151.477124444473, 6258.874822503615, 6310.6529140895855, 6335.524835637253, 6344.333844946399, 6355.777547785805, 3917.941230881596, 3947.9407808883466, 3962.247173037229, 3975.2248311578965, 3988.12261302513, 6013.488853447506, 6106.847328816815, 6170.197874276315, 6222.719977601109, 6229.283632382334, 5924.763009479745, 5938.2280303560265, 5958.374370691015, 6014.548908831943, 6035.9094613579955, 5918.556108291809, 5953.970230148995, 5956.523478121653, 5988.221531200916, 6020.729067192075, 5637.379888212376, 5754.309482862083, 5785.479306862402, 5788.334341550607, 5818.592698511064, 6053.697315134314, 6068.393160683896, 6075.726592303268, 6080.48315893154, 6128.50971922254, 5868.38381969887, 5886.735096920735, 5895.174675545341, 5898.675572843363, 5918.704064796657], "yui.html": [654.7708302094267, 684.9760258390954, 705.4708968273794, 709.9503034787564, 714.1073657927591, 12670.619881403562, 12871.356432178378, 13058.869411305895, 13094.148880322773, 13164.012699047575, 12751.171173873692, 12937.288449135294, 12945.741085178292, 12992.350382480885, 13047.15193512421, 639.6162302618438, 647.7344288841576, 812.5937031484258, 818.0551463060145, 819.4468733604793, 806.5080301016376, 808.3250485844297, 821.0434843407423, 824.3858325547476, 824.5382585751968, 840.8150206954491, 847.576211894053, 850.2050582705159, 850.2857599616322, 855.2772906893696, 834.2825170353491, 839.8152406470567, 843.9113893041234, 844.5777111444278, 849.9999999999969, 614.7725341623583, 614.9016157414837, 615.2186722861941, 618.7401291457554, 621.3258614403378, 12485.93757031209, 12489.313087780169, 12633.620991370273, 12809.487620495169, 12860.678483037906, 8259.297959673435, 8594.355423343275, 8754.255888249507, 8902.777430564287, 8975.551222438851, 8341.916580834175, 8385.119562445978, 8422.620982055761, 8465.66137354505, 8489.490630562124, 2682.825616334932, 2688.932776680579, 2689.663792025997, 2689.973100268992, 2722.8502432366213, 43062.569374306484, 43424.78287608573, 43563.346549801776, 43641.12717745627, 44049.339259911125, 6201.844953876099, 6249.468795152463, 6399.6800159992745, 6521.967390163114, 6585.86828263432, 11253.831192532118, 11302.0, 11347.716307092389, 11359.09127269833, 11404.0, 5289.788408463695, 5382.273393091961, 5401.702906340189, 5434.864128396743, 5565.0817615093865, 3297.1262615406936, 3455.740819438552, 3489.4068008438626, 3491.1097670093964, 3504.6144924058335, 2295.540891821642, 2297.471581536256, 2329.6971393719045, 2342.0631747300877, 2368.4315764216462, 368.6000689252138, 371.44654464847724, 372.7316332240782, 381.9427085937076, 381.95989421110386, 489.58385372433145, 493.8320970869921, 500.2421331682504, 542.8127296082845, 547.9999001821611, 6568.573042752206, 6724.798256052326, 7809.297163255221, 7813.140554538996, 7859.764207073797, 441.67316186022754, 442.8737809724213, 443.8912466445677, 515.9742012899341, 546.1289243656362, 3189.744820414361, 3211.4701074322943, 3313.122022663996, 3357.4124528207467, 3369.4945758136478, 56716.0, 57052.0, 57319.71340143356, 57830.13254801181, 57837.4216257832, 48638.02723945501, 49065.754671226416, 49669.25496117561, 49909.0, 49966.25050624244, 41201.79399102985, 42028.78985605053, 42043.7897810509, 42649.57350426456, 45152.548474514835, 7089.397401220954, 7226.385757210696, 7362.226966168475, 7650.693972241048, 7682.692692292246, 33428.164295891824, 34011.48982765211, 34358.0, 34418.48372274368, 34714.479282811284, 41185.1762964745, 43567.56432435762, 44036.0, 44748.32877506775, 45730.54269457263, 6740.494462915203, 6788.083608712761, 6922.411595014279, 6943.0591737997765, 7167.247439018828, 10406.063454288847, 10483.423411712429, 10528.894711052792, 10545.156387488829, 10936.179786515884, 9403.952980235055, 9409.811803764023, 9830.36102653354, 9831.655892043744, 10344.0, 9325.487098209664, 9699.17557007634, 9720.319577629782, 10025.398476091457, 10025.799484010426, 9210.125038121369, 9350.579223934803, 9401.529923503935, 9416.811663766823, 9597.47213903242, 7976.32201262876, 7990.3208227299, 8116.513009219466, 8228.83542329162, 8538.487690738575, 8114.959425202836, 8122.675092996214, 8320.209580089882, 8365.079841217339, 8527.957360213159]}, "summary": {"suite": 6271.946080053486, "subtests": {"jquery.html": {"filtered": 7546.6431743426665, "value": 7546.6431743426665}, "dojo.html": {"filtered": 4929.97951198514, "value": 4929.97951198514}, "mootools.html": {"filtered": 3881.080570553827, "value": 3881.080570553827}, "ext.html": {"filtered": 17846.357007927956, "value": 17846.357007927956}, "prototype.html": {"filtered": 4432.184571035963, "value": 4432.184571035963}, "yui.html": {"filtered": 5329.040390557966, "value": 5329.040390557966}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0098.e"}, "testrun": {"date": 1449007911, "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": "44.0a2", "id": "20151201091731", "branch": "Mozilla-Aurora", "revision": "e576dd92d0f27df387320ed59fce50803549828c"}}, {"talos_counters": {}, "results": {"audio-dft": [179.0, 184.0, 186.0, 191.0, 189.0, 198.0, 203.0, 191.0, 186.0, 185.0], "ai-astar": [114.0, 115.0, 110.0, 113.0, 118.0, 133.0, 115.0, 111.0, 115.0, 122.0], "imaging-gaussian-blur": [130.0, 131.0, 137.0, 136.0, 142.0, 137.0, 137.0, 142.0, 140.0, 137.0], "audio-beat-detection": [163.0, 144.0, 186.0, 177.0, 148.0, 169.0, 147.0, 180.0, 176.0, 154.0], "json-stringify-tinderbox": [68.0, 76.0, 68.0, 73.0, 76.0, 74.0, 76.0, 75.0, 79.0, 79.0], "stanford-crypto-pbkdf2": [162.0, 168.0, 165.0, 171.0, 174.0, 159.0, 166.0, 171.0, 165.0, 169.0], "json-parse-financial": [67.0, 67.0, 70.0, 71.0, 75.0, 76.0, 77.0, 84.0, 71.0, 74.0], "stanford-crypto-sha256-iterative": [74.0, 70.0, 76.0, 76.0, 77.0, 77.0, 78.0, 83.0, 79.0, 81.0], "audio-fft": [74.0, 84.0, 89.0, 131.0, 79.0, 76.0, 81.0, 82.0, 134.0, 77.0], "imaging-darkroom": [142.0, 148.0, 148.0, 147.0, 142.0, 143.0, 148.0, 148.0, 144.0, 142.0], "stanford-crypto-ccm": [138.0, 150.0, 143.0, 149.0, 142.0, 147.0, 151.0, 155.0, 141.0, 142.0], "audio-oscillator": [95.0, 97.0, 141.0, 97.0, 104.0, 104.0, 145.0, 103.0, 100.0, 144.0], "stanford-crypto-aes": [91.0, 95.0, 95.0, 97.0, 98.0, 98.0, 100.0, 97.0, 95.0, 99.0], "imaging-desaturate": [120.0, 130.0, 122.0, 122.0, 123.0, 124.0, 120.0, 120.0, 123.0, 122.0]}, "summary": {"suite": 1712.6, "subtests": {"audio-fft": {"filtered": 90.7, "value": 90.7}, "stanford-crypto-pbkdf2": {"filtered": 167.0, "value": 167.0}, "audio-beat-detection": {"filtered": 164.4, "value": 164.4}, "stanford-crypto-ccm": {"filtered": 145.8, "value": 145.8}, "imaging-darkroom": {"filtered": 145.2, "value": 145.2}, "json-parse-financial": {"filtered": 73.2, "value": 73.2}, "audio-oscillator": {"filtered": 113.0, "value": 113.0}, "ai-astar": {"filtered": 116.6, "value": 116.6}, "audio-dft": {"filtered": 189.2, "value": 189.2}, "stanford-crypto-sha256-iterative": {"filtered": 77.1, "value": 77.1}, "json-stringify-tinderbox": {"filtered": 74.4, "value": 74.4}, "imaging-gaussian-blur": {"filtered": 136.9, "value": 136.9}, "stanford-crypto-aes": {"filtered": 96.5, "value": 96.5}, "imaging-desaturate": {"filtered": 122.6, "value": 122.6}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0098.e"}, "testrun": {"date": 1449007911, "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": "44.0a2", "id": "20151201091731", "branch": "Mozilla-Aurora", "revision": "e576dd92d0f27df387320ed59fce50803549828c"}}, {"talos_counters": {}, "results": {"DeltaBlue": [204.58265139116202], "Encrypt": [359.45363048166786], "NavierStokes": [6320.754716981132], "Decrypt": [6223.60248447205], "Splay": [664.8936170212766], "Richards": [177.43080198722498], "RegExp": [31562.5], "Earley": [745.156482861401], "Boyer": [13808.219178082192], "RayTrace": [1091.6030534351146]}, "summary": {"suite": 18688.501006763137, "subtests": {"DeltaBlue": {"filtered": 323.1847840000001, "value": 323.1847840000001}, "Encrypt": {"filtered": 740.5155419999998, "value": 740.5155419999998}, "NavierStokes": {"filtered": 234.78208955223894, "value": 234.78208955223894}, "Decrypt": {"filtered": 42.76960179640721, "value": 42.76960179640721}, "Splay": {"filtered": 122.56246400000005, "value": 122.56246400000005}, "RegExp": {"filtered": 28.86289108910892, "value": 28.86289108910892}, "Richards": {"filtered": 198.96207199999998, "value": 198.96207199999998}, "Earley": {"filtered": 894.393346, "value": 894.393346}, "Boyer": {"filtered": 48.26567361111107, "value": 48.26567361111107}, "RayTrace": {"filtered": 677.8920209790209, "value": 677.8920209790209}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0098.e"}, "testrun": {"date": 1449007911, "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": "44.0a2", "id": "20151201091731", "branch": "Mozilla-Aurora", "revision": "e576dd92d0f27df387320ed59fce50803549828c"}}] 14:32:00 INFO - RETURN: dromaeo_css: 6271.94 14:32:00 INFO - RETURN: kraken: 1712.60 14:32:00 INFO - RETURN: v8_7: 18688.50 14:32:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,57]]", "result": "18688.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,57]]", "result": "1712.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,57]]", "result": "6271.94"}}} 14:32:00 INFO - Return code: 0 14:32:00 INFO - # TBPL SUCCESS # 14:32:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:32:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:32:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:32:00 INFO - 2015-12-01 14:32:00.767 screenresolution[1975:16948] starting screenresolution argv=screenresolution get 14:32:00 INFO - 2015-12-01 14:32:00.770 screenresolution[1975:16948] Display 0: 1600x1200x32@60 14:32:00 INFO - 2015-12-01 14:32:00.776 screenresolution[1976:16950] starting screenresolution argv=screenresolution list 14:32:00 INFO - Available Modes on Display 0 14:32:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:32:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:32:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:32:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:32:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:32:01 INFO - Intel HD Graphics 3000: 14:32:01 INFO - Chipset Model: Intel HD Graphics 3000 14:32:01 INFO - Type: GPU 14:32:01 INFO - Bus: Built-In 14:32:01 INFO - VRAM (Total): 512 MB 14:32:01 INFO - VRAM (Dynamic, Max): 10 14:32:01 INFO - Vendor: Intel (0x8086) 14:32:01 INFO - Device ID: 0x0116 14:32:01 INFO - Revision ID: 0x0009 14:32:01 INFO - Displays: 14:32:01 INFO - Display: 14:32:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:32:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:32:01 INFO - Display Serial Number: 1600x1200 60 14:32:01 INFO - Main Display: Yes 14:32:01 INFO - Mirror: Off 14:32:01 INFO - Online: Yes 14:32:01 INFO - Rotation: Supported 14:32:01 INFO - Return code: 0 14:32:01 INFO - Running post-action listener: _resource_record_post_action 14:32:01 INFO - Running post-run listener: _resource_record_post_run 14:32:02 INFO - Total resource usage - Wall time: 1249s; CPU: 30.0%; Read bytes: 245760; Write bytes: 683920384; Read time: 460; Write time: 46665 14:32:02 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 342376960; Write bytes: 344397824; Read time: 34553; Write time: 5720 14:32:02 INFO - run-tests - Wall time: 1210s; CPU: 30.0%; Read bytes: 184320; Write bytes: 338199552; Read time: 418; Write time: 40907 14:32:02 INFO - Running post-run listener: _upload_blobber_files 14:32:02 INFO - Blob upload gear active. 14:32:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:32:02 INFO - Copying logs to upload dir... 14:32:02 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1334.106411 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2015-12-01 14:32:02.180781) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-01 14:32:02.184810) ========= 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.TPIzYUDd7l/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.ZLL42Kxsz3/Listeners TMPDIR=/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/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/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009968 build_url: 'https://queue.taskcluster.net/v1/task/uQO8dreeSISpHFnahCu73A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-01 14:32:02.206741) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:32:02.207112) ========= 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.TPIzYUDd7l/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.ZLL42Kxsz3/Listeners TMPDIR=/var/folders/xx/gv0s18hn05b8fgdj1bbts38w00000w/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.005147 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-01 14:32:02.260619) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-01 14:32:02.260970) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-01 14:32:02.261497) ========= ========= Total master_lag: 0.23 =========