builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0063 starttime: 1448332884.42 results: success (0) buildid: 20151123173633 builduid: d1c54936b1de4e088d7f88ca1df7cec1 revision: eb7962bf88a8517d92c21263f3982fe95ff80eb4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:24.416019) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:24.416483) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:24.416765) ========= 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.V1ot5PuGKO/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.vdYbcBzg71/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005796 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:24.436932) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:24.437211) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:24.451278) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:24.451538) ========= 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.V1ot5PuGKO/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.vdYbcBzg71/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005393 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:24.499998) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:24.500463) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:24.501272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:24.501842) ========= 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.V1ot5PuGKO/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.vdYbcBzg71/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-23 18:41:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.41M=0.001s 2015-11-23 18:41:24 (8.41 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118094 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:24.635800) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:24.636275) ========= 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.V1ot5PuGKO/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.vdYbcBzg71/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019905 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:24.685820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 18:41:24.686175) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eb7962bf88a8517d92c21263f3982fe95ff80eb4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev eb7962bf88a8517d92c21263f3982fe95ff80eb4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V1ot5PuGKO/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.vdYbcBzg71/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-23 18:41:24,751 truncating revision to first 12 chars 2015-11-23 18:41:24,751 Setting DEBUG logging. 2015-11-23 18:41:24,751 attempt 1/10 2015-11-23 18:41:24,751 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eb7962bf88a8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 18:41:26,466 unpacking tar archive at: fx-team-eb7962bf88a8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.956959 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 18:41:26.657393) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:26.657709) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:26.668851) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:26.669393) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:26.670149) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-23 18:41:26.670432) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V1ot5PuGKO/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.vdYbcBzg71/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 18:41:26 INFO - MultiFileLogger online at 20151123 18:41:26 in /builds/slave/test 18:41:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:41:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:41:26 INFO - {'append_to_log': False, 18:41:26 INFO - 'base_work_dir': '/builds/slave/test', 18:41:26 INFO - 'blob_upload_branch': 'Fx-Team', 18:41:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:41:26 INFO - 'branch': 'Fx-Team', 18:41:26 INFO - 'buildbot_json_path': 'buildprops.json', 18:41:26 INFO - 'config_files': ('talos/mac_config.py',), 18:41:26 INFO - 'default_actions': ('clobber', 18:41:26 INFO - 'read-buildbot-config', 18:41:26 INFO - 'download-and-extract', 18:41:26 INFO - 'populate-webroot', 18:41:26 INFO - 'create-virtualenv', 18:41:26 INFO - 'install', 18:41:26 INFO - 'run-tests'), 18:41:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:41:26 INFO - 'download_minidump_stackwalk': True, 18:41:26 INFO - 'download_symbols': 'ondemand', 18:41:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:41:26 INFO - 'tooltool.py': '/tools/tooltool.py', 18:41:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:41:26 INFO - '/tools/misc-python/virtualenv.py')}, 18:41:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:41:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:41:26 INFO - 'installer_path': 'installer.exe', 18:41:26 INFO - 'log_level': 'info', 18:41:26 INFO - 'log_name': 'talos', 18:41:26 INFO - 'log_to_console': True, 18:41:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:41:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:41:26 INFO - 'opt_config_files': (), 18:41:26 INFO - 'pip_index': False, 18:41:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:41:26 INFO - 'cmd': ('bash', 18:41:26 INFO - '-c', 18:41:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:41:26 INFO - 'enabled': True, 18:41:26 INFO - 'halt_on_failure': False, 18:41:26 INFO - 'name': 'check_screen_resolution'},), 18:41:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:41:26 INFO - 'cmd': ('bash', 18:41:26 INFO - '-c', 18:41:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:41:26 INFO - 'enabled': True, 18:41:26 INFO - 'halt_on_failure': False, 18:41:26 INFO - 'name': 'check_screen_resolution'},), 18:41:26 INFO - 'run_cmd_checks_enabled': True, 18:41:26 INFO - 'sps_profile': False, 18:41:26 INFO - 'sps_profile_interval': 0, 18:41:26 INFO - 'suite': 'dromaeojs', 18:41:26 INFO - 'system_bits': '64', 18:41:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:41:26 INFO - 'title': 't-yosemite-r7-0063', 18:41:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:41:26 INFO - 'use_talos_json': True, 18:41:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:41:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:41:26 INFO - 'work_dir': 'build'} 18:41:26 INFO - ##### 18:41:26 INFO - ##### Running clobber step. 18:41:26 INFO - ##### 18:41:26 INFO - Running pre-action listener: _resource_record_pre_action 18:41:26 INFO - Running main action method: clobber 18:41:26 INFO - rmtree: /builds/slave/test/build 18:41:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:41:28 INFO - Running post-action listener: _resource_record_post_action 18:41:28 INFO - ##### 18:41:28 INFO - ##### Running read-buildbot-config step. 18:41:28 INFO - ##### 18:41:28 INFO - Running pre-action listener: _resource_record_pre_action 18:41:28 INFO - Running main action method: read_buildbot_config 18:41:28 INFO - Using buildbot properties: 18:41:28 INFO - { 18:41:28 INFO - "properties": { 18:41:28 INFO - "buildnumber": 21, 18:41:28 INFO - "product": "firefox", 18:41:28 INFO - "script_repo_revision": "production", 18:41:28 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 18:41:28 INFO - "repository": "", 18:41:28 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 18:41:28 INFO - "buildid": "20151123173633", 18:41:28 INFO - "slavename": "t-yosemite-r7-0063", 18:41:28 INFO - "pgo_build": "False", 18:41:28 INFO - "basedir": "/builds/slave/test", 18:41:28 INFO - "project": "", 18:41:28 INFO - "platform": "yosemite_r7", 18:41:28 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:41:28 INFO - "slavebuilddir": "test", 18:41:28 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:41:28 INFO - "branch": "fx-team", 18:41:28 INFO - "repo_path": "integration/fx-team", 18:41:28 INFO - "stage_platform": "macosx64", 18:41:28 INFO - "builduid": "d1c54936b1de4e088d7f88ca1df7cec1", 18:41:28 INFO - "revision": "eb7962bf88a8517d92c21263f3982fe95ff80eb4" 18:41:28 INFO - }, 18:41:28 INFO - "sourcestamp": { 18:41:28 INFO - "repository": "", 18:41:28 INFO - "hasPatch": false, 18:41:28 INFO - "project": "", 18:41:28 INFO - "branch": "fx-team-macosx64-talos", 18:41:28 INFO - "changes": [ 18:41:28 INFO - { 18:41:28 INFO - "category": null, 18:41:28 INFO - "files": [ 18:41:28 INFO - { 18:41:28 INFO - "url": null, 18:41:28 INFO - "name": "https://queue.taskcluster.net/v1/task/cIGSj8BcS0KfdvDo3RmFlw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 18:41:28 INFO - } 18:41:28 INFO - ], 18:41:28 INFO - "repository": "", 18:41:28 INFO - "rev": "06223b0f30bb1e057b6d118ca2c03ff6f0176520", 18:41:28 INFO - "who": "jryans@gmail.com", 18:41:28 INFO - "when": 1448331110, 18:41:28 INFO - "number": 6698437, 18:41:28 INFO - "comments": "Bug 1226699 - Add per-app DevTools prefs to Graphene. r=fabrice\n", 18:41:28 INFO - "project": "", 18:41:28 INFO - "at": "Mon 23 Nov 2015 18:11:50", 18:41:28 INFO - "branch": "fx-team-macosx64-talos", 18:41:28 INFO - "revlink": "", 18:41:28 INFO - "properties": [ 18:41:28 INFO - [ 18:41:28 INFO - "buildid", 18:41:28 INFO - "20151123161132", 18:41:28 INFO - "Change" 18:41:28 INFO - ], 18:41:28 INFO - [ 18:41:28 INFO - "builduid", 18:41:28 INFO - "44e585c9529d4f6aaa81d26a5d97eacf", 18:41:28 INFO - "Change" 18:41:28 INFO - ], 18:41:28 INFO - [ 18:41:28 INFO - "pgo_build", 18:41:28 INFO - "False", 18:41:28 INFO - "Change" 18:41:28 INFO - ] 18:41:28 INFO - ], 18:41:28 INFO - "revision": "06223b0f30bb1e057b6d118ca2c03ff6f0176520" 18:41:28 INFO - }, 18:41:28 INFO - { 18:41:28 INFO - "category": null, 18:41:28 INFO - "files": [ 18:41:28 INFO - { 18:41:28 INFO - "url": null, 18:41:28 INFO - "name": "https://queue.taskcluster.net/v1/task/cuIpSxrOSR-gDitnivZ4Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 18:41:28 INFO - } 18:41:28 INFO - ], 18:41:28 INFO - "repository": "", 18:41:28 INFO - "rev": "dcae05a0b0da59b35f21c6427efbbcba3f1b357d", 18:41:28 INFO - "who": "kwierso@gmail.com", 18:41:28 INFO - "when": 1448332614, 18:41:28 INFO - "number": 6698566, 18:41:28 INFO - "comments": "Merge m-c to fx-team, a=merge", 18:41:28 INFO - "project": "", 18:41:28 INFO - "at": "Mon 23 Nov 2015 18:36:54", 18:41:28 INFO - "branch": "fx-team-macosx64-talos", 18:41:28 INFO - "revlink": "", 18:41:28 INFO - "properties": [ 18:41:28 INFO - [ 18:41:28 INFO - "buildid", 18:41:28 INFO - "20151123165532", 18:41:28 INFO - "Change" 18:41:28 INFO - ], 18:41:28 INFO - [ 18:41:28 INFO - "builduid", 18:41:28 INFO - "39e07939b643402b990b81b49afe15f9", 18:41:28 INFO - "Change" 18:41:28 INFO - ], 18:41:28 INFO - [ 18:41:28 INFO - "pgo_build", 18:41:28 INFO - "False", 18:41:28 INFO - "Change" 18:41:28 INFO - ] 18:41:28 INFO - ], 18:41:28 INFO - "revision": "dcae05a0b0da59b35f21c6427efbbcba3f1b357d" 18:41:28 INFO - }, 18:41:28 INFO - { 18:41:28 INFO - "category": null, 18:41:28 INFO - "files": [ 18:41:28 INFO - { 18:41:28 INFO - "url": null, 18:41:28 INFO - "name": "https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 18:41:28 INFO - } 18:41:28 INFO - ], 18:41:28 INFO - "repository": "", 18:41:28 INFO - "rev": "eb7962bf88a8517d92c21263f3982fe95ff80eb4", 18:41:28 INFO - "who": "maglione.k@gmail.com", 18:41:28 INFO - "when": 1448331943, 18:41:28 INFO - "number": 6698494, 18:41:28 INFO - "comments": "Bug 1209184: Part 1a - [webext] Make localization work in content processes. r=billm", 18:41:28 INFO - "project": "", 18:41:28 INFO - "at": "Mon 23 Nov 2015 18:25:43", 18:41:28 INFO - "branch": "fx-team-macosx64-talos", 18:41:28 INFO - "revlink": "", 18:41:28 INFO - "properties": [ 18:41:28 INFO - [ 18:41:28 INFO - "buildid", 18:41:28 INFO - "20151123173633", 18:41:28 INFO - "Change" 18:41:28 INFO - ], 18:41:28 INFO - [ 18:41:28 INFO - "builduid", 18:41:28 INFO - "d1c54936b1de4e088d7f88ca1df7cec1", 18:41:28 INFO - "Change" 18:41:28 INFO - ], 18:41:28 INFO - [ 18:41:28 INFO - "pgo_build", 18:41:28 INFO - "False", 18:41:28 INFO - "Change" 18:41:28 INFO - ] 18:41:28 INFO - ], 18:41:28 INFO - "revision": "eb7962bf88a8517d92c21263f3982fe95ff80eb4" 18:41:28 INFO - } 18:41:28 INFO - ], 18:41:28 INFO - "revision": "eb7962bf88a8517d92c21263f3982fe95ff80eb4" 18:41:28 INFO - } 18:41:28 INFO - } 18:41:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 18:41:28 INFO - Running post-action listener: _resource_record_post_action 18:41:28 INFO - ##### 18:41:28 INFO - ##### Running download-and-extract step. 18:41:28 INFO - ##### 18:41:28 INFO - Running pre-action listener: _resource_record_pre_action 18:41:28 INFO - Running main action method: download_and_extract 18:41:28 INFO - mkdir: /builds/slave/test/build/tests 18:41:28 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')]} 18:41:28 INFO - https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:41:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/test_packages.json 18:41:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/test_packages.json 18:41:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:41:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:41:29 INFO - Downloaded 1149 bytes. 18:41:29 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:41:29 INFO - Using the following test package requirements: 18:41:29 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:41:29 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:41:29 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 18:41:29 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:41:29 INFO - u'jsshell-mac.zip'], 18:41:29 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:41:29 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 18:41:29 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:41:29 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:41:29 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 18:41:29 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:41:29 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 18:41:29 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:41:29 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 18:41:29 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:41:29 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:41:29 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 18:41:29 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:29 INFO - https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:41:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:41:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:41:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:41:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:41:30 INFO - Downloaded 17526952 bytes. 18:41:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 18:41:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:41:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:41:33 INFO - Return code: 0 18:41:33 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:41: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')]} 18:41:33 INFO - https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:41:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:41:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:41:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:41:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:41:34 INFO - Downloaded 17526952 bytes. 18:41:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 18:41:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:41:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:41:37 INFO - Return code: 0 18:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:37 INFO - https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:41:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:41:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:41:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:41:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:41:39 INFO - Downloaded 11130997 bytes. 18:41:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 18:41:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:41:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 18:41:39 INFO - Return code: 0 18:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:39 INFO - https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:41:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:41:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:41:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 18:41:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 18:41:42 INFO - Downloaded 109908876 bytes. 18:41:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:41:42 INFO - mkdir: /builds/slave/test/properties 18:41:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:41:42 INFO - Writing to file /builds/slave/test/properties/build_url 18:41:42 INFO - Contents: 18:41:42 INFO - build_url:https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:41:42 INFO - Running post-action listener: _resource_record_post_action 18:41:42 INFO - Running post-action listener: set_extra_try_arguments 18:41:42 INFO - ##### 18:41:42 INFO - ##### Running populate-webroot step. 18:41:42 INFO - ##### 18:41:42 INFO - Running pre-action listener: _resource_record_pre_action 18:41:42 INFO - Running main action method: populate_webroot 18:41:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:41:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:41:42 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:41:42 INFO - '../fennec_ids.txt'], 18:41:42 INFO - 'tests': ['tcheck2']}, 18:41:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:41:42 INFO - '--tppagecycles', 18:41:42 INFO - '7'], 18:41:42 INFO - 'tests': ['tsvgm']}}, 18:41:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:41:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:41:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:41:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:41:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:41:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:41:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:41:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:42 INFO - 'talos_options': ['--e10s'], 18:41:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:41:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:42 INFO - 'tests': ['damp', 'tps']}, 18:41:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:42 INFO - 'talos_options': ['--e10s'], 18:41:42 INFO - 'tests': ['damp', 'tps']}, 18:41:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:41:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:41:42 INFO - 'other': {'tests': ['a11yr', 18:41:42 INFO - 'ts_paint', 18:41:42 INFO - 'tpaint', 18:41:42 INFO - 'sessionrestore', 18:41:42 INFO - 'sessionrestore_no_auto_restore']}, 18:41:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:41:42 INFO - 'tests': ['a11yr', 18:41:42 INFO - 'ts_paint', 18:41:42 INFO - 'tpaint', 18:41:42 INFO - 'sessionrestore', 18:41:42 INFO - 'sessionrestore_no_auto_restore']}, 18:41:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:41:42 INFO - 'tests': ['a11yr', 18:41:42 INFO - 'ts_paint', 18:41:42 INFO - 'tpaint', 18:41:42 INFO - 'sessionrestore', 18:41:42 INFO - 'sessionrestore_no_auto_restore']}, 18:41:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:41:42 INFO - 'tests': ['a11yr', 18:41:42 INFO - 'ts_paint', 18:41:42 INFO - 'tpaint', 18:41:42 INFO - 'sessionrestore', 18:41:42 INFO - 'sessionrestore_no_auto_restore']}, 18:41:42 INFO - 'other_l64': {'tests': ['a11yr', 18:41:42 INFO - 'ts_paint', 18:41:42 INFO - 'tpaint', 18:41:42 INFO - 'sessionrestore', 18:41:42 INFO - 'sessionrestore_no_auto_restore']}, 18:41:42 INFO - 'other_nol64': {'tests': ['a11yr', 18:41:42 INFO - 'ts_paint', 18:41:42 INFO - 'tpaint', 18:41:42 INFO - 'sessionrestore', 18:41:42 INFO - 'sessionrestore_no_auto_restore']}, 18:41:42 INFO - 'svgr': {'tests': ['tsvgx', 18:41:42 INFO - 'tsvgr_opacity', 18:41:42 INFO - 'tart', 18:41:42 INFO - 'tscrollx', 18:41:42 INFO - 'cart']}, 18:41:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:41:42 INFO - 'tests': ['tsvgx', 18:41:42 INFO - 'tsvgr_opacity', 18:41:42 INFO - 'tart', 18:41:42 INFO - 'tscrollx', 18:41:42 INFO - 'cart']}, 18:41:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:42 INFO - 'tests': ['tp5o']}, 18:41:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:42 INFO - 'talos_options': ['--e10s'], 18:41:42 INFO - 'tests': ['tp5o']}, 18:41:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:42 INFO - 'talos_options': ['--xperf_path', 18:41:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:41:42 INFO - 'tests': ['tp5n']}, 18:41:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:42 INFO - 'talos_options': ['--e10s', 18:41:42 INFO - '--xperf_path', 18:41:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:41:42 INFO - 'tests': ['tp5n']}}, 18:41:42 INFO - 'talos.zip': {'path': '', 18:41:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:41:42 INFO - Running post-action listener: _resource_record_post_action 18:41:42 INFO - ##### 18:41:42 INFO - ##### Running create-virtualenv step. 18:41:42 INFO - ##### 18:41:42 INFO - Running pre-action listener: _resource_record_pre_action 18:41:42 INFO - Running main action method: create_virtualenv 18:41:42 INFO - Creating virtualenv /builds/slave/test/build/venv 18:41:42 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 18:41:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:41:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:41:42 INFO - Using real prefix '/tools/python27' 18:41:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:41:43 INFO - Installing distribute.............................................................................................................................................................................................done. 18:41:46 INFO - Installing pip.................done. 18:41:46 INFO - Return code: 0 18:41:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10af86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af63228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8261d45a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaa9f0>, '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 0x10ac09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae9d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1ot5PuGKO/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.vdYbcBzg71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:41:46 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 18:41:46 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 18:41:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1ot5PuGKO/Render', 18:41:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:41:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:41:46 INFO - 'HOME': '/Users/cltbld', 18:41:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:41:46 INFO - 'LOGNAME': 'cltbld', 18:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:46 INFO - 'MOZ_NO_REMOTE': '1', 18:41:46 INFO - 'NO_EM_RESTART': '1', 18:41:46 INFO - 'PAGER': '/bin/cat', 18:41:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:46 INFO - 'PWD': '/builds/slave/test', 18:41:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:41:46 INFO - 'SHELL': '/bin/bash', 18:41:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vdYbcBzg71/Listeners', 18:41:46 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 18:41:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:41:46 INFO - 'USER': 'cltbld', 18:41:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:41:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:46 INFO - 'XPC_FLAGS': '0x0', 18:41:46 INFO - 'XPC_SERVICE_NAME': '0', 18:41:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:46 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 18:41:46 INFO - Cleaning up... 18:41:46 INFO - Return code: 0 18:41:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10af86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af63228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8261d45a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaa9f0>, '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 0x10ac09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae9d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1ot5PuGKO/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.vdYbcBzg71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:41:46 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 18:41:46 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 18:41:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1ot5PuGKO/Render', 18:41:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:41:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:41:46 INFO - 'HOME': '/Users/cltbld', 18:41:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:41:46 INFO - 'LOGNAME': 'cltbld', 18:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:46 INFO - 'MOZ_NO_REMOTE': '1', 18:41:46 INFO - 'NO_EM_RESTART': '1', 18:41:46 INFO - 'PAGER': '/bin/cat', 18:41:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:46 INFO - 'PWD': '/builds/slave/test', 18:41:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:41:46 INFO - 'SHELL': '/bin/bash', 18:41:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vdYbcBzg71/Listeners', 18:41:46 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 18:41:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:41:46 INFO - 'USER': 'cltbld', 18:41:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:41:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:46 INFO - 'XPC_FLAGS': '0x0', 18:41:46 INFO - 'XPC_SERVICE_NAME': '0', 18:41:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:46 INFO - Downloading/unpacking psutil>=0.7.1 18:41:46 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 18:41:46 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 18:41:46 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 18:41:46 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 18:41:46 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 18:41:46 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 18:41:49 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:41:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:41:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:41:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:41:49 INFO - Installing collected packages: psutil 18:41:49 INFO - Running setup.py install for psutil 18:41:49 INFO - building 'psutil._psutil_osx' extension 18:41:49 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 18:41:49 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 18:41:49 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 18:41:49 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 18:41:49 INFO - building 'psutil._psutil_posix' extension 18:41:49 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 18:41:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:41:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:41:49 INFO - ^ 18:41:49 INFO - 1 warning generated. 18:41:49 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 18:41:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:41:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:41:50 INFO - Successfully installed psutil 18:41:50 INFO - Cleaning up... 18:41:50 INFO - Return code: 0 18:41:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:41: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')]} 18:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41: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')]} 18:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:50 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 0x10af86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af63228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8261d45a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaa9f0>, '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 0x10ac09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae9d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1ot5PuGKO/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.vdYbcBzg71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:41:50 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 18:41:50 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 18:41:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1ot5PuGKO/Render', 18:41:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:41:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:41:50 INFO - 'HOME': '/Users/cltbld', 18:41:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:41:50 INFO - 'LOGNAME': 'cltbld', 18:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:50 INFO - 'MOZ_NO_REMOTE': '1', 18:41:50 INFO - 'NO_EM_RESTART': '1', 18:41:50 INFO - 'PAGER': '/bin/cat', 18:41:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:50 INFO - 'PWD': '/builds/slave/test', 18:41:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:41:50 INFO - 'SHELL': '/bin/bash', 18:41:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vdYbcBzg71/Listeners', 18:41:50 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 18:41:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:41:50 INFO - 'USER': 'cltbld', 18:41:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:41:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:50 INFO - 'XPC_FLAGS': '0x0', 18:41:50 INFO - 'XPC_SERVICE_NAME': '0', 18:41:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:41:50 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 18:41:50 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 18:41:50 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 18:41:50 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 18:41:50 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 18:41:50 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 18:41:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:41:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:41:52 INFO - Installing collected packages: mozsystemmonitor 18:41:52 INFO - Running setup.py install for mozsystemmonitor 18:41:52 INFO - Successfully installed mozsystemmonitor 18:41:52 INFO - Cleaning up... 18:41:52 INFO - Return code: 0 18:41:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:41:52 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')]} 18:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:52 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')]} 18:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:52 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 0x10af86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af63228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8261d45a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaa9f0>, '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 0x10ac09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae9d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1ot5PuGKO/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.vdYbcBzg71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:41:52 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 18:41:52 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 18:41:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1ot5PuGKO/Render', 18:41:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:41:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:41:52 INFO - 'HOME': '/Users/cltbld', 18:41:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:41:52 INFO - 'LOGNAME': 'cltbld', 18:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:52 INFO - 'MOZ_NO_REMOTE': '1', 18:41:52 INFO - 'NO_EM_RESTART': '1', 18:41:52 INFO - 'PAGER': '/bin/cat', 18:41:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:52 INFO - 'PWD': '/builds/slave/test', 18:41:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:41:52 INFO - 'SHELL': '/bin/bash', 18:41:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vdYbcBzg71/Listeners', 18:41:52 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 18:41:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:41:52 INFO - 'USER': 'cltbld', 18:41:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:41:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:52 INFO - 'XPC_FLAGS': '0x0', 18:41:52 INFO - 'XPC_SERVICE_NAME': '0', 18:41:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:53 INFO - Downloading/unpacking blobuploader==1.2.4 18:41:53 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 18:41:53 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 18:41:53 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 18:41:53 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 18:41:53 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 18:41:53 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 18:41:55 INFO - Downloading blobuploader-1.2.4.tar.gz 18:41:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:41:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:41: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 18:41: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 18:41: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 18:41: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 18:41: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 18:41: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 18:41:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:41:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:41: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 18:41: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 18:41: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 18:41: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 18:41: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 18:41: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 18:41:56 INFO - Downloading docopt-0.6.1.tar.gz 18:41:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:41:56 INFO - Installing collected packages: blobuploader, requests, docopt 18:41:56 INFO - Running setup.py install for blobuploader 18:41:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:41:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:41:56 INFO - Running setup.py install for requests 18:41:57 INFO - Running setup.py install for docopt 18:41:57 INFO - Successfully installed blobuploader requests docopt 18:41:57 INFO - Cleaning up... 18:41:57 INFO - Return code: 0 18:41:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:57 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 0x10af86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af63228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8261d45a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaa9f0>, '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 0x10ac09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae9d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1ot5PuGKO/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.vdYbcBzg71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:41:57 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 18:41:57 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 18:41:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1ot5PuGKO/Render', 18:41:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:41:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:41:57 INFO - 'HOME': '/Users/cltbld', 18:41:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:41:57 INFO - 'LOGNAME': 'cltbld', 18:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:57 INFO - 'MOZ_NO_REMOTE': '1', 18:41:57 INFO - 'NO_EM_RESTART': '1', 18:41:57 INFO - 'PAGER': '/bin/cat', 18:41:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:57 INFO - 'PWD': '/builds/slave/test', 18:41:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:41:57 INFO - 'SHELL': '/bin/bash', 18:41:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vdYbcBzg71/Listeners', 18:41:57 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 18:41:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:41:57 INFO - 'USER': 'cltbld', 18:41:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:41:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:57 INFO - 'XPC_FLAGS': '0x0', 18:41:57 INFO - 'XPC_SERVICE_NAME': '0', 18:41:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:41:57 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-zR3cNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:41:57 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-763hVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:41:57 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-1fsros-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:41:57 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-DnRsZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:41:57 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-L8iZ6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:41:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-o0ZhlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:41:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-2uvtsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:41:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-0rSzO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:41:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Ach6hS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:41:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-lbRDoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:41:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-5KE04T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:41:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-fiG67J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:41:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-mCdUdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:41:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-clcxlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:58 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-DVILlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:41:59 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-PFWptN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:41:59 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-PBnUZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:41:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:41:59 INFO - Running setup.py install for manifestparser 18:41:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:41:59 INFO - Running setup.py install for mozcrash 18:41:59 INFO - Running setup.py install for mozdebug 18:41:59 INFO - Running setup.py install for mozdevice 18:41:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:41:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:41:59 INFO - Running setup.py install for mozfile 18:41:59 INFO - Running setup.py install for mozhttpd 18:42:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:42:00 INFO - Running setup.py install for mozinfo 18:42:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:42:00 INFO - Running setup.py install for mozInstall 18:42:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:42:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:42:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:42:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:42:00 INFO - Running setup.py install for mozleak 18:42:00 INFO - Running setup.py install for mozlog 18:42:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:42:00 INFO - Running setup.py install for moznetwork 18:42:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:42:00 INFO - Running setup.py install for mozprocess 18:42:01 INFO - Running setup.py install for mozprofile 18:42:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:42:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:42:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:42:01 INFO - Running setup.py install for mozrunner 18:42:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:42:01 INFO - Running setup.py install for mozscreenshot 18:42:01 INFO - Running setup.py install for moztest 18:42:01 INFO - Running setup.py install for mozversion 18:42:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:42:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:42:01 INFO - Cleaning up... 18:42:01 INFO - Return code: 0 18:42:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10af86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af63228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8261d45a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaa9f0>, '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 0x10ac09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae9d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1ot5PuGKO/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.vdYbcBzg71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:42:01 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 18:42:01 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 18:42:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1ot5PuGKO/Render', 18:42:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:42:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:42:01 INFO - 'HOME': '/Users/cltbld', 18:42:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:42:01 INFO - 'LOGNAME': 'cltbld', 18:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:01 INFO - 'MOZ_NO_REMOTE': '1', 18:42:01 INFO - 'NO_EM_RESTART': '1', 18:42:01 INFO - 'PAGER': '/bin/cat', 18:42:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:01 INFO - 'PWD': '/builds/slave/test', 18:42:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:42:01 INFO - 'SHELL': '/bin/bash', 18:42:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vdYbcBzg71/Listeners', 18:42:01 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 18:42:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:42:01 INFO - 'USER': 'cltbld', 18:42:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:42:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:01 INFO - 'XPC_FLAGS': '0x0', 18:42:01 INFO - 'XPC_SERVICE_NAME': '0', 18:42:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:42:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-CU1IzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:42:02 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)) 18:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:42:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-SMhGvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:42:02 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)) 18:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:42:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-X1r7i7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:42:02 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)) 18:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:42:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Cns4xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:42:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-ldY3aZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:42:02 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)) 18:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:42:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-bhEWn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:42:02 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)) 18:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:42:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-3XPlTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:42:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Mo2c0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:42:02 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)) 18:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:42:02 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-eypYkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:42:03 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)) 18:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:42:03 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Tngfye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:42:03 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-wvToEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:42:03 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)) 18:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:42:03 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-dYLvJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:42:03 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)) 18:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:42:03 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-st0REn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:42:03 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)) 18:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:42:03 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-h5HFSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:42:03 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)) 18:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:03 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-VY0zJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:42:03 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)) 18:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:42:03 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-yxUALb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:42:03 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)) 18:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:42:03 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-DliPcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:42:03 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)) 18:42:03 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)) 18:42:03 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)) 18:42:03 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)) 18:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:42:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:42:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:06 INFO - Downloading blessings-1.5.1.tar.gz 18:42:06 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 18:42:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:42:06 INFO - Installing collected packages: blessings 18:42:06 INFO - Running setup.py install for blessings 18:42:06 INFO - Successfully installed blessings 18:42:06 INFO - Cleaning up... 18:42:06 INFO - Return code: 0 18:42:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:42:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:42:06 INFO - Reading from file tmpfile_stdout 18:42:06 INFO - Current package versions: 18:42:06 INFO - blessings == 1.5.1 18:42:06 INFO - blobuploader == 1.2.4 18:42:06 INFO - docopt == 0.6.1 18:42:06 INFO - manifestparser == 1.1 18:42:06 INFO - mozInstall == 1.12 18:42:06 INFO - mozcrash == 0.16 18:42:06 INFO - mozdebug == 0.1 18:42:06 INFO - mozdevice == 0.47 18:42:06 INFO - mozfile == 1.2 18:42:06 INFO - mozhttpd == 0.7 18:42:06 INFO - mozinfo == 0.9 18:42:06 INFO - mozleak == 0.1 18:42:06 INFO - mozlog == 3.1 18:42:06 INFO - moznetwork == 0.27 18:42:06 INFO - mozprocess == 0.22 18:42:06 INFO - mozprofile == 0.27 18:42:06 INFO - mozrunner == 6.11 18:42:06 INFO - mozscreenshot == 0.1 18:42:06 INFO - mozsystemmonitor == 0.0 18:42:06 INFO - moztest == 0.7 18:42:06 INFO - mozversion == 1.4 18:42:06 INFO - psutil == 3.1.1 18:42:06 INFO - requests == 1.2.3 18:42:06 INFO - wsgiref == 0.1.2 18:42:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10af86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af63228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8261d45a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaa9f0>, '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 0x10ac09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae9d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1ot5PuGKO/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.vdYbcBzg71/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:42:06 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 18:42:06 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 18:42:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1ot5PuGKO/Render', 18:42:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:42:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:42:06 INFO - 'HOME': '/Users/cltbld', 18:42:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:42:06 INFO - 'LOGNAME': 'cltbld', 18:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:06 INFO - 'MOZ_NO_REMOTE': '1', 18:42:06 INFO - 'NO_EM_RESTART': '1', 18:42:06 INFO - 'PAGER': '/bin/cat', 18:42:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:06 INFO - 'PWD': '/builds/slave/test', 18:42:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:42:06 INFO - 'SHELL': '/bin/bash', 18:42:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vdYbcBzg71/Listeners', 18:42:06 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 18:42:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:42:06 INFO - 'USER': 'cltbld', 18:42:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:42:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:06 INFO - 'XPC_FLAGS': '0x0', 18:42:06 INFO - 'XPC_SERVICE_NAME': '0', 18:42:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:06 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)) 18:42:06 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)) 18:42:06 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)) 18:42:06 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)) 18:42:06 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)) 18:42:06 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)) 18:42:06 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)) 18:42:06 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)) 18:42:06 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)) 18:42:06 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)) 18:42:06 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)) 18:42:06 INFO - Cleaning up... 18:42:06 INFO - Return code: 0 18:42:06 INFO - Running post-action listener: _resource_record_post_action 18:42:06 INFO - Running post-action listener: _start_resource_monitoring 18:42:06 INFO - Starting resource monitoring. 18:42:06 INFO - ##### 18:42:06 INFO - ##### Running install step. 18:42:06 INFO - ##### 18:42:06 INFO - Running pre-action listener: _resource_record_pre_action 18:42:06 INFO - Running main action method: install 18:42:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:42:07 INFO - Reading from file tmpfile_stdout 18:42:07 INFO - Detecting whether we're running mozinstall >=1.0... 18:42:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:42:07 INFO - Reading from file tmpfile_stdout 18:42:07 INFO - Output received: 18:42:07 INFO - Usage: mozinstall [options] installer 18:42:07 INFO - Options: 18:42:07 INFO - -h, --help show this help message and exit 18:42:07 INFO - -d DEST, --destination=DEST 18:42:07 INFO - Directory to install application into. [default: 18:42:07 INFO - "/builds/slave/test"] 18:42:07 INFO - --app=APP Application being installed. [default: firefox] 18:42:07 INFO - mkdir: /builds/slave/test/build/application 18:42:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:42:37 INFO - Reading from file tmpfile_stdout 18:42:37 INFO - Output received: 18:42:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:42:37 INFO - Running post-action listener: _resource_record_post_action 18:42:37 INFO - ##### 18:42:37 INFO - ##### Running run-tests step. 18:42:37 INFO - ##### 18:42:37 INFO - Running pre-action listener: _resource_record_pre_action 18:42:37 INFO - Running main action method: run_tests 18:42:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:42:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:42:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:42:37 INFO - 2015-11-23 18:42:37.607 screenresolution[2060:10383] starting screenresolution argv=screenresolution get 18:42:37 INFO - 2015-11-23 18:42:37.609 screenresolution[2060:10383] Display 0: 1600x1200x32@60 18:42:37 INFO - 2015-11-23 18:42:37.615 screenresolution[2061:10385] starting screenresolution argv=screenresolution list 18:42:37 INFO - Available Modes on Display 0 18:42:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:42:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:42:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:42:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:42:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:42:37 INFO - Intel Iris: 18:42:37 INFO - Chipset Model: Intel Iris 18:42:37 INFO - Type: GPU 18:42:37 INFO - Bus: Built-In 18:42:37 INFO - VRAM (Dynamic, Max): 1536 MB 18:42:37 INFO - Vendor: Intel (0x8086) 18:42:37 INFO - Device ID: 0x0a2e 18:42:37 INFO - Revision ID: 0x0009 18:42:37 INFO - Displays: 18:42:37 INFO - Display: 18:42:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:42:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:42:37 INFO - Display Serial Number: 1600x1200 60 18:42:37 INFO - Main Display: Yes 18:42:37 INFO - Mirror: Off 18:42:37 INFO - Online: Yes 18:42:37 INFO - Rotation: Supported 18:42:37 INFO - Return code: 0 18:42:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:42:37 INFO - Python 2.7.3 18:42:37 INFO - Return code: 0 18:42:37 INFO - grabbing minidump binary from tooltool 18:42:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:37 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 0x10aeaa9f0>, '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 0x10ac09db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae9d8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:42:37 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 18:42:37 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 18:42:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:42:37 INFO - Return code: 0 18:42:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:42:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:42:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:42:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:42:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:42:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--webServer', 'localhost'] in /builds/slave/test/build 18:42:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0063 --webServer localhost 18:42:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1ot5PuGKO/Render', 18:42:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:42:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:42:37 INFO - 'HOME': '/Users/cltbld', 18:42:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:42:37 INFO - 'LOGNAME': 'cltbld', 18:42:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:42:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:37 INFO - 'MOZ_NO_REMOTE': '1', 18:42:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:42:37 INFO - 'NO_EM_RESTART': '1', 18:42:37 INFO - 'PAGER': '/bin/cat', 18:42:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:37 INFO - 'PWD': '/builds/slave/test', 18:42:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:42:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:42:37 INFO - 'SHELL': '/bin/bash', 18:42:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vdYbcBzg71/Listeners', 18:42:37 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 18:42:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:42:37 INFO - 'USER': 'cltbld', 18:42:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:42:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:37 INFO - 'XPC_FLAGS': '0x0', 18:42:37 INFO - 'XPC_SERVICE_NAME': '0', 18:42:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:42:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--webServer', 'localhost'] with output_timeout 3600 18:42:38 INFO - mozversion INFO | application_buildid: 20151123173633 18:42:38 INFO - mozversion INFO | application_changeset: eb7962bf88a8517d92c21263f3982fe95ff80eb4 18:42:38 INFO - mozversion INFO | application_display_name: Nightly 18:42:38 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:42:38 INFO - mozversion INFO | application_name: Firefox 18:42:38 INFO - mozversion INFO | application_remotingname: firefox 18:42:38 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:42:38 INFO - mozversion INFO | application_vendor: Mozilla 18:42:38 INFO - mozversion INFO | application_version: 45.0a1 18:42:38 INFO - mozversion INFO | platform_buildid: 20151123173633 18:42:38 INFO - mozversion INFO | platform_changeset: eb7962bf88a8517d92c21263f3982fe95ff80eb4 18:42:38 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:42:38 INFO - mozversion INFO | platform_version: 45.0a1 18:42:38 INFO - 2015-11-23 18:42:38,154 DEBUG : using testdate: 1448332958 18:42:38 INFO - 2015-11-23 18:42:38,154 DEBUG : actual date: 1448332958 18:42:38 INFO - 2015-11-23 18:42:38,163 INFO : starting webserver on 'localhost:49378' 18:42:38 INFO - 2015-11-23 18:42:38,163 INFO : Starting test suite t-yosemite-r7-0063 18:42:38 INFO - 2015-11-23 18:42:38,164 INFO : Starting test dromaeo_css 18:42:38 INFO - 2015-11-23 18:42:38,164 DEBUG : operating with platform_type : mac_ 18:42:38 INFO - 2015-11-23 18:42:38,164 INFO : Initialising browser for dromaeo_css test... 18:42:38 INFO - 2015-11-23 18:42:38,176 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmp3aA5Bx/profile http://localhost:49378/getInfo.html 18:42:40 INFO - 2015-11-23 18:42:40,256 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:42:40 INFO - 2015-11-23 18:42:40,256 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:42:40 INFO - 2015-11-23 18:42:40,256 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:42:40 INFO - 2015-11-23 18:42:40,256 DEBUG : BROWSER_OUTPUT: __metrics 18:42:40 INFO - 2015-11-23 18:42:40,263 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:42:40 INFO - 2015-11-23 18:42:40,870 INFO : Browser initialized. 18:42:40 INFO - 2015-11-23 18:42:40,871 INFO : Running cycle 1/1 for dromaeo_css test... 18:42:40 INFO - 2015-11-23 18:42:40,871 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmp3aA5Bx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:42:52 INFO - 2015-11-23 18:42:52,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 225959936 18:42:52 INFO - 2015-11-23 18:42:52,671 DEBUG : BROWSER_OUTPUT: 18:43:44 INFO - 2015-11-23 18:43:44,409 DEBUG : BROWSER_OUTPUT: 1448333024407 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] 18:45:54 INFO - 2015-11-23 18:45:54,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49378/tests/dromaeo/cssquery-ext.html) 18:45:55 INFO - 2015-11-23 18:45:55,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 409083904 18:45:55 INFO - 2015-11-23 18:45:55,830 DEBUG : BROWSER_OUTPUT: 18:48:58 INFO - 2015-11-23 18:48:58,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/dromaeo/cssquery-ext.html (next: http://localhost:49378/tests/dromaeo/cssquery-jquery.html) 18:48:59 INFO - 2015-11-23 18:48:59,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 365240320 18:48:59 INFO - 2015-11-23 18:48:59,298 DEBUG : BROWSER_OUTPUT: 18:52:01 INFO - 2015-11-23 18:52:01,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49378/tests/dromaeo/cssquery-mootools.html) 18:52:01 INFO - 2015-11-23 18:52:01,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 363261952 18:52:01 INFO - 2015-11-23 18:52:01,948 DEBUG : BROWSER_OUTPUT: 18:55:04 INFO - 2015-11-23 18:55:04,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49378/tests/dromaeo/cssquery-prototype.html) 18:55:04 INFO - 2015-11-23 18:55:04,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 321478656 18:55:04 INFO - 2015-11-23 18:55:04,647 DEBUG : BROWSER_OUTPUT: 18:58:07 INFO - 2015-11-23 18:58:07,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49378/tests/dromaeo/cssquery-yui.html) 18:58:08 INFO - 2015-11-23 18:58:08,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 325451776 18:58:08 INFO - 2015-11-23 18:58:08,287 DEBUG : BROWSER_OUTPUT: 19:01:10 INFO - 2015-11-23 19:01:10,993 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/dromaeo/cssquery-yui.html (next: http://localhost:49378/tests/dromaeo/cssquery-dojo.html) 19:01:11 INFO - 2015-11-23 19:01:11,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 373538816 19:01:11 INFO - 2015-11-23 19:01:11,251 DEBUG : BROWSER_OUTPUT: 19:01:11 INFO - 2015-11-23 19:01:11,251 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:01:11 INFO - 2015-11-23 19:01:11,251 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:01:11 INFO - 2015-11-23 19:01:11,251 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:01:11 INFO - 2015-11-23 19:01:11,251 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:01:11 INFO - 2015-11-23 19:01:11,251 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3113.112762862584;3409.369266685665;3442.0362298556415;3448.2758620689656;3466.653334666533;5457.372402173752;5577.135543990677;5668.943310566899;5669.234653321801;5698.344690360605;5569.470900264479;5619.466150715686;5643.463870932265;5802.622829516089;5831.212786273852;5055.266986286986;5069.493050694929;5091.389033316007;5128.153854613985;5194.792208311663;5235.397929238129;5239.397469291042;5247.632665713401;5272.525472707455;5298.47015298469;3794.31702293587;5015.52352526513;5087.643864929457;5092.8217512387255;5172.482751724835;5092.3125378073855;5098.260752190911;5113.539781419653;5114.181730923072;5115.181570948667;5031.823886163967;5107.4892510749;5132.5124113209185;5164.870878228075;5185.740712964337;5496.670199787985;5524.640898341635;5543.1408131739645;5548.805791797308;5558.471945165203;6169.074638804215;6175.845603859894;6176.197094377747;6183.2889217740085;6185.505159587222;6085;6116.938830611726;6169;6186.721597528077;6202.72087756052;5730.856728581777;5735.311762588516;5766.971165144189;5770.047942089592;5785.82642520725;6144.064619644798;6145.4161854623735;6178.505719542426;6225.8132256032395;6300.936990630126;6136.6318020918;6148.723307451175;6152.846178845564;6158.938410615837;6162.753489860355;6212.192414986023;6231.096491008779;6234.75060997555;6235.937640623626;6241.407066328691;5996.520278377807;6031.9396806032255;6101.877962440726;6133.662648554283;6188.504919606421;6181.072839074085;6195.380461953859;6199.473044791153;6206.131141640174;6208.565400422018;4906.092372911023;4912.091263116335;4921.434035085939;4927.876803079952;4967.3294105296045;4288.506821715543;4307.763073031013;4439.822407103744;4447.844325448658;4459.44256967879;5648.915266271009;5671.149327600893;5680.289963754531;5680.545556355564;5773.624714393551;6191.535634827316;6205.255369355616;6211.81364559064;6214.036824292242;6218.31598524162;5488.670679759227;5579.776808927598;5606.411326810708;5616.213730077792;5660.575456840754;5390.784368625289;5391.838244852583;5403.891922161535;5413.2692086568595;5424.511793938565;6254.843628909222;6282.811515654537;6297.622142671455;6304;6309.05364195356;6052.334243233329;6108.047853176003;6142.293636231891;6158.661273629993;6207.34822843613;6232.407921247474;6250.218722659668;6250.812475625738;6251.093591429309;6253.749850005949;6117.602355846856;6130.356312587292;6130.570860039755;6134.78528251509;6144.969275153596;5017.598592112549;5434.972825135849;6102.216595924314;6109.053096770008;6206.410391012847;5009.7244651544515;5973.044312909914;6009.308929472992;6017.879642407215;6019.909701354396;5958.1658567801405;6032.095185722177;6033.54748393881;6043.244594425697;6123.663198524124;5891.116332550152;5896.528277737856;5905.40945905406;5933.2880054393745;5949.167116603766;6056.3035250946705;6056.727447264796;6056.878862422815;6062.484688801501;6066.696665166813;5745.885082298414;5836.766529338779;5862.560307976833;5901.616394934315;5932.970335148297 19:01:11 INFO - 2015-11-23 19:01:11,251 DEBUG : BROWSER_OUTPUT: |1;ext.html;502.95976321894244;555.8249151517269;618.536097926555;629.9133993860589;633.3571425003622;32058.198545036357;32336.838315808418;32353;32465.51301730476;40415.59584404162;34081.82959085201;43776;44135.77932110335;44272;44442;9675.371100878438;9826.656067037655;9854.90145098547;9878.160356369717;9880.456574888378;8760.780980475476;8915.777105572348;8931.41945773526;8933.419327743675;9630.951845240765;8753.649854005833;8842.115788421139;11952.282863028246;12055.156139070268;12078.637640870744;11779.646610601696;11830.349330786761;11839.940800295943;11847.289162650268;11864.52541898323;8812.339074569432;11696.12279079064;11813.527458901634;11814.822777658343;11843.111766617538;31926.882559110552;32129.51805722916;42648.57351426508;42818.78590607058;42893.785531072455;3244.8053116813066;3247.5291082792864;3418.8119653419053;3681.318955993123;3760.567534733486;23340.183093591644;28455.57316640252;28548.286292842637;29273.41453170946;29641.70358296411;2735.548634475329;2737.86310684465;2851.7718582513558;2878.7553057990094;2951.704829517031;454651.4534854642;455595;456644;605782;621368.8931555358;58504;58993.705031474565;59116.40883591195;59327.81344373088;74219.25780742231;72328;72570.2742972574;72649.63675181696;72700.63649681823;72766.63616681883;16035.278412471467;16378.099204543627;16382.508524744277;16397.934134281233;16424.850260481653;12481.75036499265;12541.686457838445;12545.749085018431;12562.68593285157;12590.874091259153;18770.624587508173;20774.468340382173;21715.891420543114;21754.782452175594;21778.455538611663;8964.551772411483;9152.725418237464;9162.541872906328;9182.908170918205;9240.5841737122;903.6114470777628;1006.5369929832359;1104.0670633314837;1135.1202817816259;1149.7413082056637;27178.864105679346;29295.560566591517;29508.852455737582;29654.851725741235;29791.51042447869;1095.4084794211037;1098.3849044535086;1114.0920150077661;1124.8256520239377;1206.9818952715716;15020.324085416183;15489.922550387177;15755.763663544827;15858;16181.676366472604;732647;733174;733790;734790;736498;59127.408725913054;59264.40735592675;59388.703056485305;59509.702451487465;59762.402375976555;1460.0436713952379;1467.2590341877283;1471.9558413247619;1474.6460849396283;1485.2796393749022;28135.57796633011;29644.55533167047;29676.851615741783;30077.183185056532;30373.936912207966;41913.95215119524;51270.48729512657;51823.222651659504;51832.96334073373;51849.74075129751;452960.7351963219;456022;456748;456904;456914.4308556872;28251.57622635621;28943.710562894943;30093.849530752206;34685.959421217405;34991.62604674415;40288.3956740655;40874.79562602168;41072.589274108075;41314.79342603268;41481.58518414898;34583.65416345804;35199.29601407906;35688.929332120075;36223.818880905426;36229.09427264339;30605.846970765004;31095.533566996965;36227.63772362243;36777.63222367849;37884.43173352457;35242.82378588091;35754.64245357513;35765.46351804673;35773.747918822715;37444.43833342556;23590.52818943646;31513.684863151993;32200;32439.513407298437;32516.34967300688;24414.87792561097;24689.753102469465;24905.128320508695;25122.37194070163;25239.369015774017 19:01:11 INFO - 2015-11-23 19:01:11,253 DEBUG : BROWSER_OUTPUT: |2;jquery.html;363.5964079871342;363.6799616337621;365.2785748147411;367.5497515543458;369.59344720807115;14402;15819.683606327895;19798.802011979875;20364;21089.47276318093;18267.543311417223;18522.814771852278;18550.165242564082;18590.16344264508;19034.714479282822;4013.6387725104737;5226.608004399675;5387.4612538746005;5389.973050134744;5418.647787893794;4118.814653340607;4147.854825081123;5771.192033115367;5943.435373639497;5986.132010858423;5821.8647363764085;5877.941220587803;5919.200907877446;5920.289565252176;5956.672383018932;5893.145493903381;5922.733476993524;5924.289085309747;5934.762609495615;5936.64380137191;5343.251944727741;5496.1755736639425;5496.367917689477;5653.2085508028495;5675.262215911905;12880.42038108278;12909.67725806853;12920.22478651284;16917.90033647809;24062.27813165608;1979.0797279265066;2059.0939986406083;2104.053176070759;2105.620988222119;2170.9891450542646;9627.807443851154;9669.564869580885;9944.602215911355;9959.103680668703;12244.632661020183;1708.5728567858037;1729.7145970914785;1735.9305627774875;1741.8519425848817;1783.1530023238988;96457;96968;99751;100228.49657255146;100572.49713751384;10745.032947034648;11017.063549598373;11019.118470522339;11122.99893009633;11133.777324453466;13271.469141234436;13297.468101276034;13302.068855180045;13317.600471985663;13332.866671333162;7662.8084297893;7697.153313135551;7700.576468294297;7717.922820771721;7815.140334563193;6527.249366322839;7004.719811207495;7337.853242935112;7397.408207343399;7404.2595740426605;3992.161646054303;4148.398482220061;4288.807003684841;4356.520782713899;4375.949772054748;1733.5406117378905;1764.4706588023541;1767.0369648541575;1767.7525146479504;1768.6639538487645;898.9886377824947;926.5737760630186;1042.3381152967768;1082.1937656445841;1082.437132691012;19564.21743130259;19915.203391864452;19962.500937476678;20089.598208035757;20411.591768164555;758.3250906693048;917.1241464401614;941.317544780029;952.8708480450688;968.3899143539666;10915.181361397927;11405.201635885409;11683.824742628867;11708.824367634492;11717.12121590884;736091;736690.6330936729;740127;760150;762468;116229;117735.41132294283;118429.8157018436;120386;122650.38674806747;1233.4018001269378;1244.0980289290192;1247.3015111537568;1250.2685928731612;1258.2576279994664;18222.623859224193;18570.721439178153;18645.90677046606;18693.065346732335;18796;51517.227241590655;52273.47726522838;52302.21546676879;52418;52484;57358;65869.34130658633;66458;72669.63665181852;72872;8330.416870818985;9472.905270947478;9846.606135754777;9877.753056173653;9884.11043006133;15397.384104635688;16356.427525036566;19154.23383064662;19271.1327990238;19966.60066798627;10042.949785251027;14918.55244342628;15826;15883.602909926882;16001;12413.923968461046;15084.321205545997;15433.151176685391;15696.529104126894;15735.842641573438;12574.559890403792;15833.52499425019;15882.841171588136;16250.593735156242;16490.093044882648;8074.313683336982;9429.292803039662;9690;9758.658446954323;9782.657606983721;10046.196304295492;10586.101518050076;14565.41738330455;14747.410103595736;15130.54608361751 19:01:11 INFO - 2015-11-23 19:01:11,254 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1583.5566041508375;1587.7062743392466;1707.9487615371543;1905.6665083610364;1930.835878950289;7432.331090201881;7589.582572958485;8430.494170349775;8563.272121869633;8605.440646357998;7332.816679583013;8305.833883322344;8401.327893768499;8412.11672774359;8420.705275315366;2096.2243969731144;2144.3352560706153;2373.64395340699;2388.235764555343;2398.0168131066266;2196.3191410662744;2367.562001029806;2389.3309873235435;2392.2583998960376;2392.3301475586863;2333.94165145871;2353.211674089182;2363.3028256664325;2385.940351491209;2392.712874455068;2130.6697461893355;2173.7500187478327;2177.7495588007423;2351.882405879699;2382.868942208178;2369.052379048377;2400.2199285232196;2403.591389463795;2403.639454081884;2407.723111842143;8387.538685372301;8500.82998340036;8503.1921967413;8518.616662250151;8530.957345213295;5100.413452452978;5177.715225662587;5198.506141916512;5203;5215.869603259911;3444.3111377724554;3484.5992710838323;3555.7333200010103;3567.910802229965;3585.515955346047;1032.5560009196042;1041.8697662792151;1043.1706793099504;1059.2638116509029;1065.9413732244723;11161.776764464665;11163.106951443864;11164.441777911154;11174.161937854613;11175.72060698489;4557.521460246693;4623.768811559476;4690.038542098861;4711.246200607886;4724.598409135262;9630.181434578139;9647.517624118766;9648.179904708179;9663.082007209305;9673.129418352382;5218.921716174261;5221.373435187802;5223.503767142115;5225.190095535198;5228.686278823283;4095.1809638072505;4636.675432719677;4679.719216847;4736;4768.260919557474;3847.6344747249527;3848.8845334640005;3870.322693528621;3884.8834534964;3894.922101557953;1281.7244292477162;1281.7820970434861;1285.479380850757;1289.548657969703;1289.8129771183314;1365.8497565267812;1366.7881478370668;1400.0549629000384;1401.8177636907137;1408.0706733555803;6748.763793267212;7719.768406947801;7867.960660196777;7890.8816367754525;7893.210678932176;484.68495477938916;495.43767823519846;508.14885067511767;510.47676131965034;511.12342332899254;5922.2597175353085;6056.242969628796;6059.909101363483;6152.907706384408;6419.03714442828;9818.410895346302;9915.504224788876;10113.190944724405;10114.393136411838;10175.694729157989;9876.753081173028;9906.504674766233;9908.752281192883;9983.800323993624;10038.548265328078;7312.647160275366;7313.524620899624;7755.30202281786;7785.80535486606;7870.921290787019;7735.419843511647;7866.803329916798;7877.133515313197;7882.172371900868;7887.566183859713;8735.388522803343;8809.559522023745;8978.461292322481;9068.138526839939;9096.727098187064;9022.458652480873;9192;9259.583318750538;9282.535873206447;9317.16145546904;7904.802379940547;7990.720324788605;7994.92005079965;8022.713526644879;8023.959880200561;7654.5839019781515;8055.838883222185;8080.757577272691;8090.029196496458;8092.988376452943;7458.92541074604;7468.253174682488;7583.696652133853;7619.314261716472;7627.389808815171;7271.709131634675;7322.194558598443;7366.337029667141;7547.433942454228;7549.980752598329;7482.027336446227;7560.6219689016425;7614.657340419583;7614.961925190339;7615.504992175491;6821.658917054028;6888.51780375389;6894.310568943066;6902.689378978059;6915.792526224222;6342.873142537216;6973.884178531411;6975.79072627822;6992.056072430157;6995.825104372431 19:01:11 INFO - 2015-11-23 19:01:11,257 DEBUG : BROWSER_OUTPUT: |4;prototype.html;320.8892931938482;322.62575412521466;330.64951151779115;335.2490421455938;340.5419710489391;6708.865822683543;6719.160104986877;6839.110915580974;6847.486438517106;6851.965740171305;6502.902456463157;6729.7644582439625;6740.090087838153;6775.864482710343;6794.932050679492;4948.851534453954;4984.551390374865;4986.301917731521;4988.575971042465;4990.875228119308;4709.481956984729;4770.761461926907;4995.725235112068;4998;5004.973980334041;4488.8877778055485;4732.692374995631;4842.539958703917;4910.901781964359;4916.827911023097;4891.364122664067;4900.460949295574;4900.55433647075;4905.411350637946;4916.975415122937;4227.260229459832;4231.619154276099;4233.936490952638;4237.851675191384;4238.237117318881;6221.875562488724;6465.159529261213;6487.3836985486305;6487.448566871822;6496.317886621884;5913.083472061838;5914.2311499504785;5916.822495325147;5919.437653422918;5926.140709597084;7253.818654533626;7269.709211631528;7273.309035641606;7275.745348912763;7282.198958114604;3979.7612143271494;4780.37855078841;4789.377380940456;4796.592289655384;4797.112534181153;7451.21762214965;7754.728584499516;7761.45669803114;7763.340116090139;7795.4932929359975;4595.149897268949;4656.32483289921;4669.41632295963;4703.670743047954;4852;4094.7274262783844;4989.725565093955;4990.2764099205415;4992.775325110306;5001.7499125043605;5365.973170134124;5447.96488667152;5866.061430171152;5905.822825315247;5908;7140.500164988505;7388.187299397062;7405.33351998312;7406.407487400995;7444.702211911571;1523.8857085718394;1722.2852516205635;1737.6872163010526;1742.2160027987202;1743.3723859410602;1095.9971625962155;1110.2062025651699;1113.2930589075995;1122.0350498571222;1136.2727854173336;6539.574927629689;6852.109225800614;6854.006169105552;6866.588004719732;6876.896846547305;6181.721822517998;7650;7663.961680191564;7664.923350766532;7666.310032097138;6673.332666733385;6818.522703410813;6832.80425925471;6852.725890964405;6954.165500139914;4070.1859628074503;4098.077932465171;4107.096438783463;4116.403121547419;4126.546079931205;8003.639836207385;8007.719729809545;8011.879821802678;8015.158408367154;8021.679132834738;7710.961445192738;7979.960100199578;7993.040835099825;8004.199580041949;8040.839183216303;7960.323372513401;7969.1632378601735;7973.44185906981;7976.122626511079;7981.281684648409;7538.736144235145;7674.040744906887;7755.844883102419;7765.223477652416;7774.339181169437;6195.256569211723;6196.411340922605;7600.049993750781;7604.96197519031;7613.314801667876;7598.278163574451;7792.220777922163;7958.522488650699;7959.641816118405;7965.01312007997;3910.416281406035;4473.038296766211;4556.202664533627;4597.264437689953;4658.976705116453;7311.488195826241;7587.582682952269;7606;7616.428767842323;7636.579988100486;7308.96345518269;7315.853682926205;7316.122065352191;7324.377427918686;7331.670074846538;7086.964565177141;7261.564306141649;7279;7300.23347548521;7300.96349518249;7077.221505634273;7193.208747037717;7202.099737532809;7208.495405321787;7212.4230061596;7170.1754298256365;7379.298966598165;7387.409007279297;7391.4086873048955;7401.037865077506;7177.533460325062;7212.134543854561;7231.3130252625915;7241.04491787225;7259.818504537217 19:01:11 INFO - 2015-11-23 19:01:11,258 DEBUG : BROWSER_OUTPUT: |5;yui.html;722.7073035420655;724.9093863267088;769.3037800790287;813.6582635293177;821.9794505137367;14777.26113694315;15263.847361526381;15291.847081529182;15296.082235065876;15326.540203793904;14242.430302787876;14420.639484012905;14450.783238251408;14454.927725361385;14458.132512049284;761.6153842309626;773.1032002876664;774.1832366852968;778.2451022508172;962.3504134709078;950.5959967014026;959.6113574002541;969.5733877094056;970.5777986575827;972.470003847901;1003.0821798054772;1025.9846102308472;1029.2332212501697;1029.8455231715227;1032.0505135275564;803;817.382875928673;1014.7209517382779;1018.3940555369543;1021.6577446555413;755.041097805789;759.4797563668905;762.0626629246003;765.165969093685;766.0118447203101;14944.178070206135;15194.772078418833;15221.31504082308;15223.467178648805;15233.923830380889;12448.502059917593;12750.29873356965;12888.291143987077;13166.86833131666;13336.266505342202;10076.768725479365;10319.122874555671;11003.17476189281;11397.316161030365;11724.413779311086;3455.6026057003514;3523.577170739502;3564.500969864221;3704.7036237100965;3728.3475391806323;71098.64450677765;71740.64129679318;72126.27873721249;72165;72218.27781722168;9356.062863841278;9430.481323527272;9446.008169142278;9448.338616296793;9518.857217141749;20825;20982.265620703507;20991.685124723143;21007.264745733824;21029.84335861512;7027.683754231072;7117.82205444868;7173.067501224912;7196.892046619305;7347.118345798538;3986.421968814506;3995.760254384746;4004.619561141687;4014.157027024299;4038.51537815464;3552.4138517144897;3597.892063238107;3598.9100272493397;3600.945985810215;3602.225521512887;640.8750293692685;646.5829539946802;650.1905128115432;650.3431534150542;655.0240142188105;518.5669965578709;525.6530689744826;530.8805518758248;560.8990381731328;609.597665540741;9202.35583509148;9383.5308234588;9400.106989835955;9498.525073746285;9548.761280968032;616.2851092732409;622.7726879688971;635.463033736492;644.7711062572719;645.7675236914707;4020.9396859047138;4073.103917138284;4087.9386809197886;4141.275276826544;4162.375643653476;100252;102062;102065;102318.48840755748;102941;76829.6158519215;76845.46309073787;85034.14965850262;85144.14855851486;87374.56312718523;73851.26148738552;73887.99999999892;73939;74534.25465745381;75729.62135189289;8386.287165590993;8504.022037465771;8589.699360522352;8700.695475658575;9020.59407326685;53256.402307930824;54061.459385405644;54182.18726719024;54888;55928.440715592325;53476.245944337075;67428;73058.63470682612;75132.2380985714;79071;10609.20430967696;11065.721911100169;11219.158563107636;11340.94329528347;11439.485223164811;11926.403679816149;12115.515379384726;12144.332061736335;12220.816687749868;12234.87765122373;11536.365499897585;11703.707407314885;11786;11889.821652675044;11893.226940248856;11815.645530634094;11828.704282392664;11907.82138267944;12146.757064858477;12159.270443773403;11229.38238396896;11275.943620281847;11669.533218671158;11793.823092653789;11915.821262680893;9679.806403871742;9781.217502599917;9813.55838987233;10140.29017968735;10210.438425886647;9734.75663108428;9977.10206081456;9991.750206244902;10002.749931251778;10008.499575021366 19:01:11 INFO - 2015-11-23 19:01:11,259 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:01:11 INFO - 2015-11-23 19:01:11,259 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:01:11 INFO - 2015-11-23 19:01:11,259 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1607 19:01:11 INFO - 2015-11-23 19:01:11,259 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:01:11 INFO - 2015-11-23 19:01:11,259 DEBUG : BROWSER_OUTPUT: __startTimestamp1448334071245__endTimestamp 19:01:11 INFO - 2015-11-23 19:01:11,259 DEBUG : BROWSER_OUTPUT: 19:01:11 INFO - 2015-11-23 19:01:11,259 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:01:11 INFO - 2015-11-23 19:01:11,259 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:01:11 INFO - 2015-11-23 19:01:11,259 DEBUG : BROWSER_OUTPUT: 19:01:11 INFO - 2015-11-23 19:01:11,259 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5668.73 Median:5896.53 stddev:646.53 (11.0%) stddev-sans-first:616.64 19:01:11 INFO - 2015-11-23 19:01:11,261 DEBUG : BROWSER_OUTPUT: Values: 3113.1 3409.4 3442.0 3448.3 3466.7 5457.4 5577.1 5668.9 5669.2 5698.3 5569.5 5619.5 5643.5 5802.6 5831.2 5055.3 5069.5 5091.4 5128.2 5194.8 5235.4 5239.4 5247.6 5272.5 5298.5 3794.3 5015.5 5087.6 5092.8 5172.5 5092.3 5098.3 5113.5 5114.2 5115.2 5031.8 5107.5 5132.5 5164.9 5185.7 5496.7 5524.6 5543.1 5548.8 5558.5 6169.1 6175.8 6176.2 6183.3 6185.5 6085.0 6116.9 6169.0 6186.7 6202.7 5730.9 5735.3 5767.0 5770.0 5785.8 6144.1 6145.4 6178.5 6225.8 6300.9 6136.6 6148.7 6152.8 6158.9 6162.8 6212.2 6231.1 6234.8 6235.9 6241.4 5996.5 6031.9 6101.9 6133.7 6188.5 6181.1 6195.4 6199.5 6206.1 6208.6 4906.1 4912.1 4921.4 4927.9 4967.3 4288.5 4307.8 4439.8 4447.8 4459.4 5648.9 5671.1 5680.3 5680.5 5773.6 6191.5 6205.3 6211.8 6214.0 6218.3 5488.7 5579.8 5606.4 5616.2 5660.6 5390.8 5391.8 5403.9 5413.3 5424.5 6254.8 6282.8 6297.6 6304.0 6309.1 6052.3 6108.0 6142.3 6158.7 6207.3 6232.4 6250.2 6250.8 6251.1 6253.7 6117.6 6130.4 6130.6 6134.8 6145.0 5017.6 5435.0 6102.2 6109.1 6206.4 5009.7 5973.0 6009.3 6017.9 6019.9 5958.2 6032.1 6033.5 6043.2 6123.7 5891.1 5896.5 5905.4 5933.3 5949.2 6056.3 6056.7 6056.9 6062.5 6066.7 5745.9 5836.8 5862.6 5901.6 5933.0 19:01:11 INFO - 2015-11-23 19:01:11,261 DEBUG : BROWSER_OUTPUT: 19:01:11 INFO - 2015-11-23 19:01:11,261 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:70149.39 Median:19001.23 stddev:156499.60 (823.6%) stddev-sans-first:156851.26 19:01:11 INFO - 2015-11-23 19:01:11,261 DEBUG : BROWSER_OUTPUT: Values: 503.0 555.8 618.5 629.9 633.4 32058.2 32336.8 32353.0 32465.5 40415.6 34081.8 43776.0 44135.8 44272.0 44442.0 9675.4 9826.7 9854.9 9878.2 9880.5 8760.8 8915.8 8931.4 8933.4 9631.0 8753.6 8842.1 11952.3 12055.2 12078.6 11779.6 11830.3 11839.9 11847.3 11864.5 8812.3 11696.1 11813.5 11814.8 11843.1 31926.9 32129.5 42648.6 42818.8 42893.8 3244.8 3247.5 3418.8 3681.3 3760.6 23340.2 28455.6 28548.3 29273.4 29641.7 2735.5 2737.9 2851.8 2878.8 2951.7 454651.5 455595.0 456644.0 605782.0 621368.9 58504.0 58993.7 59116.4 59327.8 74219.3 72328.0 72570.3 72649.6 72700.6 72766.6 16035.3 16378.1 16382.5 16397.9 16424.9 12481.8 12541.7 12545.7 12562.7 12590.9 18770.6 20774.5 21715.9 21754.8 21778.5 8964.6 9152.7 9162.5 9182.9 9240.6 903.6 1006.5 1104.1 1135.1 1149.7 27178.9 29295.6 29508.9 29654.9 29791.5 1095.4 1098.4 1114.1 1124.8 1207.0 15020.3 15489.9 15755.8 15858.0 16181.7 732647.0 733174.0 733790.0 734790.0 736498.0 59127.4 59264.4 59388.7 59509.7 59762.4 1460.0 1467.3 1472.0 1474.6 1485.3 28135.6 29644.6 29676.9 30077.2 30373.9 41914.0 51270.5 51823.2 51833.0 51849.7 452960.7 456022.0 456748.0 456904.0 456914.4 28251.6 28943.7 30093.8 34686.0 34991.6 40288.4 40874.8 41072.6 41314.8 41481.6 34583.7 35199.3 35688.9 36223.8 36229.1 30605.8 31095.5 36227.6 36777.6 37884.4 35242.8 35754.6 35765.5 35773.7 37444.4 23590.5 31513.7 32200.0 32439.5 32516.3 24414.9 24689.8 24905.1 25122.4 25239.4 19:01:11 INFO - 2015-11-23 19:01:11,262 DEBUG : BROWSER_OUTPUT: 19:01:11 INFO - 2015-11-23 19:01:11,262 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38117.69 Median:2081.57 stddev:122940.90 (5906.2%) stddev-sans-first:123253.10 19:01:11 INFO - 2015-11-23 19:01:11,263 DEBUG : BROWSER_OUTPUT: Values: 363.6 363.7 365.3 367.5 369.6 14402.0 15819.7 19798.8 20364.0 21089.5 18267.5 18522.8 18550.2 18590.2 19034.7 4013.6 5226.6 5387.5 5390.0 5418.6 4118.8 4147.9 5771.2 5943.4 5986.1 5821.9 5877.9 5919.2 5920.3 5956.7 5893.1 5922.7 5924.3 5934.8 5936.6 5343.3 5496.2 5496.4 5653.2 5675.3 12880.4 12909.7 12920.2 16917.9 24062.3 1979.1 2059.1 2104.1 2105.6 2171.0 9627.8 9669.6 9944.6 9959.1 12244.6 1708.6 1729.7 1735.9 1741.9 1783.2 96457.0 96968.0 99751.0 100228.5 100572.5 10745.0 11017.1 11019.1 11123.0 11133.8 13271.5 13297.5 13302.1 13317.6 13332.9 7662.8 7697.2 7700.6 7717.9 7815.1 6527.2 7004.7 7337.9 7397.4 7404.3 3992.2 4148.4 4288.8 4356.5 4375.9 1733.5 1764.5 1767.0 1767.8 1768.7 899.0 926.6 1042.3 1082.2 1082.4 19564.2 19915.2 19962.5 20089.6 20411.6 758.3 917.1 941.3 952.9 968.4 10915.2 11405.2 11683.8 11708.8 11717.1 736091.0 736690.6 740127.0 760150.0 762468.0 116229.0 117735.4 118429.8 120386.0 122650.4 1233.4 1244.1 1247.3 1250.3 1258.3 18222.6 18570.7 18645.9 18693.1 18796.0 51517.2 52273.5 52302.2 52418.0 52484.0 57358.0 65869.3 66458.0 72669.6 72872.0 8330.4 9472.9 9846.6 9877.8 9884.1 15397.4 16356.4 19154.2 19271.1 19966.6 10042.9 14918.6 15826.0 15883.6 16001.0 12413.9 15084.3 15433.2 15696.5 15735.8 12574.6 15833.5 15882.8 16250.6 16490.1 8074.3 9429.3 9690.0 9758.7 9782.7 10046.2 10586.1 14565.4 14747.4 15130.5 19:01:11 INFO - 2015-11-23 19:01:11,263 DEBUG : BROWSER_OUTPUT: 19:01:11 INFO - 2015-11-23 19:01:11,263 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5828.97 Median:6058.08 stddev:3039.49 (50.2%) stddev-sans-first:3031.27 19:01:11 INFO - 2015-11-23 19:01:11,264 DEBUG : BROWSER_OUTPUT: Values: 1583.6 1587.7 1707.9 1905.7 1930.8 7432.3 7589.6 8430.5 8563.3 8605.4 7332.8 8305.8 8401.3 8412.1 8420.7 2096.2 2144.3 2373.6 2388.2 2398.0 2196.3 2367.6 2389.3 2392.3 2392.3 2333.9 2353.2 2363.3 2385.9 2392.7 2130.7 2173.8 2177.7 2351.9 2382.9 2369.1 2400.2 2403.6 2403.6 2407.7 8387.5 8500.8 8503.2 8518.6 8531.0 5100.4 5177.7 5198.5 5203.0 5215.9 3444.3 3484.6 3555.7 3567.9 3585.5 1032.6 1041.9 1043.2 1059.3 1065.9 11161.8 11163.1 11164.4 11174.2 11175.7 4557.5 4623.8 4690.0 4711.2 4724.6 9630.2 9647.5 9648.2 9663.1 9673.1 5218.9 5221.4 5223.5 5225.2 5228.7 4095.2 4636.7 4679.7 4736.0 4768.3 3847.6 3848.9 3870.3 3884.9 3894.9 1281.7 1281.8 1285.5 1289.5 1289.8 1365.8 1366.8 1400.1 1401.8 1408.1 6748.8 7719.8 7868.0 7890.9 7893.2 484.7 495.4 508.1 510.5 511.1 5922.3 6056.2 6059.9 6152.9 6419.0 9818.4 9915.5 10113.2 10114.4 10175.7 9876.8 9906.5 9908.8 9983.8 10038.5 7312.6 7313.5 7755.3 7785.8 7870.9 7735.4 7866.8 7877.1 7882.2 7887.6 8735.4 8809.6 8978.5 9068.1 9096.7 9022.5 9192.0 9259.6 9282.5 9317.2 7904.8 7990.7 7994.9 8022.7 8024.0 7654.6 8055.8 8080.8 8090.0 8093.0 7458.9 7468.3 7583.7 7619.3 7627.4 7271.7 7322.2 7366.3 7547.4 7550.0 7482.0 7560.6 7614.7 7615.0 7615.5 6821.7 6888.5 6894.3 6902.7 6915.8 6342.9 6973.9 6975.8 6992.1 6995.8 19:01:11 INFO - 2015-11-23 19:01:11,264 DEBUG : BROWSER_OUTPUT: 19:01:11 INFO - 2015-11-23 19:01:11,265 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5968.83 Median:6785.40 stddev:1945.68 (28.7%) stddev-sans-first:1904.39 19:01:11 INFO - 2015-11-23 19:01:11,266 DEBUG : BROWSER_OUTPUT: Values: 320.9 322.6 330.6 335.2 340.5 6708.9 6719.2 6839.1 6847.5 6852.0 6502.9 6729.8 6740.1 6775.9 6794.9 4948.9 4984.6 4986.3 4988.6 4990.9 4709.5 4770.8 4995.7 4998.0 5005.0 4488.9 4732.7 4842.5 4910.9 4916.8 4891.4 4900.5 4900.6 4905.4 4917.0 4227.3 4231.6 4233.9 4237.9 4238.2 6221.9 6465.2 6487.4 6487.4 6496.3 5913.1 5914.2 5916.8 5919.4 5926.1 7253.8 7269.7 7273.3 7275.7 7282.2 3979.8 4780.4 4789.4 4796.6 4797.1 7451.2 7754.7 7761.5 7763.3 7795.5 4595.1 4656.3 4669.4 4703.7 4852.0 4094.7 4989.7 4990.3 4992.8 5001.7 5366.0 5448.0 5866.1 5905.8 5908.0 7140.5 7388.2 7405.3 7406.4 7444.7 1523.9 1722.3 1737.7 1742.2 1743.4 1096.0 1110.2 1113.3 1122.0 1136.3 6539.6 6852.1 6854.0 6866.6 6876.9 6181.7 7650.0 7664.0 7664.9 7666.3 6673.3 6818.5 6832.8 6852.7 6954.2 4070.2 4098.1 4107.1 4116.4 4126.5 8003.6 8007.7 8011.9 8015.2 8021.7 7711.0 7980.0 7993.0 8004.2 8040.8 7960.3 7969.2 7973.4 7976.1 7981.3 7538.7 7674.0 7755.8 7765.2 7774.3 6195.3 6196.4 7600.0 7605.0 7613.3 7598.3 7792.2 7958.5 7959.6 7965.0 3910.4 4473.0 4556.2 4597.3 4659.0 7311.5 7587.6 7606.0 7616.4 7636.6 7309.0 7315.9 7316.1 7324.4 7331.7 7087.0 7261.6 7279.0 7300.2 7301.0 7077.2 7193.2 7202.1 7208.5 7212.4 7170.2 7379.3 7387.4 7391.4 7401.0 7177.5 7212.1 7231.3 7241.0 7259.8 19:01:11 INFO - 2015-11-23 19:01:11,266 DEBUG : BROWSER_OUTPUT: 19:01:11 INFO - 2015-11-23 19:01:11,266 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18876.83 Median:4151.83 stddev:26734.90 (643.9%) stddev-sans-first:26775.15 19:01:11 INFO - 2015-11-23 19:01:11,267 DEBUG : BROWSER_OUTPUT: Values: 722.7 724.9 769.3 813.7 822.0 14777.3 15263.8 15291.8 15296.1 15326.5 14242.4 14420.6 14450.8 14454.9 14458.1 761.6 773.1 774.2 778.2 962.4 950.6 959.6 969.6 970.6 972.5 1003.1 1026.0 1029.2 1029.8 1032.1 803.0 817.4 1014.7 1018.4 1021.7 755.0 759.5 762.1 765.2 766.0 14944.2 15194.8 15221.3 15223.5 15233.9 12448.5 12750.3 12888.3 13166.9 13336.3 10076.8 10319.1 11003.2 11397.3 11724.4 3455.6 3523.6 3564.5 3704.7 3728.3 71098.6 71740.6 72126.3 72165.0 72218.3 9356.1 9430.5 9446.0 9448.3 9518.9 20825.0 20982.3 20991.7 21007.3 21029.8 7027.7 7117.8 7173.1 7196.9 7347.1 3986.4 3995.8 4004.6 4014.2 4038.5 3552.4 3597.9 3598.9 3600.9 3602.2 640.9 646.6 650.2 650.3 655.0 518.6 525.7 530.9 560.9 609.6 9202.4 9383.5 9400.1 9498.5 9548.8 616.3 622.8 635.5 644.8 645.8 4020.9 4073.1 4087.9 4141.3 4162.4 100252.0 102062.0 102065.0 102318.5 102941.0 76829.6 76845.5 85034.1 85144.1 87374.6 73851.3 73888.0 73939.0 74534.3 75729.6 8386.3 8504.0 8589.7 8700.7 9020.6 53256.4 54061.5 54182.2 54888.0 55928.4 53476.2 67428.0 73058.6 75132.2 79071.0 10609.2 11065.7 11219.2 11340.9 11439.5 11926.4 12115.5 12144.3 12220.8 12234.9 11536.4 11703.7 11786.0 11889.8 11893.2 11815.6 11828.7 11907.8 12146.8 12159.3 11229.4 11275.9 11669.5 11793.8 11915.8 9679.8 9781.2 9813.6 10140.3 10210.4 9734.8 9977.1 9991.8 10002.7 10008.5 19:01:11 INFO - 2015-11-23 19:01:11,267 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:01:11 INFO - 2015-11-23 19:01:11,267 DEBUG : BROWSER_OUTPUT: 19:01:11 INFO - 2015-11-23 19:01:11,677 INFO : Browser exited with error code: 0 19:01:11 INFO - 2015-11-23 19:01:11,698 INFO : Completed test dromaeo_css (00:18:33) 19:01:11 INFO - 2015-11-23 19:01:11,698 INFO : Starting test kraken 19:01:11 INFO - 2015-11-23 19:01:11,698 DEBUG : operating with platform_type : mac_ 19:01:11 INFO - 2015-11-23 19:01:11,698 INFO : Initialising browser for kraken test... 19:01:11 INFO - 2015-11-23 19:01:11,709 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpzPhI28/profile http://localhost:49378/getInfo.html 19:01:13 INFO - 2015-11-23 19:01:13,710 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:01:13 INFO - 2015-11-23 19:01:13,710 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:01:13 INFO - 2015-11-23 19:01:13,710 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:01:13 INFO - 2015-11-23 19:01:13,710 DEBUG : BROWSER_OUTPUT: __metrics 19:01:13 INFO - 2015-11-23 19:01:13,726 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:01:14 INFO - 2015-11-23 19:01:14,540 INFO : Browser initialized. 19:01:14 INFO - 2015-11-23 19:01:14,541 INFO : Running cycle 1/1 for kraken test... 19:01:14 INFO - 2015-11-23 19:01:14,541 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpzPhI28/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:01:26 INFO - 2015-11-23 19:01:26,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 224886784 19:01:26 INFO - 2015-11-23 19:01:26,373 DEBUG : BROWSER_OUTPUT: 19:01:29 INFO - 2015-11-23 19:01:29,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49378/tests/kraken/driver.html?testName=audio-beat-detection) 19:01:29 INFO - 2015-11-23 19:01:29,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 275456000 19:01:29 INFO - 2015-11-23 19:01:29,642 DEBUG : BROWSER_OUTPUT: 19:01:32 INFO - 2015-11-23 19:01:32,167 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49378/tests/kraken/driver.html?testName=audio-dft) 19:01:32 INFO - 2015-11-23 19:01:32,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 288550912 19:01:32 INFO - 2015-11-23 19:01:32,757 DEBUG : BROWSER_OUTPUT: 19:01:35 INFO - 2015-11-23 19:01:35,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49378/tests/kraken/driver.html?testName=audio-fft) 19:01:36 INFO - 2015-11-23 19:01:36,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 276410368 19:01:36 INFO - 2015-11-23 19:01:36,526 DEBUG : BROWSER_OUTPUT: 19:01:38 INFO - 2015-11-23 19:01:38,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49378/tests/kraken/driver.html?testName=audio-oscillator) 19:01:38 INFO - 2015-11-23 19:01:38,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 277741568 19:01:38 INFO - 2015-11-23 19:01:38,977 DEBUG : BROWSER_OUTPUT: 19:01:40 INFO - 2015-11-23 19:01:40,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49378/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:01:41 INFO - 2015-11-23 19:01:41,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 279109632 19:01:41 INFO - 2015-11-23 19:01:41,529 DEBUG : BROWSER_OUTPUT: 19:01:44 INFO - 2015-11-23 19:01:44,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49378/tests/kraken/driver.html?testName=imaging-darkroom) 19:01:44 INFO - 2015-11-23 19:01:44,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 280760320 19:01:44 INFO - 2015-11-23 19:01:44,793 DEBUG : BROWSER_OUTPUT: 19:01:47 INFO - 2015-11-23 19:01:47,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49378/tests/kraken/driver.html?testName=imaging-desaturate) 19:01:48 INFO - 2015-11-23 19:01:48,154 DEBUG : BROWSER_OUTPUT: RSS: Main: 280723456 19:01:48 INFO - 2015-11-23 19:01:48,155 DEBUG : BROWSER_OUTPUT: 19:01:50 INFO - 2015-11-23 19:01:50,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49378/tests/kraken/driver.html?testName=json-parse-financial) 19:01:51 INFO - 2015-11-23 19:01:51,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 281423872 19:01:51 INFO - 2015-11-23 19:01:51,415 DEBUG : BROWSER_OUTPUT: 19:01:52 INFO - 2015-11-23 19:01:52,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49378/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:01:53 INFO - 2015-11-23 19:01:53,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 314994688 19:01:53 INFO - 2015-11-23 19:01:53,499 DEBUG : BROWSER_OUTPUT: 19:01:55 INFO - 2015-11-23 19:01:55,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49378/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:01:55 INFO - 2015-11-23 19:01:55,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 315170816 19:01:55 INFO - 2015-11-23 19:01:55,874 DEBUG : BROWSER_OUTPUT: 19:01:57 INFO - 2015-11-23 19:01:57,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49378/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:01:58 INFO - 2015-11-23 19:01:58,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 322670592 19:01:58 INFO - 2015-11-23 19:01:58,496 DEBUG : BROWSER_OUTPUT: 19:02:01 INFO - 2015-11-23 19:02:01,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:02:01 INFO - 2015-11-23 19:02:01,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 323362816 19:02:01 INFO - 2015-11-23 19:02:01,614 DEBUG : BROWSER_OUTPUT: 19:02:04 INFO - 2015-11-23 19:02:04,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:02:04 INFO - 2015-11-23 19:02:04,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 323317760 19:02:04 INFO - 2015-11-23 19:02:04,678 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49378/tests/kraken/driver.html?testName=ai-astar) 19:02:06 INFO - 2015-11-23 19:02:06,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 382468096 19:02:06 INFO - 2015-11-23 19:02:06,594 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,595 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:02:06 INFO - 2015-11-23 19:02:06,595 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:02:06 INFO - 2015-11-23 19:02:06,595 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:02:06 INFO - 2015-11-23 19:02:06,595 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:02:06 INFO - 2015-11-23 19:02:06,595 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;105;108;109;113;77;147;158;141 19:02:06 INFO - 2015-11-23 19:02:06,596 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;120;141;155;116;141;141;117;161;117 19:02:06 INFO - 2015-11-23 19:02:06,596 DEBUG : BROWSER_OUTPUT: |2;audio-dft;184;182;181;182;185;183;183;184;183;180 19:02:06 INFO - 2015-11-23 19:02:06,596 DEBUG : BROWSER_OUTPUT: |3;audio-fft;68;66;80;73;55;57;57;76;74;58 19:02:06 INFO - 2015-11-23 19:02:06,596 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;85;86;114;74;75;77;102;76;73;97 19:02:06 INFO - 2015-11-23 19:02:06,596 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;86;87;86;86;85;87;86;86;88;87 19:02:06 INFO - 2015-11-23 19:02:06,596 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;94;94;93;94;93;93;93;93;94;93 19:02:06 INFO - 2015-11-23 19:02:06,596 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;84;85;85;86;84;84;85;85;84;84 19:02:06 INFO - 2015-11-23 19:02:06,596 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;53;55;54;53;54;54;55;63;53;52 19:02:06 INFO - 2015-11-23 19:02:06,596 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;64;63;63;65;66;67;67;67;67 19:02:06 INFO - 2015-11-23 19:02:06,596 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;81;80;80;82;83;82;81;84 19:02:06 INFO - 2015-11-23 19:02:06,596 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;120;138;119;123;122;118;125;119;119 19:02:06 INFO - 2015-11-23 19:02:06,596 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;126;136;140;135;128;136;137;135;156 19:02:06 INFO - 2015-11-23 19:02:06,596 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;55;61;81;70;64;63;63;65;63;64 19:02:06 INFO - 2015-11-23 19:02:06,596 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:02:06 INFO - 2015-11-23 19:02:06,597 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:02:06 INFO - 2015-11-23 19:02:06,597 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1055 19:02:06 INFO - 2015-11-23 19:02:06,597 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:02:06 INFO - 2015-11-23 19:02:06,597 DEBUG : BROWSER_OUTPUT: __startTimestamp1448334126594__endTimestamp 19:02:06 INFO - 2015-11-23 19:02:06,597 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,599 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:02:06 INFO - 2015-11-23 19:02:06,599 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:02:06 INFO - 2015-11-23 19:02:06,599 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,599 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:117.70 Median:127.00 stddev:23.97 (18.9%) stddev-sans-first:25.21 19:02:06 INFO - 2015-11-23 19:02:06,599 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 105.0 108.0 109.0 113.0 77.0 147.0 158.0 141.0 19:02:06 INFO - 2015-11-23 19:02:06,599 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,599 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:135.50 Median:141.00 stddev:16.79 (11.9%) stddev-sans-first:17.37 19:02:06 INFO - 2015-11-23 19:02:06,599 DEBUG : BROWSER_OUTPUT: Values: 146.0 120.0 141.0 155.0 116.0 141.0 141.0 117.0 161.0 117.0 19:02:06 INFO - 2015-11-23 19:02:06,599 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,600 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.49 (0.8%) stddev-sans-first:1.51 19:02:06 INFO - 2015-11-23 19:02:06,600 DEBUG : BROWSER_OUTPUT: Values: 184.0 182.0 181.0 182.0 185.0 183.0 183.0 184.0 183.0 180.0 19:02:06 INFO - 2015-11-23 19:02:06,600 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,600 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:66.40 Median:70.50 stddev:9.18 (13.0%) stddev-sans-first:9.72 19:02:06 INFO - 2015-11-23 19:02:06,600 DEBUG : BROWSER_OUTPUT: Values: 68.0 66.0 80.0 73.0 55.0 57.0 57.0 76.0 74.0 58.0 19:02:06 INFO - 2015-11-23 19:02:06,600 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,600 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:85.90 Median:76.50 stddev:14.05 (18.4%) stddev-sans-first:14.90 19:02:06 INFO - 2015-11-23 19:02:06,600 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 114.0 74.0 75.0 77.0 102.0 76.0 73.0 97.0 19:02:06 INFO - 2015-11-23 19:02:06,600 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,601 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:86.50 stddev:0.84 (1.0%) stddev-sans-first:0.88 19:02:06 INFO - 2015-11-23 19:02:06,602 DEBUG : BROWSER_OUTPUT: Values: 86.0 87.0 86.0 86.0 85.0 87.0 86.0 86.0 88.0 87.0 19:02:06 INFO - 2015-11-23 19:02:06,602 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,602 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 19:02:06 INFO - 2015-11-23 19:02:06,602 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 93.0 94.0 93.0 93.0 93.0 93.0 94.0 93.0 19:02:06 INFO - 2015-11-23 19:02:06,602 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,602 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 19:02:06 INFO - 2015-11-23 19:02:06,602 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 85.0 86.0 84.0 84.0 85.0 85.0 84.0 84.0 19:02:06 INFO - 2015-11-23 19:02:06,602 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,603 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.00 stddev:3.10 (5.7%) stddev-sans-first:3.23 19:02:06 INFO - 2015-11-23 19:02:06,603 DEBUG : BROWSER_OUTPUT: Values: 53.0 55.0 54.0 53.0 54.0 54.0 55.0 63.0 53.0 52.0 19:02:06 INFO - 2015-11-23 19:02:06,603 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,603 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:66.50 stddev:1.97 (3.0%) stddev-sans-first:1.74 19:02:06 INFO - 2015-11-23 19:02:06,603 DEBUG : BROWSER_OUTPUT: Values: 62.0 64.0 63.0 63.0 65.0 66.0 67.0 67.0 67.0 67.0 19:02:06 INFO - 2015-11-23 19:02:06,603 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,603 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:1.32 (1.6%) stddev-sans-first:1.39 19:02:06 INFO - 2015-11-23 19:02:06,603 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 81.0 80.0 80.0 82.0 83.0 82.0 81.0 84.0 19:02:06 INFO - 2015-11-23 19:02:06,603 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,603 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:122.50 stddev:5.87 (4.8%) stddev-sans-first:6.23 19:02:06 INFO - 2015-11-23 19:02:06,603 DEBUG : BROWSER_OUTPUT: Values: 123.0 120.0 138.0 119.0 123.0 122.0 118.0 125.0 119.0 119.0 19:02:06 INFO - 2015-11-23 19:02:06,603 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,603 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.60 Median:136.50 stddev:8.03 (5.9%) stddev-sans-first:8.52 19:02:06 INFO - 2015-11-23 19:02:06,604 DEBUG : BROWSER_OUTPUT: Values: 137.0 126.0 136.0 140.0 135.0 128.0 136.0 137.0 135.0 156.0 19:02:06 INFO - 2015-11-23 19:02:06,604 DEBUG : BROWSER_OUTPUT: 19:02:06 INFO - 2015-11-23 19:02:06,604 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.00 stddev:6.76 (10.6%) stddev-sans-first:6.14 19:02:06 INFO - 2015-11-23 19:02:06,604 DEBUG : BROWSER_OUTPUT: Values: 55.0 61.0 81.0 70.0 64.0 63.0 63.0 65.0 63.0 64.0 19:02:06 INFO - 2015-11-23 19:02:06,604 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:02:06 INFO - 2015-11-23 19:02:06,604 DEBUG : BROWSER_OUTPUT: 19:02:07 INFO - 2015-11-23 19:02:07,194 INFO : Browser exited with error code: 0 19:02:07 INFO - 2015-11-23 19:02:07,240 INFO : Completed test kraken (00:00:55) 19:02:07 INFO - 2015-11-23 19:02:07,240 INFO : Starting test v8_7 19:02:07 INFO - 2015-11-23 19:02:07,240 DEBUG : operating with platform_type : mac_ 19:02:07 INFO - 2015-11-23 19:02:07,240 INFO : Initialising browser for v8_7 test... 19:02:07 INFO - 2015-11-23 19:02:07,254 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpuUko3R/profile http://localhost:49378/getInfo.html 19:02:09 INFO - 2015-11-23 19:02:09,506 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:02:09 INFO - 2015-11-23 19:02:09,506 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:02:09 INFO - 2015-11-23 19:02:09,506 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:02:09 INFO - 2015-11-23 19:02:09,506 DEBUG : BROWSER_OUTPUT: __metrics 19:02:09 INFO - 2015-11-23 19:02:09,524 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:02:09 INFO - 2015-11-23 19:02:09,836 DEBUG : BROWSER_OUTPUT: console.error: 19:02:09 INFO - 2015-11-23 19:02:09,839 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 19:02:09 INFO - 2015-11-23 19:02:09,839 DEBUG : BROWSER_OUTPUT: Stack: 19:02:09 INFO - 2015-11-23 19:02:09,840 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 19:02:09 INFO - 2015-11-23 19:02:09,840 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 19:02:09 INFO - 2015-11-23 19:02:09,840 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 19:02:09 INFO - 2015-11-23 19:02:09,840 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 19:02:09 INFO - 2015-11-23 19:02:09,840 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 19:02:09 INFO - 2015-11-23 19:02:09,840 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 19:02:09 INFO - 2015-11-23 19:02:09,840 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 19:02:09 INFO - 2015-11-23 19:02:09,840 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 19:02:09 INFO - 2015-11-23 19:02:09,840 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 19:02:09 INFO - 2015-11-23 19:02:09,840 DEBUG : BROWSER_OUTPUT: 19:02:10 INFO - 2015-11-23 19:02:10,307 INFO : Browser initialized. 19:02:10 INFO - 2015-11-23 19:02:10,307 INFO : Running cycle 1/1 for v8_7 test... 19:02:10 INFO - 2015-11-23 19:02:10,307 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpuUko3R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:02:22 INFO - 2015-11-23 19:02:22,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 225038336 19:02:22 INFO - 2015-11-23 19:02:22,189 DEBUG : BROWSER_OUTPUT: 19:02:43 INFO - 2015-11-23 19:02:43,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49378/tests/v8_7/run.html (next: http://localhost:49378/tests/v8_7/run.html) 19:02:43 INFO - 2015-11-23 19:02:43,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 645578752 19:02:43 INFO - 2015-11-23 19:02:43,833 DEBUG : BROWSER_OUTPUT: 19:02:43 INFO - 2015-11-23 19:02:43,833 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:02:43 INFO - 2015-11-23 19:02:43,833 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:02:43 INFO - 2015-11-23 19:02:43,833 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:02:43 INFO - 2015-11-23 19:02:43,834 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:02:43 INFO - 2015-11-23 19:02:43,834 DEBUG : BROWSER_OUTPUT: |0;Richards;193.87359441644048 19:02:43 INFO - 2015-11-23 19:02:43,834 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;158.95724050230487 19:02:43 INFO - 2015-11-23 19:02:43,834 DEBUG : BROWSER_OUTPUT: |2;Encrypt;288.1014116969173 19:02:43 INFO - 2015-11-23 19:02:43,834 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4731.132075471698 19:02:43 INFO - 2015-11-23 19:02:43,834 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1754.3859649122808 19:02:43 INFO - 2015-11-23 19:02:43,834 DEBUG : BROWSER_OUTPUT: |5;Earley;820.4918032786885 19:02:43 INFO - 2015-11-23 19:02:43,834 DEBUG : BROWSER_OUTPUT: |6;Boyer;12910.25641025641 19:02:43 INFO - 2015-11-23 19:02:43,834 DEBUG : BROWSER_OUTPUT: |7;RegExp;27944.444444444445 19:02:43 INFO - 2015-11-23 19:02:43,834 DEBUG : BROWSER_OUTPUT: |8;Splay;664.4518272425249 19:02:43 INFO - 2015-11-23 19:02:43,834 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4482.142857142857 19:02:43 INFO - 2015-11-23 19:02:43,834 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:02:43 INFO - 2015-11-23 19:02:43,834 DEBUG : BROWSER_OUTPUT: __startTimestamp1448334163833__endTimestamp 19:02:43 INFO - 2015-11-23 19:02:43,834 DEBUG : BROWSER_OUTPUT: 19:02:43 INFO - 2015-11-23 19:02:43,836 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:02:43 INFO - 2015-11-23 19:02:43,836 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:02:43 INFO - 2015-11-23 19:02:43,836 DEBUG : BROWSER_OUTPUT: 19:02:43 INFO - 2015-11-23 19:02:43,836 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:193.87 Median:193.87 stddev:0.00 (0.0%) 19:02:43 INFO - 2015-11-23 19:02:43,836 DEBUG : BROWSER_OUTPUT: Values: 193.9 19:02:43 INFO - 2015-11-23 19:02:43,836 DEBUG : BROWSER_OUTPUT: 19:02:43 INFO - 2015-11-23 19:02:43,836 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:158.96 Median:158.96 stddev:0.00 (0.0%) 19:02:43 INFO - 2015-11-23 19:02:43,836 DEBUG : BROWSER_OUTPUT: Values: 159.0 19:02:43 INFO - 2015-11-23 19:02:43,836 DEBUG : BROWSER_OUTPUT: 19:02:43 INFO - 2015-11-23 19:02:43,836 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:288.10 Median:288.10 stddev:0.00 (0.0%) 19:02:43 INFO - 2015-11-23 19:02:43,836 DEBUG : BROWSER_OUTPUT: Values: 288.1 19:02:43 INFO - 2015-11-23 19:02:43,836 DEBUG : BROWSER_OUTPUT: 19:02:43 INFO - 2015-11-23 19:02:43,837 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4731.13 Median:4731.13 stddev:0.00 (0.0%) 19:02:43 INFO - 2015-11-23 19:02:43,837 DEBUG : BROWSER_OUTPUT: Values: 4731.1 19:02:43 INFO - 2015-11-23 19:02:43,837 DEBUG : BROWSER_OUTPUT: 19:02:43 INFO - 2015-11-23 19:02:43,837 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1754.39 Median:1754.39 stddev:0.00 (0.0%) 19:02:43 INFO - 2015-11-23 19:02:43,837 DEBUG : BROWSER_OUTPUT: Values: 1754.4 19:02:43 INFO - 2015-11-23 19:02:43,837 DEBUG : BROWSER_OUTPUT: 19:02:43 INFO - 2015-11-23 19:02:43,837 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:820.49 Median:820.49 stddev:0.00 (0.0%) 19:02:43 INFO - 2015-11-23 19:02:43,837 DEBUG : BROWSER_OUTPUT: Values: 820.5 19:02:43 INFO - 2015-11-23 19:02:43,837 DEBUG : BROWSER_OUTPUT: 19:02:43 INFO - 2015-11-23 19:02:43,837 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12910.26 Median:12910.26 stddev:0.00 (0.0%) 19:02:43 INFO - 2015-11-23 19:02:43,837 DEBUG : BROWSER_OUTPUT: Values: 12910.3 19:02:43 INFO - 2015-11-23 19:02:43,837 DEBUG : BROWSER_OUTPUT: 19:02:43 INFO - 2015-11-23 19:02:43,837 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27944.44 Median:27944.44 stddev:0.00 (0.0%) 19:02:43 INFO - 2015-11-23 19:02:43,837 DEBUG : BROWSER_OUTPUT: Values: 27944.4 19:02:43 INFO - 2015-11-23 19:02:43,837 DEBUG : BROWSER_OUTPUT: 19:02:43 INFO - 2015-11-23 19:02:43,837 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:664.45 Median:664.45 stddev:0.00 (0.0%) 19:02:43 INFO - 2015-11-23 19:02:43,838 DEBUG : BROWSER_OUTPUT: Values: 664.5 19:02:43 INFO - 2015-11-23 19:02:43,838 DEBUG : BROWSER_OUTPUT: 19:02:43 INFO - 2015-11-23 19:02:43,838 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4482.14 Median:4482.14 stddev:0.00 (0.0%) 19:02:43 INFO - 2015-11-23 19:02:43,838 DEBUG : BROWSER_OUTPUT: Values: 4482.1 19:02:43 INFO - 2015-11-23 19:02:43,838 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:02:43 INFO - 2015-11-23 19:02:43,838 DEBUG : BROWSER_OUTPUT: 19:02:44 INFO - 2015-11-23 19:02:44,574 INFO : Browser exited with error code: 0 19:02:44 INFO - 2015-11-23 19:02:44,592 INFO : Completed test v8_7 (00:00:37) 19:02:44 INFO - 2015-11-23 19:02:44,927 INFO : Completed test suite (00:20:06) 19:02:44 INFO - 2015-11-23 19:02:44,927 DEBUG : Working with test: dromaeo_css 19:02:44 INFO - 2015-11-23 19:02:44,927 DEBUG : Generating results file: dromaeo_css 19:02:44 INFO - 2015-11-23 19:02:44,928 DEBUG : Working with test: kraken 19:02:44 INFO - 2015-11-23 19:02:44,928 DEBUG : Generating results file: kraken 19:02:44 INFO - 2015-11-23 19:02:44,929 INFO : javascript benchmark 19:02:44 INFO - 2015-11-23 19:02:44,929 DEBUG : Working with test: v8_7 19:02:44 INFO - 2015-11-23 19:02:44,929 DEBUG : Generating results file: v8_7 19:02:44 INFO - 2015-11-23 19:02:44,929 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:02:44 INFO - 2015-11-23 19:02:44,983 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 19:02:44 INFO - 2015-11-23 19:02:44,984 DEBUG : process_Request line: dromaeo_css 7607.45 graph.html#tests=[[72,64,59]] 19:02:44 INFO - 2015-11-23 19:02:44,984 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:02:45 INFO - 2015-11-23 19:02:45,009 DEBUG : process_Request line: kraken 1378.20 graph.html#tests=[[232,64,59]] 19:02:45 INFO - 2015-11-23 19:02:45,009 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:02:45 INFO - 2015-11-23 19:02:45,035 DEBUG : process_Request line: v8_7 19871.07 graph.html#tests=[[230,64,59]] 19:02:45 INFO - 2015-11-23 19:02:45,036 INFO : javascript benchmark 19:02:45 INFO - 2015-11-23 19:02:45,038 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3113.112762862584, 3409.369266685665, 3442.0362298556415, 3448.2758620689656, 3466.653334666533, 5457.372402173752, 5577.135543990677, 5668.943310566899, 5669.234653321801, 5698.344690360605, 5569.470900264479, 5619.466150715686, 5643.463870932265, 5802.622829516089, 5831.212786273852, 5055.266986286986, 5069.493050694929, 5091.389033316007, 5128.153854613985, 5194.792208311663, 5235.397929238129, 5239.397469291042, 5247.632665713401, 5272.525472707455, 5298.47015298469, 3794.31702293587, 5015.52352526513, 5087.643864929457, 5092.8217512387255, 5172.482751724835, 5092.3125378073855, 5098.260752190911, 5113.539781419653, 5114.181730923072, 5115.181570948667, 5031.823886163967, 5107.4892510749, 5132.5124113209185, 5164.870878228075, 5185.740712964337, 5496.670199787985, 5524.640898341635, 5543.1408131739645, 5548.805791797308, 5558.471945165203, 6169.074638804215, 6175.845603859894, 6176.197094377747, 6183.2889217740085, 6185.505159587222, 6085.0, 6116.938830611726, 6169.0, 6186.721597528077, 6202.72087756052, 5730.856728581777, 5735.311762588516, 5766.971165144189, 5770.047942089592, 5785.82642520725, 6144.064619644798, 6145.4161854623735, 6178.505719542426, 6225.8132256032395, 6300.936990630126, 6136.6318020918, 6148.723307451175, 6152.846178845564, 6158.938410615837, 6162.753489860355, 6212.192414986023, 6231.096491008779, 6234.75060997555, 6235.937640623626, 6241.407066328691, 5996.520278377807, 6031.9396806032255, 6101.877962440726, 6133.662648554283, 6188.504919606421, 6181.072839074085, 6195.380461953859, 6199.473044791153, 6206.131141640174, 6208.565400422018, 4906.092372911023, 4912.091263116335, 4921.434035085939, 4927.876803079952, 4967.3294105296045, 4288.506821715543, 4307.763073031013, 4439.822407103744, 4447.844325448658, 4459.44256967879, 5648.915266271009, 5671.149327600893, 5680.289963754531, 5680.545556355564, 5773.624714393551, 6191.535634827316, 6205.255369355616, 6211.81364559064, 6214.036824292242, 6218.31598524162, 5488.670679759227, 5579.776808927598, 5606.411326810708, 5616.213730077792, 5660.575456840754, 5390.784368625289, 5391.838244852583, 5403.891922161535, 5413.2692086568595, 5424.511793938565, 6254.843628909222, 6282.811515654537, 6297.622142671455, 6304.0, 6309.05364195356, 6052.334243233329, 6108.047853176003, 6142.293636231891, 6158.661273629993, 6207.34822843613, 6232.407921247474, 6250.218722659668, 6250.812475625738, 6251.093591429309, 6253.749850005949, 6117.602355846856, 6130.356312587292, 6130.570860039755, 6134.78528251509, 6144.969275153596, 5017.598592112549, 5434.972825135849, 6102.216595924314, 6109.053096770008, 6206.410391012847, 5009.7244651544515, 5973.044312909914, 6009.308929472992, 6017.879642407215, 6019.909701354396, 5958.1658567801405, 6032.095185722177, 6033.54748393881, 6043.244594425697, 6123.663198524124, 5891.116332550152, 5896.528277737856, 5905.40945905406, 5933.2880054393745, 5949.167116603766, 6056.3035250946705, 6056.727447264796, 6056.878862422815, 6062.484688801501, 6066.696665166813, 5745.885082298414, 5836.766529338779, 5862.560307976833, 5901.616394934315, 5932.970335148297], "unit": "ms", "name": "dojo.html", "value": 5627.867496000289}, {"lowerIsBetter": false, "replicates": [502.95976321894244, 555.8249151517269, 618.536097926555, 629.9133993860589, 633.3571425003622, 32058.198545036357, 32336.838315808418, 32353.0, 32465.51301730476, 40415.59584404162, 34081.82959085201, 43776.0, 44135.77932110335, 44272.0, 44442.0, 9675.371100878438, 9826.656067037655, 9854.90145098547, 9878.160356369717, 9880.456574888378, 8760.780980475476, 8915.777105572348, 8931.41945773526, 8933.419327743675, 9630.951845240765, 8753.649854005833, 8842.115788421139, 11952.282863028246, 12055.156139070268, 12078.637640870744, 11779.646610601696, 11830.349330786761, 11839.940800295943, 11847.289162650268, 11864.52541898323, 8812.339074569432, 11696.12279079064, 11813.527458901634, 11814.822777658343, 11843.111766617538, 31926.882559110552, 32129.51805722916, 42648.57351426508, 42818.78590607058, 42893.785531072455, 3244.8053116813066, 3247.5291082792864, 3418.8119653419053, 3681.318955993123, 3760.567534733486, 23340.183093591644, 28455.57316640252, 28548.286292842637, 29273.41453170946, 29641.70358296411, 2735.548634475329, 2737.86310684465, 2851.7718582513558, 2878.7553057990094, 2951.704829517031, 454651.4534854642, 455595.0, 456644.0, 605782.0, 621368.8931555358, 58504.0, 58993.705031474565, 59116.40883591195, 59327.81344373088, 74219.25780742231, 72328.0, 72570.2742972574, 72649.63675181696, 72700.63649681823, 72766.63616681883, 16035.278412471467, 16378.099204543627, 16382.508524744277, 16397.934134281233, 16424.850260481653, 12481.75036499265, 12541.686457838445, 12545.749085018431, 12562.68593285157, 12590.874091259153, 18770.624587508173, 20774.468340382173, 21715.891420543114, 21754.782452175594, 21778.455538611663, 8964.551772411483, 9152.725418237464, 9162.541872906328, 9182.908170918205, 9240.5841737122, 903.6114470777628, 1006.5369929832359, 1104.0670633314837, 1135.1202817816259, 1149.7413082056637, 27178.864105679346, 29295.560566591517, 29508.852455737582, 29654.851725741235, 29791.51042447869, 1095.4084794211037, 1098.3849044535086, 1114.0920150077661, 1124.8256520239377, 1206.9818952715716, 15020.324085416183, 15489.922550387177, 15755.763663544827, 15858.0, 16181.676366472604, 732647.0, 733174.0, 733790.0, 734790.0, 736498.0, 59127.408725913054, 59264.40735592675, 59388.703056485305, 59509.702451487465, 59762.402375976555, 1460.0436713952379, 1467.2590341877283, 1471.9558413247619, 1474.6460849396283, 1485.2796393749022, 28135.57796633011, 29644.55533167047, 29676.851615741783, 30077.183185056532, 30373.936912207966, 41913.95215119524, 51270.48729512657, 51823.222651659504, 51832.96334073373, 51849.74075129751, 452960.7351963219, 456022.0, 456748.0, 456904.0, 456914.4308556872, 28251.57622635621, 28943.710562894943, 30093.849530752206, 34685.959421217405, 34991.62604674415, 40288.3956740655, 40874.79562602168, 41072.589274108075, 41314.79342603268, 41481.58518414898, 34583.65416345804, 35199.29601407906, 35688.929332120075, 36223.818880905426, 36229.09427264339, 30605.846970765004, 31095.533566996965, 36227.63772362243, 36777.63222367849, 37884.43173352457, 35242.82378588091, 35754.64245357513, 35765.46351804673, 35773.747918822715, 37444.43833342556, 23590.52818943646, 31513.684863151993, 32200.0, 32439.513407298437, 32516.34967300688, 24414.87792561097, 24689.753102469465, 24905.128320508695, 25122.37194070163, 25239.369015774017], "unit": "ms", "name": "ext.html", "value": 20231.754563093262}, {"lowerIsBetter": false, "replicates": [363.5964079871342, 363.6799616337621, 365.2785748147411, 367.5497515543458, 369.59344720807115, 14402.0, 15819.683606327895, 19798.802011979875, 20364.0, 21089.47276318093, 18267.543311417223, 18522.814771852278, 18550.165242564082, 18590.16344264508, 19034.714479282822, 4013.6387725104737, 5226.608004399675, 5387.4612538746005, 5389.973050134744, 5418.647787893794, 4118.814653340607, 4147.854825081123, 5771.192033115367, 5943.435373639497, 5986.132010858423, 5821.8647363764085, 5877.941220587803, 5919.200907877446, 5920.289565252176, 5956.672383018932, 5893.145493903381, 5922.733476993524, 5924.289085309747, 5934.762609495615, 5936.64380137191, 5343.251944727741, 5496.1755736639425, 5496.367917689477, 5653.2085508028495, 5675.262215911905, 12880.42038108278, 12909.67725806853, 12920.22478651284, 16917.90033647809, 24062.27813165608, 1979.0797279265066, 2059.0939986406083, 2104.053176070759, 2105.620988222119, 2170.9891450542646, 9627.807443851154, 9669.564869580885, 9944.602215911355, 9959.103680668703, 12244.632661020183, 1708.5728567858037, 1729.7145970914785, 1735.9305627774875, 1741.8519425848817, 1783.1530023238988, 96457.0, 96968.0, 99751.0, 100228.49657255146, 100572.49713751384, 10745.032947034648, 11017.063549598373, 11019.118470522339, 11122.99893009633, 11133.777324453466, 13271.469141234436, 13297.468101276034, 13302.068855180045, 13317.600471985663, 13332.866671333162, 7662.8084297893, 7697.153313135551, 7700.576468294297, 7717.922820771721, 7815.140334563193, 6527.249366322839, 7004.719811207495, 7337.853242935112, 7397.408207343399, 7404.2595740426605, 3992.161646054303, 4148.398482220061, 4288.807003684841, 4356.520782713899, 4375.949772054748, 1733.5406117378905, 1764.4706588023541, 1767.0369648541575, 1767.7525146479504, 1768.6639538487645, 898.9886377824947, 926.5737760630186, 1042.3381152967768, 1082.1937656445841, 1082.437132691012, 19564.21743130259, 19915.203391864452, 19962.500937476678, 20089.598208035757, 20411.591768164555, 758.3250906693048, 917.1241464401614, 941.317544780029, 952.8708480450688, 968.3899143539666, 10915.181361397927, 11405.201635885409, 11683.824742628867, 11708.824367634492, 11717.12121590884, 736091.0, 736690.6330936729, 740127.0, 760150.0, 762468.0, 116229.0, 117735.41132294283, 118429.8157018436, 120386.0, 122650.38674806747, 1233.4018001269378, 1244.0980289290192, 1247.3015111537568, 1250.2685928731612, 1258.2576279994664, 18222.623859224193, 18570.721439178153, 18645.90677046606, 18693.065346732335, 18796.0, 51517.227241590655, 52273.47726522838, 52302.21546676879, 52418.0, 52484.0, 57358.0, 65869.34130658633, 66458.0, 72669.63665181852, 72872.0, 8330.416870818985, 9472.905270947478, 9846.606135754777, 9877.753056173653, 9884.11043006133, 15397.384104635688, 16356.427525036566, 19154.23383064662, 19271.1327990238, 19966.60066798627, 10042.949785251027, 14918.55244342628, 15826.0, 15883.602909926882, 16001.0, 12413.923968461046, 15084.321205545997, 15433.151176685391, 15696.529104126894, 15735.842641573438, 12574.559890403792, 15833.52499425019, 15882.841171588136, 16250.593735156242, 16490.093044882648, 8074.313683336982, 9429.292803039662, 9690.0, 9758.658446954323, 9782.657606983721, 10046.196304295492, 10586.101518050076, 14565.41738330455, 14747.410103595736, 15130.54608361751], "unit": "ms", "name": "jquery.html", "value": 9607.492025621197}, {"lowerIsBetter": false, "replicates": [1583.5566041508375, 1587.7062743392466, 1707.9487615371543, 1905.6665083610364, 1930.835878950289, 7432.331090201881, 7589.582572958485, 8430.494170349775, 8563.272121869633, 8605.440646357998, 7332.816679583013, 8305.833883322344, 8401.327893768499, 8412.11672774359, 8420.705275315366, 2096.2243969731144, 2144.3352560706153, 2373.64395340699, 2388.235764555343, 2398.0168131066266, 2196.3191410662744, 2367.562001029806, 2389.3309873235435, 2392.2583998960376, 2392.3301475586863, 2333.94165145871, 2353.211674089182, 2363.3028256664325, 2385.940351491209, 2392.712874455068, 2130.6697461893355, 2173.7500187478327, 2177.7495588007423, 2351.882405879699, 2382.868942208178, 2369.052379048377, 2400.2199285232196, 2403.591389463795, 2403.639454081884, 2407.723111842143, 8387.538685372301, 8500.82998340036, 8503.1921967413, 8518.616662250151, 8530.957345213295, 5100.413452452978, 5177.715225662587, 5198.506141916512, 5203.0, 5215.869603259911, 3444.3111377724554, 3484.5992710838323, 3555.7333200010103, 3567.910802229965, 3585.515955346047, 1032.5560009196042, 1041.8697662792151, 1043.1706793099504, 1059.2638116509029, 1065.9413732244723, 11161.776764464665, 11163.106951443864, 11164.441777911154, 11174.161937854613, 11175.72060698489, 4557.521460246693, 4623.768811559476, 4690.038542098861, 4711.246200607886, 4724.598409135262, 9630.181434578139, 9647.517624118766, 9648.179904708179, 9663.082007209305, 9673.129418352382, 5218.921716174261, 5221.373435187802, 5223.503767142115, 5225.190095535198, 5228.686278823283, 4095.1809638072505, 4636.675432719677, 4679.719216847, 4736.0, 4768.260919557474, 3847.6344747249527, 3848.8845334640005, 3870.322693528621, 3884.8834534964, 3894.922101557953, 1281.7244292477162, 1281.7820970434861, 1285.479380850757, 1289.548657969703, 1289.8129771183314, 1365.8497565267812, 1366.7881478370668, 1400.0549629000384, 1401.8177636907137, 1408.0706733555803, 6748.763793267212, 7719.768406947801, 7867.960660196777, 7890.8816367754525, 7893.210678932176, 484.68495477938916, 495.43767823519846, 508.14885067511767, 510.47676131965034, 511.12342332899254, 5922.2597175353085, 6056.242969628796, 6059.909101363483, 6152.907706384408, 6419.03714442828, 9818.410895346302, 9915.504224788876, 10113.190944724405, 10114.393136411838, 10175.694729157989, 9876.753081173028, 9906.504674766233, 9908.752281192883, 9983.800323993624, 10038.548265328078, 7312.647160275366, 7313.524620899624, 7755.30202281786, 7785.80535486606, 7870.921290787019, 7735.419843511647, 7866.803329916798, 7877.133515313197, 7882.172371900868, 7887.566183859713, 8735.388522803343, 8809.559522023745, 8978.461292322481, 9068.138526839939, 9096.727098187064, 9022.458652480873, 9192.0, 9259.583318750538, 9282.535873206447, 9317.16145546904, 7904.802379940547, 7990.720324788605, 7994.92005079965, 8022.713526644879, 8023.959880200561, 7654.5839019781515, 8055.838883222185, 8080.757577272691, 8090.029196496458, 8092.988376452943, 7458.92541074604, 7468.253174682488, 7583.696652133853, 7619.314261716472, 7627.389808815171, 7271.709131634675, 7322.194558598443, 7366.337029667141, 7547.433942454228, 7549.980752598329, 7482.027336446227, 7560.6219689016425, 7614.657340419583, 7614.961925190339, 7615.504992175491, 6821.658917054028, 6888.51780375389, 6894.310568943066, 6902.689378978059, 6915.792526224222, 6342.873142537216, 6973.884178531411, 6975.79072627822, 6992.056072430157, 6995.825104372431], "unit": "ms", "name": "mootools.html", "value": 4700.074178978504}, {"lowerIsBetter": false, "replicates": [320.8892931938482, 322.62575412521466, 330.64951151779115, 335.2490421455938, 340.5419710489391, 6708.865822683543, 6719.160104986877, 6839.110915580974, 6847.486438517106, 6851.965740171305, 6502.902456463157, 6729.7644582439625, 6740.090087838153, 6775.864482710343, 6794.932050679492, 4948.851534453954, 4984.551390374865, 4986.301917731521, 4988.575971042465, 4990.875228119308, 4709.481956984729, 4770.761461926907, 4995.725235112068, 4998.0, 5004.973980334041, 4488.8877778055485, 4732.692374995631, 4842.539958703917, 4910.901781964359, 4916.827911023097, 4891.364122664067, 4900.460949295574, 4900.55433647075, 4905.411350637946, 4916.975415122937, 4227.260229459832, 4231.619154276099, 4233.936490952638, 4237.851675191384, 4238.237117318881, 6221.875562488724, 6465.159529261213, 6487.3836985486305, 6487.448566871822, 6496.317886621884, 5913.083472061838, 5914.2311499504785, 5916.822495325147, 5919.437653422918, 5926.140709597084, 7253.818654533626, 7269.709211631528, 7273.309035641606, 7275.745348912763, 7282.198958114604, 3979.7612143271494, 4780.37855078841, 4789.377380940456, 4796.592289655384, 4797.112534181153, 7451.21762214965, 7754.728584499516, 7761.45669803114, 7763.340116090139, 7795.4932929359975, 4595.149897268949, 4656.32483289921, 4669.41632295963, 4703.670743047954, 4852.0, 4094.7274262783844, 4989.725565093955, 4990.2764099205415, 4992.775325110306, 5001.7499125043605, 5365.973170134124, 5447.96488667152, 5866.061430171152, 5905.822825315247, 5908.0, 7140.500164988505, 7388.187299397062, 7405.33351998312, 7406.407487400995, 7444.702211911571, 1523.8857085718394, 1722.2852516205635, 1737.6872163010526, 1742.2160027987202, 1743.3723859410602, 1095.9971625962155, 1110.2062025651699, 1113.2930589075995, 1122.0350498571222, 1136.2727854173336, 6539.574927629689, 6852.109225800614, 6854.006169105552, 6866.588004719732, 6876.896846547305, 6181.721822517998, 7650.0, 7663.961680191564, 7664.923350766532, 7666.310032097138, 6673.332666733385, 6818.522703410813, 6832.80425925471, 6852.725890964405, 6954.165500139914, 4070.1859628074503, 4098.077932465171, 4107.096438783463, 4116.403121547419, 4126.546079931205, 8003.639836207385, 8007.719729809545, 8011.879821802678, 8015.158408367154, 8021.679132834738, 7710.961445192738, 7979.960100199578, 7993.040835099825, 8004.199580041949, 8040.839183216303, 7960.323372513401, 7969.1632378601735, 7973.44185906981, 7976.122626511079, 7981.281684648409, 7538.736144235145, 7674.040744906887, 7755.844883102419, 7765.223477652416, 7774.339181169437, 6195.256569211723, 6196.411340922605, 7600.049993750781, 7604.96197519031, 7613.314801667876, 7598.278163574451, 7792.220777922163, 7958.522488650699, 7959.641816118405, 7965.01312007997, 3910.416281406035, 4473.038296766211, 4556.202664533627, 4597.264437689953, 4658.976705116453, 7311.488195826241, 7587.582682952269, 7606.0, 7616.428767842323, 7636.579988100486, 7308.96345518269, 7315.853682926205, 7316.122065352191, 7324.377427918686, 7331.670074846538, 7086.964565177141, 7261.564306141649, 7279.0, 7300.23347548521, 7300.96349518249, 7077.221505634273, 7193.208747037717, 7202.099737532809, 7208.495405321787, 7212.4230061596, 7170.1754298256365, 7379.298966598165, 7387.409007279297, 7391.4086873048955, 7401.037865077506, 7177.533460325062, 7212.134543854561, 7231.3130252625915, 7241.04491787225, 7259.818504537217], "unit": "ms", "name": "prototype.html", "value": 5316.320006601421}, {"lowerIsBetter": false, "replicates": [722.7073035420655, 724.9093863267088, 769.3037800790287, 813.6582635293177, 821.9794505137367, 14777.26113694315, 15263.847361526381, 15291.847081529182, 15296.082235065876, 15326.540203793904, 14242.430302787876, 14420.639484012905, 14450.783238251408, 14454.927725361385, 14458.132512049284, 761.6153842309626, 773.1032002876664, 774.1832366852968, 778.2451022508172, 962.3504134709078, 950.5959967014026, 959.6113574002541, 969.5733877094056, 970.5777986575827, 972.470003847901, 1003.0821798054772, 1025.9846102308472, 1029.2332212501697, 1029.8455231715227, 1032.0505135275564, 803.0, 817.382875928673, 1014.7209517382779, 1018.3940555369543, 1021.6577446555413, 755.041097805789, 759.4797563668905, 762.0626629246003, 765.165969093685, 766.0118447203101, 14944.178070206135, 15194.772078418833, 15221.31504082308, 15223.467178648805, 15233.923830380889, 12448.502059917593, 12750.29873356965, 12888.291143987077, 13166.86833131666, 13336.266505342202, 10076.768725479365, 10319.122874555671, 11003.17476189281, 11397.316161030365, 11724.413779311086, 3455.6026057003514, 3523.577170739502, 3564.500969864221, 3704.7036237100965, 3728.3475391806323, 71098.64450677765, 71740.64129679318, 72126.27873721249, 72165.0, 72218.27781722168, 9356.062863841278, 9430.481323527272, 9446.008169142278, 9448.338616296793, 9518.857217141749, 20825.0, 20982.265620703507, 20991.685124723143, 21007.264745733824, 21029.84335861512, 7027.683754231072, 7117.82205444868, 7173.067501224912, 7196.892046619305, 7347.118345798538, 3986.421968814506, 3995.760254384746, 4004.619561141687, 4014.157027024299, 4038.51537815464, 3552.4138517144897, 3597.892063238107, 3598.9100272493397, 3600.945985810215, 3602.225521512887, 640.8750293692685, 646.5829539946802, 650.1905128115432, 650.3431534150542, 655.0240142188105, 518.5669965578709, 525.6530689744826, 530.8805518758248, 560.8990381731328, 609.597665540741, 9202.35583509148, 9383.5308234588, 9400.106989835955, 9498.525073746285, 9548.761280968032, 616.2851092732409, 622.7726879688971, 635.463033736492, 644.7711062572719, 645.7675236914707, 4020.9396859047138, 4073.103917138284, 4087.9386809197886, 4141.275276826544, 4162.375643653476, 100252.0, 102062.0, 102065.0, 102318.48840755748, 102941.0, 76829.6158519215, 76845.46309073787, 85034.14965850262, 85144.14855851486, 87374.56312718523, 73851.26148738552, 73887.99999999892, 73939.0, 74534.25465745381, 75729.62135189289, 8386.287165590993, 8504.022037465771, 8589.699360522352, 8700.695475658575, 9020.59407326685, 53256.402307930824, 54061.459385405644, 54182.18726719024, 54888.0, 55928.440715592325, 53476.245944337075, 67428.0, 73058.63470682612, 75132.2380985714, 79071.0, 10609.20430967696, 11065.721911100169, 11219.158563107636, 11340.94329528347, 11439.485223164811, 11926.403679816149, 12115.515379384726, 12144.332061736335, 12220.816687749868, 12234.87765122373, 11536.365499897585, 11703.707407314885, 11786.0, 11889.821652675044, 11893.226940248856, 11815.645530634094, 11828.704282392664, 11907.82138267944, 12146.757064858477, 12159.270443773403, 11229.38238396896, 11275.943620281847, 11669.533218671158, 11793.823092653789, 11915.821262680893, 9679.806403871742, 9781.217502599917, 9813.55838987233, 10140.29017968735, 10210.438425886647, 9734.75663108428, 9977.10206081456, 9991.750206244902, 10002.749931251778, 10008.499575021366], "unit": "ms", "name": "yui.html", "value": 7090.7923242087745}], "name": "dromaeo_css", "value": 7607.450111652349}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 108.0, 109.0, 113.0, 77.0, 147.0, 158.0, 141.0], "unit": "ms", "name": "ai-astar", "value": 117.7}, {"lowerIsBetter": true, "replicates": [146.0, 120.0, 141.0, 155.0, 116.0, 141.0, 141.0, 117.0, 161.0, 117.0], "unit": "ms", "name": "audio-beat-detection", "value": 135.5}, {"lowerIsBetter": true, "replicates": [184.0, 182.0, 181.0, 182.0, 185.0, 183.0, 183.0, 184.0, 183.0, 180.0], "unit": "ms", "name": "audio-dft", "value": 182.7}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 80.0, 73.0, 55.0, 57.0, 57.0, 76.0, 74.0, 58.0], "unit": "ms", "name": "audio-fft", "value": 66.4}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 114.0, 74.0, 75.0, 77.0, 102.0, 76.0, 73.0, 97.0], "unit": "ms", "name": "audio-oscillator", "value": 85.9}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 86.0, 86.0, 85.0, 87.0, 86.0, 86.0, 88.0, 87.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 86.4}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 93.0, 94.0, 93.0, 93.0, 93.0, 93.0, 94.0, 93.0], "unit": "ms", "name": "imaging-darkroom", "value": 93.4}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 86.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0], "unit": "ms", "name": "imaging-desaturate", "value": 84.6}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 54.0, 53.0, 54.0, 54.0, 55.0, 63.0, 53.0, 52.0], "unit": "ms", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [62.0, 64.0, 63.0, 63.0, 65.0, 66.0, 67.0, 67.0, 67.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 81.0, 80.0, 80.0, 82.0, 83.0, 82.0, 81.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.8}, {"lowerIsBetter": true, "replicates": [123.0, 120.0, 138.0, 119.0, 123.0, 122.0, 118.0, 125.0, 119.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [137.0, 126.0, 136.0, 140.0, 135.0, 128.0, 136.0, 137.0, 135.0, 156.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 136.6}, {"lowerIsBetter": true, "replicates": [55.0, 61.0, 81.0, 70.0, 64.0, 63.0, 63.0, 65.0, 63.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.9}], "name": "kraken", "value": 1378.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [193.87359441644048], "unit": "score", "name": "Richards", "value": 182.08771599999994}, {"lowerIsBetter": false, "replicates": [158.95724050230487], "unit": "score", "name": "DeltaBlue", "value": 415.94833799999986}, {"lowerIsBetter": false, "replicates": [288.1014116969173], "unit": "score", "name": "Encrypt", "value": 923.9142510000003}, {"lowerIsBetter": false, "replicates": [4731.132075471698], "unit": "score", "name": "Decrypt", "value": 56.26158723828514}, {"lowerIsBetter": false, "replicates": [1754.3859649122808], "unit": "score", "name": "RayTrace", "value": 421.7937299999998}, {"lowerIsBetter": false, "replicates": [820.4918032786885], "unit": "score", "name": "Earley", "value": 812.2725874125878}, {"lowerIsBetter": false, "replicates": [12910.25641025641], "unit": "score", "name": "Boyer", "value": 51.62275471698113}, {"lowerIsBetter": false, "replicates": [27944.444444444445], "unit": "score", "name": "RegExp", "value": 32.59986083499008}, {"lowerIsBetter": false, "replicates": [664.4518272425249], "unit": "score", "name": "Splay", "value": 122.64395499999999}, {"lowerIsBetter": false, "replicates": [4482.142857142857], "unit": "score", "name": "NavierStokes", "value": 331.0916334661356}], "name": "v8_7", "value": 19871.06779511062}]} 19:02:45 INFO - RETURN: dromaeo_css: 7607.45 19:02:45 INFO - RETURN: kraken: 1378.20 19:02:45 INFO - RETURN: v8_7: 19871.07 19:02:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "19871.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1378.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7607.45"}}} 19:02:45 INFO - Return code: 0 19:02:45 INFO - # TBPL SUCCESS # 19:02:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:02:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:02:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:02:45 INFO - 2015-11-23 19:02:45.116 screenresolution[2205:12834] starting screenresolution argv=screenresolution get 19:02:45 INFO - 2015-11-23 19:02:45.119 screenresolution[2205:12834] Display 0: 1600x1200x32@60 19:02:45 INFO - 2015-11-23 19:02:45.125 screenresolution[2206:12837] starting screenresolution argv=screenresolution list 19:02:45 INFO - Available Modes on Display 0 19:02:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:02:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:02:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:02:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:02:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:02:45 INFO - Intel Iris: 19:02:45 INFO - Chipset Model: Intel Iris 19:02:45 INFO - Type: GPU 19:02:45 INFO - Bus: Built-In 19:02:45 INFO - VRAM (Dynamic, Max): 1536 MB 19:02:45 INFO - Vendor: Intel (0x8086) 19:02:45 INFO - Device ID: 0x0a2e 19:02:45 INFO - Revision ID: 0x0009 19:02:45 INFO - Displays: 19:02:45 INFO - Display: 19:02:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:02:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:02:45 INFO - Display Serial Number: 1600x1200 60 19:02:45 INFO - Main Display: Yes 19:02:45 INFO - Mirror: Off 19:02:45 INFO - Online: Yes 19:02:45 INFO - Rotation: Supported 19:02:45 INFO - Return code: 0 19:02:45 INFO - Running post-action listener: _resource_record_post_action 19:02:45 INFO - Running post-run listener: _resource_record_post_run 19:02:46 INFO - Total resource usage - Wall time: 1237s; CPU: 53.0%; Read bytes: 598016; Write bytes: 688432640; Read time: 9; Write time: 2032 19:02:46 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 336933376; Write bytes: 336566272; Read time: 26181; Write time: 593 19:02:46 INFO - run-tests - Wall time: 1208s; CPU: 53.0%; Read bytes: 598016; Write bytes: 340594176; Read time: 9; Write time: 1403 19:02:46 INFO - Running post-run listener: _upload_blobber_files 19:02:46 INFO - Blob upload gear active. 19:02:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:02:46 INFO - Copying logs to upload dir... 19:02:46 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.781227 ========= master_lag: 0.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-23 19:02:47.043409) ========= ========= Started set props: build_url (results: 0, elapsed: 2 secs) (at 2015-11-23 19:02:47.047459) ========= 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.V1ot5PuGKO/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.vdYbcBzg71/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009592 build_url: 'https://queue.taskcluster.net/v1/task/xWPFeFVQShqXjHmHRW7FCQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 2.51 ========= ========= Finished set props: build_url (results: 0, elapsed: 2 secs) (at 2015-11-23 19:02:49.568404) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:02:49.568741) ========= 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.V1ot5PuGKO/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.vdYbcBzg71/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005159 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 19:02:49.633534) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 19:02:49.633839) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 19:02:49.638182) ========= ========= Total master_lag: 3.28 =========