builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0089 starttime: 1446545544.5 results: success (0) buildid: 20151103002805 builduid: 1bbd5ec37da24723a434a1ca046d0fcc revision: 56e2e69aea4d8e87652f560a72c5dc7376d834ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:24.500997) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:24.501671) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:24.502021) ========= 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.klHMMKfvwC/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.Aw7UPUHeNO/Listeners TMPDIR=/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005962 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:24.530973) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:24.531324) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:24.547158) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:24.547533) ========= 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.klHMMKfvwC/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.Aw7UPUHeNO/Listeners TMPDIR=/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005506 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:24.597933) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:24.598285) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:24.599032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:24.599355) ========= 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.klHMMKfvwC/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.Aw7UPUHeNO/Listeners TMPDIR=/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-03 02:12: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% 7.70M=0.002s 2015-11-03 02:12:24 (7.70 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185841 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:24.801805) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:24.802156) ========= 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.klHMMKfvwC/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.Aw7UPUHeNO/Listeners TMPDIR=/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.021519 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:24.852884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:24.853281) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 56e2e69aea4d8e87652f560a72c5dc7376d834ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 56e2e69aea4d8e87652f560a72c5dc7376d834ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.klHMMKfvwC/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.Aw7UPUHeNO/Listeners TMPDIR=/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-03 02:12:24,937 truncating revision to first 12 chars 2015-11-03 02:12:24,938 Setting DEBUG logging. 2015-11-03 02:12:24,938 attempt 1/10 2015-11-03 02:12:24,938 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/56e2e69aea4d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-03 02:12:25,223 unpacking tar archive at: mozilla-aurora-56e2e69aea4d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.551230 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:25.423030) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:25.423567) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:25.456040) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:25.456437) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-03 02:12:25.457002) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 23 secs) (at 2015-11-03 02:12:25.457327) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.klHMMKfvwC/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.Aw7UPUHeNO/Listeners TMPDIR=/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 02:12:25 INFO - MultiFileLogger online at 20151103 02:12:25 in /builds/slave/test 02:12:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:12:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:12:25 INFO - {'append_to_log': False, 02:12:25 INFO - 'base_work_dir': '/builds/slave/test', 02:12:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:12:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:12:25 INFO - 'branch': 'Mozilla-Aurora', 02:12:25 INFO - 'buildbot_json_path': 'buildprops.json', 02:12:25 INFO - 'config_files': ('talos/mac_config.py',), 02:12:25 INFO - 'default_actions': ('clobber', 02:12:25 INFO - 'read-buildbot-config', 02:12:25 INFO - 'download-and-extract', 02:12:25 INFO - 'populate-webroot', 02:12:25 INFO - 'create-virtualenv', 02:12:25 INFO - 'install', 02:12:25 INFO - 'run-tests'), 02:12:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:12:25 INFO - 'download_minidump_stackwalk': True, 02:12:25 INFO - 'download_symbols': 'ondemand', 02:12:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:12:25 INFO - 'tooltool.py': '/tools/tooltool.py', 02:12:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:12:25 INFO - '/tools/misc-python/virtualenv.py')}, 02:12:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:12:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:12:25 INFO - 'installer_path': 'installer.exe', 02:12:25 INFO - 'log_level': 'info', 02:12:25 INFO - 'log_name': 'talos', 02:12:25 INFO - 'log_to_console': True, 02:12:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:12:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:12:25 INFO - 'opt_config_files': (), 02:12:25 INFO - 'pip_index': False, 02:12:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:12:25 INFO - 'cmd': ('bash', 02:12:25 INFO - '-c', 02:12:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:12:25 INFO - 'enabled': True, 02:12:25 INFO - 'halt_on_failure': False, 02:12:25 INFO - 'name': 'check_screen_resolution'},), 02:12:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:12:25 INFO - 'cmd': ('bash', 02:12:25 INFO - '-c', 02:12:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:12:25 INFO - 'enabled': True, 02:12:25 INFO - 'halt_on_failure': False, 02:12:25 INFO - 'name': 'check_screen_resolution'},), 02:12:25 INFO - 'run_cmd_checks_enabled': True, 02:12:25 INFO - 'sps_profile': False, 02:12:25 INFO - 'sps_profile_interval': 0, 02:12:25 INFO - 'suite': 'dromaeojs', 02:12:25 INFO - 'system_bits': '64', 02:12:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:12:25 INFO - 'title': 't-yosemite-r5-0089', 02:12:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:12:25 INFO - 'use_talos_json': True, 02:12:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:12:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:12:25 INFO - 'work_dir': 'build'} 02:12:25 INFO - ##### 02:12:25 INFO - ##### Running clobber step. 02:12:25 INFO - ##### 02:12:25 INFO - Running pre-action listener: _resource_record_pre_action 02:12:25 INFO - Running main action method: clobber 02:12:25 INFO - rmtree: /builds/slave/test/build 02:12:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:12:25 INFO - Running post-action listener: _resource_record_post_action 02:12:25 INFO - ##### 02:12:25 INFO - ##### Running read-buildbot-config step. 02:12:25 INFO - ##### 02:12:25 INFO - Running pre-action listener: _resource_record_pre_action 02:12:25 INFO - Running main action method: read_buildbot_config 02:12:25 INFO - Using buildbot properties: 02:12:25 INFO - { 02:12:25 INFO - "properties": { 02:12:25 INFO - "buildnumber": 255, 02:12:25 INFO - "product": "firefox", 02:12:25 INFO - "script_repo_revision": "production", 02:12:25 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 02:12:25 INFO - "repository": "", 02:12:25 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 02:12:25 INFO - "buildid": "20151103002805", 02:12:25 INFO - "slavename": "t-yosemite-r5-0089", 02:12:25 INFO - "pgo_build": "False", 02:12:25 INFO - "basedir": "/builds/slave/test", 02:12:25 INFO - "project": "", 02:12:25 INFO - "platform": "yosemite", 02:12:25 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:12:25 INFO - "slavebuilddir": "test", 02:12:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:12:25 INFO - "branch": "mozilla-aurora", 02:12:25 INFO - "repo_path": "releases/mozilla-aurora", 02:12:25 INFO - "stage_platform": "macosx64", 02:12:25 INFO - "builduid": "1bbd5ec37da24723a434a1ca046d0fcc", 02:12:25 INFO - "revision": "56e2e69aea4d8e87652f560a72c5dc7376d834ad" 02:12:25 INFO - }, 02:12:25 INFO - "sourcestamp": { 02:12:25 INFO - "repository": "", 02:12:25 INFO - "hasPatch": false, 02:12:25 INFO - "project": "", 02:12:25 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:12:25 INFO - "changes": [ 02:12:25 INFO - { 02:12:25 INFO - "category": null, 02:12:25 INFO - "files": [ 02:12:25 INFO - { 02:12:25 INFO - "url": null, 02:12:25 INFO - "name": "https://queue.taskcluster.net/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 02:12:25 INFO - } 02:12:25 INFO - ], 02:12:25 INFO - "repository": "", 02:12:25 INFO - "rev": "56e2e69aea4d8e87652f560a72c5dc7376d834ad", 02:12:25 INFO - "who": "pbrosset@mozilla.com", 02:12:25 INFO - "when": 1446545525, 02:12:25 INFO - "number": 6614077, 02:12:25 INFO - "comments": "Bug 1211886 - Make infinite animations that iterated at least once pausable; r=miker; a=blanket-sylvestre", 02:12:25 INFO - "project": "", 02:12:25 INFO - "at": "Tue 03 Nov 2015 02:12:05", 02:12:25 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:12:25 INFO - "revlink": "", 02:12:25 INFO - "properties": [ 02:12:25 INFO - [ 02:12:25 INFO - "buildid", 02:12:25 INFO - "20151103002805", 02:12:25 INFO - "Change" 02:12:25 INFO - ], 02:12:25 INFO - [ 02:12:25 INFO - "builduid", 02:12:25 INFO - "1bbd5ec37da24723a434a1ca046d0fcc", 02:12:25 INFO - "Change" 02:12:25 INFO - ], 02:12:25 INFO - [ 02:12:25 INFO - "pgo_build", 02:12:25 INFO - "False", 02:12:25 INFO - "Change" 02:12:25 INFO - ] 02:12:25 INFO - ], 02:12:25 INFO - "revision": "56e2e69aea4d8e87652f560a72c5dc7376d834ad" 02:12:25 INFO - } 02:12:25 INFO - ], 02:12:25 INFO - "revision": "56e2e69aea4d8e87652f560a72c5dc7376d834ad" 02:12:25 INFO - } 02:12:25 INFO - } 02:12:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 02:12:25 INFO - Running post-action listener: _resource_record_post_action 02:12:25 INFO - ##### 02:12:25 INFO - ##### Running download-and-extract step. 02:12:25 INFO - ##### 02:12:25 INFO - Running pre-action listener: _resource_record_pre_action 02:12:25 INFO - Running main action method: download_and_extract 02:12:25 INFO - mkdir: /builds/slave/test/build/tests 02:12:25 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')]} 02:12:25 INFO - https://queue.taskcluster.net/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:12:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/test_packages.json 02:12:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/test_packages.json 02:12:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:12:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:12:25 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/test_packages.json 02:12:25 INFO - Running command: ['nslookup', 'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 02:12:25 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 02:12:26 INFO - Server: 10.26.75.40 02:12:26 INFO - Address: 10.26.75.40#53 02:12:26 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 02:12:26 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 02:12:26 INFO - Address: 10.26.48.46 02:12:26 INFO - Return code: 0 02:12:26 INFO - retry: attempt #1 caught exception: 02:12:26 INFO - retry: Failed, sleeping 30 seconds before retrying 02:12:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #2 02:12:57 INFO - Downloaded 1149 bytes. 02:12:57 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:12:57 INFO - Using the following test package requirements: 02:12:57 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:12:57 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:12:57 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 02:12:57 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:12:57 INFO - u'jsshell-mac.zip'], 02:12:57 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:12:57 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 02:12:57 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:12:57 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:12:57 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 02:12:57 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:12:57 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 02:12:57 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:12:57 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 02:12:57 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:12:57 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:12:57 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 02:12:57 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:12: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')]} 02:12:57 INFO - https://queue.taskcluster.net/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:12:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:12:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:12:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:12:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:12:58 INFO - Downloaded 17445371 bytes. 02:12:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:12:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:12:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:13:03 INFO - Return code: 0 02:13:03 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:03 INFO - https://queue.taskcluster.net/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:13:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:13:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:13:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:13:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:13:04 INFO - Downloaded 17445371 bytes. 02:13:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:13:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:13:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:13:10 INFO - Return code: 0 02:13:10 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')]} 02:13:10 INFO - https://queue.taskcluster.net/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:13:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:13:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:13:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:13:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:13:11 INFO - Downloaded 11131307 bytes. 02:13:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 02:13:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:13:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:13:11 INFO - Return code: 0 02:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:11 INFO - https://queue.taskcluster.net/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:13:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:13:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:13:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 02:13:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 02:13:17 INFO - Downloaded 107715984 bytes. 02:13:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:13:17 INFO - mkdir: /builds/slave/test/properties 02:13:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:13:17 INFO - Writing to file /builds/slave/test/properties/build_url 02:13:17 INFO - Contents: 02:13:17 INFO - build_url:https://queue.taskcluster.net/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:13:17 INFO - Running post-action listener: _resource_record_post_action 02:13:17 INFO - Running post-action listener: set_extra_try_arguments 02:13:17 INFO - ##### 02:13:17 INFO - ##### Running populate-webroot step. 02:13:17 INFO - ##### 02:13:17 INFO - Running pre-action listener: _resource_record_pre_action 02:13:17 INFO - Running main action method: populate_webroot 02:13:17 INFO - Guessing talos json url... 02:13:17 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')]} 02:13:17 INFO - https://queue.taskcluster.net/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 02:13:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:13:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:13:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:13:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 02:13:18 INFO - Downloaded 107 bytes. 02:13:18 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:13:18 INFO - Contents: 02:13:18 INFO - 20151103002805 02:13:18 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/56e2e69aea4d8e87652f560a72c5dc7376d834ad 02:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:18 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/56e2e69aea/testing/talos/talos.json 02:13:18 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/56e2e69aea/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:13:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/56e2e69aea/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:13:18 INFO - Downloaded 4264 bytes. 02:13:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:13:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:13:18 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:13:18 INFO - '../fennec_ids.txt'], 02:13:18 INFO - 'tests': ['tcheck2']}, 02:13:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:13:18 INFO - '--tppagecycles', 02:13:18 INFO - '7'], 02:13:18 INFO - 'tests': ['tsvgm']}}, 02:13:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:13:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:13:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:13:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:13:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:13:18 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:13:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:18 INFO - 'talos_options': ['--e10s'], 02:13:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:18 INFO - 'tests': ['damp', 'tps']}, 02:13:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:18 INFO - 'talos_options': ['--e10s'], 02:13:18 INFO - 'tests': ['damp', 'tps']}, 02:13:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:13:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:13:18 INFO - 'other': {'tests': ['a11yr', 02:13:18 INFO - 'ts_paint', 02:13:18 INFO - 'tpaint', 02:13:18 INFO - 'sessionrestore', 02:13:18 INFO - 'sessionrestore_no_auto_restore']}, 02:13:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:13:18 INFO - 'tests': ['a11yr', 02:13:18 INFO - 'ts_paint', 02:13:18 INFO - 'tpaint', 02:13:18 INFO - 'sessionrestore', 02:13:18 INFO - 'sessionrestore_no_auto_restore']}, 02:13:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:13:18 INFO - 'tests': ['a11yr', 02:13:18 INFO - 'ts_paint', 02:13:18 INFO - 'tpaint', 02:13:18 INFO - 'sessionrestore', 02:13:18 INFO - 'sessionrestore_no_auto_restore']}, 02:13:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:13:18 INFO - 'tests': ['a11yr', 02:13:18 INFO - 'ts_paint', 02:13:18 INFO - 'tpaint', 02:13:18 INFO - 'sessionrestore', 02:13:18 INFO - 'sessionrestore_no_auto_restore']}, 02:13:18 INFO - 'other_l64': {'tests': ['a11yr', 02:13:18 INFO - 'ts_paint', 02:13:18 INFO - 'tpaint', 02:13:18 INFO - 'sessionrestore', 02:13:18 INFO - 'sessionrestore_no_auto_restore']}, 02:13:18 INFO - 'other_nol64': {'tests': ['a11yr', 02:13:18 INFO - 'ts_paint', 02:13:18 INFO - 'tpaint', 02:13:18 INFO - 'sessionrestore', 02:13:18 INFO - 'sessionrestore_no_auto_restore']}, 02:13:18 INFO - 'svgr': {'tests': ['tsvgx', 02:13:18 INFO - 'tsvgr_opacity', 02:13:18 INFO - 'tart', 02:13:18 INFO - 'tscrollx', 02:13:18 INFO - 'cart']}, 02:13:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:13:18 INFO - 'tests': ['tsvgx', 02:13:18 INFO - 'tsvgr_opacity', 02:13:18 INFO - 'tart', 02:13:18 INFO - 'tscrollx', 02:13:18 INFO - 'cart']}, 02:13:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:18 INFO - 'tests': ['tp5o']}, 02:13:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:18 INFO - 'talos_options': ['--e10s'], 02:13:18 INFO - 'tests': ['tp5o']}, 02:13:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:18 INFO - 'talos_options': ['--xperf_path', 02:13:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:18 INFO - 'tests': ['tp5n']}, 02:13:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:18 INFO - 'talos_options': ['--e10s', 02:13:18 INFO - '--xperf_path', 02:13:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:13:18 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:13:18 INFO - 'tests': ['tp5n']}}, 02:13:18 INFO - 'talos.zip': {'path': '', 02:13:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:13:18 INFO - Running post-action listener: _resource_record_post_action 02:13:18 INFO - ##### 02:13:18 INFO - ##### Running create-virtualenv step. 02:13:18 INFO - ##### 02:13:18 INFO - Running pre-action listener: _resource_record_pre_action 02:13:18 INFO - Running main action method: create_virtualenv 02:13:18 INFO - Creating virtualenv /builds/slave/test/build/venv 02:13:18 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 02:13:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:13:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:13:19 INFO - Using real prefix '/tools/python27' 02:13:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:13:19 INFO - Installing distribute.............................................................................................................................................................................................done. 02:13:23 INFO - Installing pip.................done. 02:13:23 INFO - Return code: 0 02:13:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:13:23 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')]} 02:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:23 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')]} 02:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:23 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 0x100f10a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde30cea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec59f0>, '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 0x100c24cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e8f990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.klHMMKfvwC/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.Aw7UPUHeNO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:13:23 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 02:13:23 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 02:13:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.klHMMKfvwC/Render', 02:13:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:23 INFO - 'HOME': '/Users/cltbld', 02:13:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:23 INFO - 'LOGNAME': 'cltbld', 02:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:23 INFO - 'MOZ_NO_REMOTE': '1', 02:13:23 INFO - 'NO_EM_RESTART': '1', 02:13:23 INFO - 'PAGER': '/bin/cat', 02:13:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:23 INFO - 'PWD': '/builds/slave/test', 02:13:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:23 INFO - 'SHELL': '/bin/bash', 02:13:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Aw7UPUHeNO/Listeners', 02:13:23 INFO - 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', 02:13:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:23 INFO - 'USER': 'cltbld', 02:13:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:23 INFO - 'XPC_FLAGS': '0x0', 02:13:23 INFO - 'XPC_SERVICE_NAME': '0', 02:13:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:23 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 02:13:23 INFO - Cleaning up... 02:13:23 INFO - Return code: 0 02:13:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:13:23 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')]} 02:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:23 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')]} 02:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:23 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 0x100f10a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde30cea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec59f0>, '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 0x100c24cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e8f990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.klHMMKfvwC/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.Aw7UPUHeNO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:13:23 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 02:13:23 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 02:13:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.klHMMKfvwC/Render', 02:13:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:23 INFO - 'HOME': '/Users/cltbld', 02:13:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:23 INFO - 'LOGNAME': 'cltbld', 02:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:23 INFO - 'MOZ_NO_REMOTE': '1', 02:13:23 INFO - 'NO_EM_RESTART': '1', 02:13:23 INFO - 'PAGER': '/bin/cat', 02:13:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:23 INFO - 'PWD': '/builds/slave/test', 02:13:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:23 INFO - 'SHELL': '/bin/bash', 02:13:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Aw7UPUHeNO/Listeners', 02:13:23 INFO - 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', 02:13:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:23 INFO - 'USER': 'cltbld', 02:13:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:23 INFO - 'XPC_FLAGS': '0x0', 02:13:23 INFO - 'XPC_SERVICE_NAME': '0', 02:13:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:24 INFO - Downloading/unpacking psutil>=0.7.1 02:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:26 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:13:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:13:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:13:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:13:27 INFO - Installing collected packages: psutil 02:13:27 INFO - Running setup.py install for psutil 02:13:27 INFO - building 'psutil._psutil_osx' extension 02:13:27 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 02:13:27 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 02:13:27 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 02:13:27 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 02:13:27 INFO - building 'psutil._psutil_posix' extension 02:13:27 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 02:13:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:13:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:13:27 INFO - ^ 02:13:27 INFO - 1 warning generated. 02:13:27 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 02:13:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:13:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:13:28 INFO - Successfully installed psutil 02:13:28 INFO - Cleaning up... 02:13:28 INFO - Return code: 0 02:13:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:13: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')]} 02:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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')]} 02:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:28 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 0x100f10a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde30cea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec59f0>, '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 0x100c24cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e8f990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.klHMMKfvwC/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.Aw7UPUHeNO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:13:28 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 02:13:28 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 02:13:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.klHMMKfvwC/Render', 02:13:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:28 INFO - 'HOME': '/Users/cltbld', 02:13:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:28 INFO - 'LOGNAME': 'cltbld', 02:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:28 INFO - 'MOZ_NO_REMOTE': '1', 02:13:28 INFO - 'NO_EM_RESTART': '1', 02:13:28 INFO - 'PAGER': '/bin/cat', 02:13:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:28 INFO - 'PWD': '/builds/slave/test', 02:13:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:28 INFO - 'SHELL': '/bin/bash', 02:13:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Aw7UPUHeNO/Listeners', 02:13:28 INFO - 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', 02:13:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:28 INFO - 'USER': 'cltbld', 02:13:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:28 INFO - 'XPC_FLAGS': '0x0', 02:13:28 INFO - 'XPC_SERVICE_NAME': '0', 02:13:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:13:28 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 02:13:28 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 02:13:28 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 02:13:28 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 02:13:28 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 02:13:28 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 02:13:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:13:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:13:31 INFO - Installing collected packages: mozsystemmonitor 02:13:31 INFO - Running setup.py install for mozsystemmonitor 02:13:31 INFO - Successfully installed mozsystemmonitor 02:13:31 INFO - Cleaning up... 02:13:31 INFO - Return code: 0 02:13:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x100f10a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde30cea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec59f0>, '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 0x100c24cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e8f990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.klHMMKfvwC/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.Aw7UPUHeNO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:13:31 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 02:13:31 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 02:13:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.klHMMKfvwC/Render', 02:13:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:31 INFO - 'HOME': '/Users/cltbld', 02:13:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:31 INFO - 'LOGNAME': 'cltbld', 02:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:31 INFO - 'MOZ_NO_REMOTE': '1', 02:13:31 INFO - 'NO_EM_RESTART': '1', 02:13:31 INFO - 'PAGER': '/bin/cat', 02:13:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:31 INFO - 'PWD': '/builds/slave/test', 02:13:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:31 INFO - 'SHELL': '/bin/bash', 02:13:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Aw7UPUHeNO/Listeners', 02:13:31 INFO - 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', 02:13:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:31 INFO - 'USER': 'cltbld', 02:13:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:31 INFO - 'XPC_FLAGS': '0x0', 02:13:31 INFO - 'XPC_SERVICE_NAME': '0', 02:13:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:31 INFO - Downloading/unpacking blobuploader==1.2.4 02:13:31 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 02:13:31 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 02:13:31 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 02:13:31 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 02:13:31 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 02:13:31 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 02:13:34 INFO - Downloading blobuploader-1.2.4.tar.gz 02:13:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:13:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:13:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:13:34 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 02:13:34 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 02:13:34 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 02:13:34 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 02:13:34 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 02:13:34 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 02:13:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:13:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:13:35 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 02:13:35 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 02:13:35 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 02:13:35 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 02:13:35 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 02:13:35 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 02:13:35 INFO - Downloading docopt-0.6.1.tar.gz 02:13:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:13:36 INFO - Installing collected packages: blobuploader, requests, docopt 02:13:36 INFO - Running setup.py install for blobuploader 02:13:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:13:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:13:36 INFO - Running setup.py install for requests 02:13:36 INFO - Running setup.py install for docopt 02:13:37 INFO - Successfully installed blobuploader requests docopt 02:13:37 INFO - Cleaning up... 02:13:37 INFO - Return code: 0 02:13:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13: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')]} 02:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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')]} 02:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:37 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 0x100f10a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde30cea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec59f0>, '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 0x100c24cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e8f990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.klHMMKfvwC/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.Aw7UPUHeNO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:13:37 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 02:13:37 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 02:13:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.klHMMKfvwC/Render', 02:13:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:37 INFO - 'HOME': '/Users/cltbld', 02:13:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:37 INFO - 'LOGNAME': 'cltbld', 02:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:37 INFO - 'MOZ_NO_REMOTE': '1', 02:13:37 INFO - 'NO_EM_RESTART': '1', 02:13:37 INFO - 'PAGER': '/bin/cat', 02:13:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:37 INFO - 'PWD': '/builds/slave/test', 02:13:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:37 INFO - 'SHELL': '/bin/bash', 02:13:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Aw7UPUHeNO/Listeners', 02:13:37 INFO - 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', 02:13:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:37 INFO - 'USER': 'cltbld', 02:13:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:37 INFO - 'XPC_FLAGS': '0x0', 02:13:37 INFO - 'XPC_SERVICE_NAME': '0', 02:13:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:13:37 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-eoPGAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:13:37 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-TUvMMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:13:37 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-8XakYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:13:37 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-N0I29w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:13:38 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-VUY6tJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:13:38 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-YYyUJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:13:38 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-eY7Y0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:13:38 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-EYjK5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:13:38 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-isuxk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:13:38 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-76spYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:13:38 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-dJgQdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:13:39 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-OLI2Mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:13:39 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-1ihLSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:13:39 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-uFDG06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:39 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-VgtquG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:13:39 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-OtrNh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:13:39 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-H16i0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:13:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:13:39 INFO - Running setup.py install for manifestparser 02:13:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:13:40 INFO - Running setup.py install for mozcrash 02:13:40 INFO - Running setup.py install for mozdebug 02:13:40 INFO - Running setup.py install for mozdevice 02:13:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:13:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:13:40 INFO - Running setup.py install for mozfile 02:13:40 INFO - Running setup.py install for mozhttpd 02:13:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:13:40 INFO - Running setup.py install for mozinfo 02:13:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:13:41 INFO - Running setup.py install for mozInstall 02:13:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:13:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:13:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:13:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:13:41 INFO - Running setup.py install for mozleak 02:13:41 INFO - Running setup.py install for mozlog 02:13:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:13:41 INFO - Running setup.py install for moznetwork 02:13:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:13:41 INFO - Running setup.py install for mozprocess 02:13:42 INFO - Running setup.py install for mozprofile 02:13:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:13:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:13:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:13:42 INFO - Running setup.py install for mozrunner 02:13:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:13:42 INFO - Running setup.py install for mozscreenshot 02:13:42 INFO - Running setup.py install for moztest 02:13:42 INFO - Running setup.py install for mozversion 02:13:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:13:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:13:43 INFO - Cleaning up... 02:13:43 INFO - Return code: 0 02:13:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:43 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')]} 02:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:43 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')]} 02:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:43 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 0x100f10a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde30cea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec59f0>, '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 0x100c24cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e8f990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.klHMMKfvwC/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.Aw7UPUHeNO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:13:43 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 02:13:43 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 02:13:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.klHMMKfvwC/Render', 02:13:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:43 INFO - 'HOME': '/Users/cltbld', 02:13:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:43 INFO - 'LOGNAME': 'cltbld', 02:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:43 INFO - 'MOZ_NO_REMOTE': '1', 02:13:43 INFO - 'NO_EM_RESTART': '1', 02:13:43 INFO - 'PAGER': '/bin/cat', 02:13:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:43 INFO - 'PWD': '/builds/slave/test', 02:13:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:43 INFO - 'SHELL': '/bin/bash', 02:13:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Aw7UPUHeNO/Listeners', 02:13:43 INFO - 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', 02:13:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:43 INFO - 'USER': 'cltbld', 02:13:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:43 INFO - 'XPC_FLAGS': '0x0', 02:13:43 INFO - 'XPC_SERVICE_NAME': '0', 02:13:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:13:43 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-IjuPCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:13:43 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)) 02:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:13:43 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-rFLxtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:13:43 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)) 02:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:13:43 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-tDyDqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:13:43 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)) 02:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:13:43 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-vWZm1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:13:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:13:44 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-KT8zVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:13:44 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)) 02:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:13:44 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-Vn95Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:13:44 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)) 02:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:13:44 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-cB2Dc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:13:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:13:44 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-yXeg9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:13:44 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)) 02:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:13:44 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-8pqhok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:13:44 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)) 02:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:13:44 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-frifp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:13:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:13:44 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-7Tbc6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:13:44 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)) 02:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:13:45 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-f6UTdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:13:45 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)) 02:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:13:45 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-MCn5qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:13:45 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)) 02:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:13:45 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-ACGI_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:13:45 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)) 02:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:45 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-_LYf5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:45 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)) 02:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:13:45 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-z1TjJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:13:45 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)) 02:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:13:45 INFO - Running setup.py (path:/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/pip-mjAiht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:13:45 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)) 02:13:45 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)) 02:13:45 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)) 02:13:45 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)) 02:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:13:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:13:45 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 02:13:45 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 02:13:45 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 02:13:45 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 02:13:45 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 02:13:45 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 02:13:48 INFO - Downloading blessings-1.5.1.tar.gz 02:13:48 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 02:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:13:48 INFO - Installing collected packages: blessings 02:13:48 INFO - Running setup.py install for blessings 02:13:48 INFO - Successfully installed blessings 02:13:48 INFO - Cleaning up... 02:13:48 INFO - Return code: 0 02:13:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:13:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:13:49 INFO - Reading from file tmpfile_stdout 02:13:49 INFO - Current package versions: 02:13:49 INFO - blessings == 1.5.1 02:13:49 INFO - blobuploader == 1.2.4 02:13:49 INFO - docopt == 0.6.1 02:13:49 INFO - manifestparser == 1.1 02:13:49 INFO - mozInstall == 1.12 02:13:49 INFO - mozcrash == 0.16 02:13:49 INFO - mozdebug == 0.1 02:13:49 INFO - mozdevice == 0.46 02:13:49 INFO - mozfile == 1.2 02:13:49 INFO - mozhttpd == 0.7 02:13:49 INFO - mozinfo == 0.8 02:13:49 INFO - mozleak == 0.1 02:13:49 INFO - mozlog == 3.0 02:13:49 INFO - moznetwork == 0.27 02:13:49 INFO - mozprocess == 0.22 02:13:49 INFO - mozprofile == 0.27 02:13:49 INFO - mozrunner == 6.11 02:13:49 INFO - mozscreenshot == 0.1 02:13:49 INFO - mozsystemmonitor == 0.0 02:13:49 INFO - moztest == 0.7 02:13:49 INFO - mozversion == 1.4 02:13:49 INFO - psutil == 3.1.1 02:13:49 INFO - requests == 1.2.3 02:13:49 INFO - wsgiref == 0.1.2 02:13:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:49 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')]} 02:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:49 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')]} 02:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:49 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 0x100f10a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f7d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde30cea480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ec59f0>, '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 0x100c24cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e8f990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.klHMMKfvwC/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.Aw7UPUHeNO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:13:49 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 02:13:49 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 02:13:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.klHMMKfvwC/Render', 02:13:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:49 INFO - 'HOME': '/Users/cltbld', 02:13:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:49 INFO - 'LOGNAME': 'cltbld', 02:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:49 INFO - 'MOZ_NO_REMOTE': '1', 02:13:49 INFO - 'NO_EM_RESTART': '1', 02:13:49 INFO - 'PAGER': '/bin/cat', 02:13:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:49 INFO - 'PWD': '/builds/slave/test', 02:13:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:49 INFO - 'SHELL': '/bin/bash', 02:13:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Aw7UPUHeNO/Listeners', 02:13:49 INFO - 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', 02:13:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:49 INFO - 'USER': 'cltbld', 02:13:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:49 INFO - 'XPC_FLAGS': '0x0', 02:13:49 INFO - 'XPC_SERVICE_NAME': '0', 02:13:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:49 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)) 02:13:49 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)) 02:13:49 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)) 02:13:49 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)) 02:13:49 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)) 02:13:49 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)) 02:13:49 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)) 02:13:49 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)) 02:13:49 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)) 02:13:49 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)) 02:13:49 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)) 02:13:49 INFO - Cleaning up... 02:13:49 INFO - Return code: 0 02:13:49 INFO - Running post-action listener: _resource_record_post_action 02:13:49 INFO - Running post-action listener: _start_resource_monitoring 02:13:49 INFO - Starting resource monitoring. 02:13:49 INFO - ##### 02:13:49 INFO - ##### Running install step. 02:13:49 INFO - ##### 02:13:49 INFO - Running pre-action listener: _resource_record_pre_action 02:13:49 INFO - Running main action method: install 02:13:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:13:49 INFO - Reading from file tmpfile_stdout 02:13:49 INFO - Detecting whether we're running mozinstall >=1.0... 02:13:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:13:50 INFO - Reading from file tmpfile_stdout 02:13:50 INFO - Output received: 02:13:50 INFO - Usage: mozinstall [options] installer 02:13:50 INFO - Options: 02:13:50 INFO - -h, --help show this help message and exit 02:13:50 INFO - -d DEST, --destination=DEST 02:13:50 INFO - Directory to install application into. [default: 02:13:50 INFO - "/builds/slave/test"] 02:13:50 INFO - --app=APP Application being installed. [default: firefox] 02:13:50 INFO - mkdir: /builds/slave/test/build/application 02:13:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:14:30 INFO - Reading from file tmpfile_stdout 02:14:30 INFO - Output received: 02:14:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:14:30 INFO - Running post-action listener: _resource_record_post_action 02:14:30 INFO - ##### 02:14:30 INFO - ##### Running run-tests step. 02:14:30 INFO - ##### 02:14:30 INFO - Running pre-action listener: _resource_record_pre_action 02:14:30 INFO - Running main action method: run_tests 02:14:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:14:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:14:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:14:31 INFO - 2015-11-03 02:14:31.015 screenresolution[2211:19027] starting screenresolution argv=screenresolution get 02:14:31 INFO - 2015-11-03 02:14:31.019 screenresolution[2211:19027] Display 0: 1600x1200x32@60 02:14:31 INFO - 2015-11-03 02:14:31.026 screenresolution[2212:19029] starting screenresolution argv=screenresolution list 02:14:31 INFO - Available Modes on Display 0 02:14:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:14:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:14:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:14:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:14:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:14:31 INFO - Intel HD Graphics 3000: 02:14:31 INFO - Chipset Model: Intel HD Graphics 3000 02:14:31 INFO - Type: GPU 02:14:31 INFO - Bus: Built-In 02:14:31 INFO - VRAM (Total): 512 MB 02:14:31 INFO - VRAM (Dynamic, Max): 10 02:14:31 INFO - Vendor: Intel (0x8086) 02:14:31 INFO - Device ID: 0x0116 02:14:31 INFO - Revision ID: 0x0009 02:14:31 INFO - Displays: 02:14:31 INFO - Display: 02:14:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:14:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:14:31 INFO - Display Serial Number: 1600x1200 60 02:14:31 INFO - Main Display: Yes 02:14:31 INFO - Mirror: Off 02:14:31 INFO - Online: Yes 02:14:31 INFO - Rotation: Supported 02:14:31 INFO - Return code: 0 02:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:14:31 INFO - Python 2.7.3 02:14:31 INFO - Return code: 0 02:14:31 INFO - grabbing minidump binary from tooltool 02:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:31 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 0x100ec59f0>, '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 0x100c24cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e8f990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:14:31 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 02:14:31 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 02:14:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:14:31 INFO - Return code: 0 02:14:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:14:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:14:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:14:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:14:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0089', '--webServer', 'localhost'] in /builds/slave/test/build 02:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0089 --webServer localhost 02:14:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.klHMMKfvwC/Render', 02:14:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:31 INFO - 'HOME': '/Users/cltbld', 02:14:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:31 INFO - 'LOGNAME': 'cltbld', 02:14:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:14:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:31 INFO - 'MOZ_NO_REMOTE': '1', 02:14:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:14:31 INFO - 'NO_EM_RESTART': '1', 02:14:31 INFO - 'PAGER': '/bin/cat', 02:14:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:31 INFO - 'PWD': '/builds/slave/test', 02:14:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:14:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:31 INFO - 'SHELL': '/bin/bash', 02:14:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Aw7UPUHeNO/Listeners', 02:14:31 INFO - 'TMPDIR': '/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/', 02:14:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:31 INFO - 'USER': 'cltbld', 02:14:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:31 INFO - 'XPC_FLAGS': '0x0', 02:14:31 INFO - 'XPC_SERVICE_NAME': '0', 02:14:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:14:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0089', '--webServer', 'localhost'] with output_timeout 3600 02:14:31 INFO - mozversion INFO | application_buildid: 20151103002805 02:14:31 INFO - mozversion INFO | application_changeset: 56e2e69aea4d8e87652f560a72c5dc7376d834ad 02:14:31 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:14:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:14:31 INFO - mozversion INFO | application_name: Firefox 02:14:31 INFO - mozversion INFO | application_remotingname: firefox-dev 02:14:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:14:31 INFO - mozversion INFO | application_vendor: Mozilla 02:14:31 INFO - mozversion INFO | application_version: 44.0a2 02:14:31 INFO - mozversion INFO | platform_buildid: 20151103002805 02:14:31 INFO - mozversion INFO | platform_changeset: 56e2e69aea4d8e87652f560a72c5dc7376d834ad 02:14:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:14:31 INFO - mozversion INFO | platform_version: 44.0a2 02:14:31 INFO - 2015-11-03 02:14:31,695 DEBUG : using testdate: 1446545671 02:14:31 INFO - 2015-11-03 02:14:31,695 DEBUG : actual date: 1446545671 02:14:31 INFO - 2015-11-03 02:14:31,705 INFO : starting webserver on 'localhost:57288' 02:14:31 INFO - 2015-11-03 02:14:31,706 INFO : Starting test suite t-yosemite-r5-0089 02:14:31 INFO - 2015-11-03 02:14:31,707 INFO : Starting test dromaeo_css 02:14:31 INFO - 2015-11-03 02:14:31,707 DEBUG : operating with platform_type : mac_ 02:14:31 INFO - 2015-11-03 02:14:31,708 INFO : Initialising browser for dromaeo_css test... 02:14:31 INFO - 2015-11-03 02:14:31,723 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/tmpxxKaHw/profile http://localhost:57288/getInfo.html 02:14:34 INFO - 2015-11-03 02:14:34,343 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:14:34 INFO - 2015-11-03 02:14:34,344 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:14:34 INFO - 2015-11-03 02:14:34,344 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:14:34 INFO - 2015-11-03 02:14:34,344 DEBUG : BROWSER_OUTPUT: __metrics 02:14:34 INFO - 2015-11-03 02:14:34,364 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:14:35 INFO - 2015-11-03 02:14:35,127 INFO : Browser initialized. 02:14:35 INFO - 2015-11-03 02:14:35,128 INFO : Running cycle 1/1 for dromaeo_css test... 02:14:35 INFO - 2015-11-03 02:14:35,128 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/tmpxxKaHw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:14:47 INFO - 2015-11-03 02:14:47,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 200941568 02:14:47 INFO - 2015-11-03 02:14:47,186 DEBUG : BROWSER_OUTPUT: 02:15:39 INFO - 2015-11-03 02:15:39,001 DEBUG : BROWSER_OUTPUT: 1446545738996 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] 02:17:49 INFO - 2015-11-03 02:17:49,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57288/tests/dromaeo/cssquery-ext.html) 02:17:50 INFO - 2015-11-03 02:17:50,664 DEBUG : BROWSER_OUTPUT: RSS: Main: 322621440 02:17:50 INFO - 2015-11-03 02:17:50,664 DEBUG : BROWSER_OUTPUT: 02:20:53 INFO - 2015-11-03 02:20:53,502 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/dromaeo/cssquery-ext.html (next: http://localhost:57288/tests/dromaeo/cssquery-jquery.html) 02:20:54 INFO - 2015-11-03 02:20:54,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 341929984 02:20:54 INFO - 2015-11-03 02:20:54,082 DEBUG : BROWSER_OUTPUT: 02:23:56 INFO - 2015-11-03 02:23:56,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57288/tests/dromaeo/cssquery-mootools.html) 02:23:56 INFO - 2015-11-03 02:23:56,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 308465664 02:23:56 INFO - 2015-11-03 02:23:56,904 DEBUG : BROWSER_OUTPUT: 02:26:58 INFO - 2015-11-03 02:26:58,914 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57288/tests/dromaeo/cssquery-prototype.html) 02:26:59 INFO - 2015-11-03 02:26:59,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 302080000 02:26:59 INFO - 2015-11-03 02:26:59,499 DEBUG : BROWSER_OUTPUT: 02:30:02 INFO - 2015-11-03 02:30:02,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57288/tests/dromaeo/cssquery-yui.html) 02:30:03 INFO - 2015-11-03 02:30:03,245 DEBUG : BROWSER_OUTPUT: RSS: Main: 303448064 02:30:03 INFO - 2015-11-03 02:30:03,245 DEBUG : BROWSER_OUTPUT: 02:33:05 INFO - 2015-11-03 02:33:05,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/dromaeo/cssquery-yui.html (next: http://localhost:57288/tests/dromaeo/cssquery-dojo.html) 02:33:06 INFO - 2015-11-03 02:33:06,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 352952320 02:33:06 INFO - 2015-11-03 02:33:06,102 DEBUG : BROWSER_OUTPUT: 02:33:06 INFO - 2015-11-03 02:33:06,102 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:33:06 INFO - 2015-11-03 02:33:06,102 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:33:06 INFO - 2015-11-03 02:33:06,103 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:33:06 INFO - 2015-11-03 02:33:06,103 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:33:06 INFO - 2015-11-03 02:33:06,106 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2715.9321016974573;2810.016494227022;2847.5016872047386;2854.3292326303304;2877.2662970942415;4743.122522333367;4796.232602783547;4803.111424386491;4862.392200974874;4864.537868902448;4807.807687692497;4811.109944660231;4821.469638339789;4822.734749588772;4877.195262781645;4358.346248062784;4500.842470513533;4506.414166158394;4537.954620453786;4581.381513495686;4357.673174511909;4433.423654924855;4435.556444355571;4469.061497085616;4520.480144783359;4390.868273951786;4450.132224216279;4451.732896026233;4462.910741785162;4534.433195850519;4535.092981403733;4567.223571992769;4597.908041839161;4623.42207224097;4642.373279607244;3966.1869316790276;4288.849890253826;4386.758728269944;4427.1367083418745;4522.773861306954;4546.158960592301;4583.977080114611;4598.333241679971;4692.929606055912;4737.407824021997;5037.219231019198;5039.697618142924;5042.042012017741;5049.671771334852;5078.7460626968505;4793.616510679172;5010.924836127461;5050.7222102784335;5072.568831649314;5086.79652813887;4579.542045795394;4592.7933243004145;4628.305754136873;4676.5089665584965;4743.620510359163;5225.372955245319;5306.840794776086;5330.893382132335;5341.465853414627;5398.4871437213405;4730.479647238801;5042.722650254198;5042.84871453857;5083.2883396323805;5085.593152547787;4961.677490963148;5025.874353141127;5042.722650254272;5059.988002399535;5075.8223462179385;5032.622553308516;5038.445770965191;5133.307003554547;5142.30578871855;5183.922241166386;4756.7859446325;5071.797128114834;5124.590032797368;5136.357955255593;5153.793848246029;3884.514435695538;3889.630485103911;3899.727019108635;3929.410588411761;4004.839806407769;3552.5381700379303;3564.8752293669595;3567.8751243706865;3594.5686517618055;3640.508531348287;4479.238529450001;4809.567138957511;4869.391326084239;4870.732109733999;4877.804887804448;5026.698398096126;5059.772310246048;5095.133827249377;5154.639175257696;5194.68831870089;4736.076465089343;4772.164871147535;4789.377380940456;4835.274708793709;4851.781669824866;4201.075763332062;4494.617957473652;4520.073384956077;4523.84166554169;4532.9773351133035;4981;5035.697858128524;5072.6195535335;5082.974585127125;5083.110455670169;5197.688138711689;5219.634625576173;5230.8169214077325;5232.581393488588;5236.764345604381;5194.506521880416;5266.289050978069;5270.604704647243;5277.28756617867;5300.337457817773;4872.366592342973;4888.340074089952;4912.0175964807895;4990.750462476789;5019.196928491424;4952.653314267966;5199.66202196856;5208.453112423293;5215;5219.034478621467;5043.773030213576;5050.242463630485;5059.342285502861;5072.137736584863;5111.46329635383;4780.713157210578;4852.272159176152;4896.216605343128;4904.803807847647;5048.040872234264;4854.150523658416;4892.2661600760175;4968.975155124202;4970.055689418999;5006.048850718352;5048.318477005704;5070.4676009019995;5072.112380333353;5078.771455284595;5107.974460127675;4682.976585117052;4774.379330686988;4778.354922085613;4962.776675049704;5019.974900125476 02:33:06 INFO - 2015-11-03 02:33:06,107 DEBUG : BROWSER_OUTPUT: |1;ext.html;488.58470300244784;498.33721150869326;498.3820063121728;513.6994858008065;521.1557277210919;28188.577171342422;29334.41331173378;34936.30127397454;35186.824065879635;35380.2923941521;37941.62058379415;38176.61823381765;38587.421188682194;38699.226015479675;38797.80601096997;7377.262273772633;7957.880631790514;8149.837003259931;8164.224398682116;8173.918260817375;7517.586532740725;9697.612095516171;9844.409335439897;9881.110700036996;10053.49732513375;9562.282828787835;9600.279979001569;9608.951955240214;9652.372595781288;9766.755831104208;7618.885716714254;7840.255175758294;9326.766830829216;9453.291003174754;9554.617815287414;9280.1647851693;9309.53452327381;9339;9471.052894710543;9477.573509192103;32932.83533582317;33447.83276083604;33483;33949.660503394894;34032.149196270046;2598.1296265751;2607.6610040694777;2661.161734053767;2764.156932135698;2874.9263442483953;24537.14120005791;24601.138960136308;24647.753522464725;25338.619920701203;25396;2078.4803799050237;2098.1607357057146;2110.693949377347;2118.766935637079;2141.2612648636195;237621;241142;241305;242308;242492;53361;56010.43989560134;56273;56437.43562564404;56628;50284.245736313984;65929;66961.66519167373;67002.32997670058;67530;15491.690166196839;15743.921280393524;15747.055176689435;15752.448664296924;15757.527274181793;11642.825357619642;11680.532778688927;11696.181267311207;11865.466054027589;11875.524979000917;18329.266829326945;18375.356862509747;18381;18389;18392.632147356977;7591.8861217081785;7746.30283274508;7748.108967468813;7838.608069596497;7894.21057894206;811.3428123220093;833.629035079396;868;872.4590753732599;957.1337939165066;25910.222693319232;28437;29304.56043159354;29603;29857.70142298549;791.8535071011881;892.9776755581163;944.7874228298577;955.9426434413957;1025.6153942271649;13774.242416667179;14108.788368174486;14462.27688615565;14540.927295363455;14581.489647862274;322031;329677;329958;331170;331684;52921.206181906535;52927.470725293024;53506.46493535015;53740.462595373545;53821.73089134607;1151.2574389518713;1196.132803717298;1281.5130250504749;1282.7242142939126;1428.9428422863177;26454.603180952687;27101.457970840867;27530.311742206606;27557.173284801487;28260;44666.10667786691;45054.54945450504;46245.53754462547;47227.52772472369;47625.285620715025;360011;363353;367974;368632;370092;36181.27637447184;37297.440538391405;37607.43588846115;37755;38815.80592097021;39134.804325978184;39197.41203881887;39730;39752.60247397489;39871.80064099661;32720.672793271762;33057.83471082629;33083.669163308055;33469.16327091842;33695.3260934775;33072;33097.338053238316;33106.5034024485;33193.842400243906;33408;32866.83566582152;33651.326973460884;33697.83151084229;33721.66278337185;34230.82884585561;26937.59593606058;29048.854755726086;29200.41599168047;29230.853845731486;29319.706802931698;21618.891905541;21999.450013749785;22206.77793222047;22321.553568928204;22448.77551224467 02:33:06 INFO - 2015-11-03 02:33:06,109 DEBUG : BROWSER_OUTPUT: |2;jquery.html;277.59260549016483;277.76667599216654;277.8291350819247;280.5133094081768;286.0389092648701;10151.137153341957;10797.190210734207;15051.548453546397;15619;15662.686746265068;16951.49145525636;17032.48902532923;17168.39910603129;17206.13969301533;17563.121843907786;4816.759162041902;4925.33507976424;4939.950600493985;4996.975015124919;5034.773435195425;4869.196582563873;4871.488493708145;4887.7311747853855;4929.457759646436;4933.407991041062;3594.676479116879;3757.380032294668;4699.436067671884;4823.276508523714;4863.659543831933;5344.4922732340365;5358.758855851457;5363.973180134113;5428.348598168225;5465.781368745245;4639;4768.523147685204;4799.664023518355;4836.081144582518;4841.3222148899185;20344;20380.898095509576;20602.793972060237;20668;20749.066292016894;969.8690676758617;1794.7487351770762;1801.2254730465895;1901.486598618379;1949.4736421166206;12271.509139634403;12342.95084917783;12349.382530873421;12626.936865315614;13130.474781008748;1523.7790520374595;1530.036077271312;1534.3479021415853;1545.3895711194127;1562.5156201577547;54390.18414723782;55039.44960550383;55242.171367429524;56715.43284567143;57136.42863571394;9434.95282523583;9506.809863802824;9604.711858644252;9691.370060946016;9735.805283894424;12041;12061.85412385822;12221.877781222252;12230.449629766681;12247.448864800926;7433.4053275737815;7436.442266829901;7441;7483.962580187064;7504.362129218968;7299.978003079573;7317.085364329459;7352.889706654404;7355.926440735631;7433.888491672629;5517.503424691797;5599.356074051536;5601.5238704709745;5657.632253903483;5730.08318669011;1538.4461593826213;1616.3453801210528;1682.9831701683072;1687.4515782370534;1725.0943254791334;356.6112936898793;357.05558796982353;373.25908072476113;383.2258837148999;384.61730578074435;9982;10525.894741052645;10565.735856603493;10591.20565957541;10617.309874858109;376.98869033929026;393.92121575684405;399.6143721308951;404.31065034117347;405.1168452772983;5478.698671573102;5572.192032155314;5607.831765047055;5637.633553818989;5647.519960803378;498493;503758;511216;515414;516809;62836;64434;64596;64875;66403.33596663972;455.3033858196964;456.2084782901663;457.51046380373344;457.98397056102874;464.38932803364145;9285.164335209864;9625.181859541737;9778.608855645694;9849.950750246202;9973.950130249303;29041.41917161687;30678.846605766827;30729.846350768104;31656.841715791274;32106.357872841945;42666.78666606647;43040;43083.35374969315;43230;43266.35100473432;5353.518183363516;5655.293088363955;5689.260396148474;5736.311642602747;5798.188253644409;10217.846732299171;10371.896281037394;10495.107915826935;10511.526981286013;10655.946720266349;8762.299016078827;8862.379633425857;8886.688965886164;9073.364864459689;9169.174774270348;8827.293816494794;8846.778830529289;8906.73279801607;8936.195742383217;8937.642494300155;9174;9366;9377.484238366955;9452.480113593543;9500.239980801658;5017.498250174954;5017.799288028438;5594.692291923983;5597.132444471114;5599.384067752462;8975.32685048611;8992.145746154105;9237.722868313962;9262.39794413361;9288.860667090134 02:33:06 INFO - 2015-11-03 02:33:06,112 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1222.8349172861663;1298.714282857771;1336.4787732784216;1359.8912087033038;1584.477122549558;5899.557533185007;6117.724702388392;6356.396142366473;6545.574537655049;6632.834179145524;6419.422251997319;6530.70611822468;6566;6576.177977752781;6663.100481435004;1886.5849513107094;1907.8759880607786;1921.1354890299351;1921.7309576659209;1930.3436831477295;1920.270297287029;1922.3848368522079;1924.894130822804;1927.9036048197604;1934.1103092577362;1854.545636319097;1856.5358660334916;1866.4120801947342;1874.8500119990367;1888.046536499073;1832.1938347127289;1859.7024476083761;1865.272543707955;1867.6451474219855;1884.387574038443;1808.94573162804;1819.754333165019;1821.6174603333316;1847.2333981397837;1875.0905810681809;5687.886242275173;6468.256150542654;6497.090407342976;6520.836979075513;6578.407943285128;3564.1624218308934;3705.6294370562728;3794.829232684536;3799.9240015199543;3846.11539345952;2431.4043059450546;2479.157086590568;2501.58723810571;2503.874806259698;2521.6091505816626;731.7365748330596;742.6027075514573;748.5022460064105;751.4927423988786;752.3229093815555;8637.956810215908;8639.65441382344;8642.178992995656;8659.04750477447;8763.956180219122;3626.9818650906577;3628.600853906068;3677.742558020913;3696.77819330841;3715.21980384117;7643.923560764321;7669.271419215165;7676.19399963007;7726;7804.960975195201;4103.384492326175;4114.1977314424;4115.34154535273;4162.854300099542;4166.604172603597;3741.831617577161;3748.250349930025;3767.962320376816;3791.9431208531896;3798.2593394287846;2856.243095579673;2896.4786338458857;2930.4285664295685;2951.2031751426994;2985.462616728966;974.488393593355;983.2969426859829;984.9704508864745;992.3202606214766;997.3766396002499;849.9660013599387;875.7941883657336;876.7764220123828;889.4840992224495;948.1277224952922;6303.495720342362;6427.903581446282;6445.1943507061615;6494.772682956168;6496.480281577463;888.2849306308354;923.7459698582809;1001.62439085343;1006.4514839412537;1033.4625994482976;4850.927236091461;4930.13722598551;4975.228839529878;4977.0792403405485;5047.091523525727;7253.347198752138;7522.473426860177;7551.5846628434865;7730.226977302224;7743.651535680795;7559.584222867685;7659.693612255559;7693.807654808675;7752.7286544971785;7788.14330423653;6211.81364559064;6371.139896114058;6379.64911929839;6466.288708242089;6486.740530378826;6285.182926219745;6326.715297811517;6336.1446204763615;6409.679516024087;6424.903626445701;7116.964415177891;7167.892481612885;7222.819429514304;7302.926970730225;7309.342159205697;7289;7344.449166312441;7346;7400.851982960418;7495.287947644965;5693.5160511357;5760.251167348386;5766.740496677576;5784.479396854304;5797.710114494174;6419.133416988833;6469.288378278292;6481.189851268591;6483.2544257411;6557.114789503356;6032.426919442646;6045.183900173421;6084.117802918464;6090.573659843945;6101.115338276014;5769.682667453162;5781.132830075522;5828.504577110823;5968.612040217372;6111.724972376165;5855.502282306052;5893.734781934738;5943.732532036155;5956.285245770535;5990.9700451497465;5223.764930578209;5315.202719592092;5316.946830531645;5393.757280922289;5405.86485337854;5528.778848846162;5555.861103472445;5576;5630.718464076862;5639.6334238274385 02:33:06 INFO - 2015-11-03 02:33:06,113 DEBUG : BROWSER_OUTPUT: |4;prototype.html;251.7055045596652;258.7373815577189;259.46550106780035;263.51907768322815;263.79160463234047;5205.3233079699585;5317.734113294339;5345.037893179227;5369.5704343652515;5416.187571864222;5137.51193636604;5221.791128354871;5259.158534634459;5312.096943519601;5354.732263386825;4052.53395859477;4058.086930440657;4104.8563300284495;4126.2160189563965;4132.5454200037975;4004.4593979812644;4031.5162180538377;4059.025833799896;4061.0659548303906;4132.049628585427;4024.3158663027357;4056.3509838425857;4067.5118985721756;4089.20260549193;4097.467329247193;4028.03327201471;4043.7573745575064;4070.8778736637946;4089.1821635672986;4111.444954931076;3462.2036931505645;3476;3495.8252087395526;3503.7372197085065;3516.6834984851484;5053.393592768854;5096.133657278235;5106.744662766884;5118.667286626357;5200.713960732158;4414.271645178542;4446.088551846864;4470.374147619336;4475.485319188302;4478.664100192498;5469.398366179717;5482.945170548283;5551.028570000234;5563.527100196488;5589.965856316554;3469.60099588548;3548.414511605582;3583.4266517357096;3673.7061035117126;3676.099355657854;5708.4291570843;5708.857278568069;5817.0983497557945;5822.970885145547;5891.882162356772;3667.156553992597;3670.9816450917574;3720.4605332226674;3744.344739670547;3750.4374343848094;3714.23858109087;3715.8327875245677;3724.1992971511254;3769.151940813295;3792.0898984244136;4305.784710764512;4413;4424.402705634762;4426.358178064227;4459.152760975404;5493.835184944378;5601.467860553241;5604.8038318658655;5618.185363122325;5619;1326.6683329167709;1338.2238301784942;1338.7991801229698;1357.077187512501;1365.378752667534;843.4896887383045;851.9350811485643;858.1847245117164;865.2126564825978;877.1754550722428;5204.635675502678;5350.946490535122;5380.515753582196;5426.457354264542;5430.864228394322;5820.214271073351;5837.182794408786;5872.0898260769645;5872.119182122716;5910.497607703393;5370.624056316098;5388.084025715638;5408.215808707794;5419.593530485229;5445.482679145475;3071.5239137933654;3183;3193.9840300798346;3204.83975801209;3248.480243161083;5790.420957904176;5833.591648584558;5919.3192782829665;5938.257717785277;5939.13882487037;5914.852128696731;5941.792037278675;5953.642781433128;5987.221661184019;6002.4897883679505;5637.718114094197;5862.12068189775;5928.347881733006;5936.614120082095;5937.465628093492;5821.301443826768;5823.068309070529;5883.911741323798;5890.941090589039;5895.263092113486;5560.638558493685;5668.433156684298;5701;5714.742836572281;5756.021476348947;5836.124581312667;5855.912161317498;5872.1778950946045;5922.407759224043;5969.224000879858;3605.2248766515327;3628;3658.414653655402;3682.0058584181584;3706.8331925063976;5812.18629391894;5823.010088284917;5824.9417505826095;5838.1826544282985;5843.912341314799;5570.5543556516195;5620.297462817148;5708.143778433268;5715.971420142872;5726.341470730753;5622.85942851432;5622.887542249214;5646.830595082154;5674.687892165971;5705.971470142623;5518.392976772632;5542.667439953616;5545.473180047889;5552.472515111058;5578.051731205624;5515.558755299647;5577.52591029767;5614.9719251403485;5678.4605462480995;5716.514096301695;5528.502434780889;5576.860578485408;5637.069883469182;5654.378018417889;5657.038303488499 02:33:06 INFO - 2015-11-03 02:33:06,117 DEBUG : BROWSER_OUTPUT: |5;yui.html;565.2962062232518;589.5961266532423;603.4990957505271;655.3021032600284;664.7772996046326;12249.142560020802;12690.873091269084;12718;12730.427130779113;12777.552785652504;11491.138164637643;11602.651920442378;11626.360550169737;11629.592964246252;11644.068474522039;612.1827360473761;622.1352320274822;758.3516093739855;766.5362455714296;770.7687693691898;721.6103304215717;763.4541302968377;770.8997830282084;774.020863607537;774.6707649249075;628.1896353703717;634.2515831319041;789.72754399732;790.0716657926941;798.7124635131348;767.9155292917775;780.0249687890138;780.7969927818808;787.4055088408244;799.5003123048095;572.2274928846066;572.6392372805107;575.7610591604479;576.3400905962691;579.9797007104773;12014;12192.878071219264;12210.633680989584;12217.144799864012;12375.62873113808;8505.702300419518;8588.699395521127;8683.175098365646;9056.818863622757;9090.318226133066;7536.585487798169;7559.206283340225;7716.7684969451;7773.572453515055;7976.042874854997;2496.862672553009;2502.687164104487;2568.7944964402805;2609.8825552850167;2649.3641526033807;43436;44052.3392149118;44148.55851441476;44180.779096104634;44880.55119448829;6213.5339849510565;6278.497720182374;6279.246490421178;6354.682265886687;6524.9673751630935;10913.23607347494;10921;11075.05862001739;11093.500792464358;11105.944470277596;5483.067878460672;5550.583706221969;5715.428457154251;5721.713914304268;5753.424657534297;3240.4329242382487;3419.196488825124;3422.7261819054415;3430.073880052422;3550.0237434705145;2360.4924941137397;2377.429416939922;2378.9167379141995;2392.6889504364667;2395.8203134764963;311.83784432095183;312.59050643656883;313.50309759031734;314.2677561282207;315.9921001974923;409.1673444540406;430.71787978873886;523.3249108649799;528.3342987835279;529.684837521674;6708.932910670831;6793;6815.591064536144;6893.379595836399;6897.586144831326;394.3591663546737;516.8630312967067;555.3668817547998;557.289455943667;558.0540983033719;3019.637643482752;3127.6559578446354;3188.426083304981;3233.7736358455154;3314.7016768490953;50554.241686374735;51150.74424627853;51247.231291530654;51292.48707512952;55537.72231138899;46940.5305946943;49886;51299;51355.7432212844;52172.21741673878;45773.77113114413;45818.770906145925;45986.77006614945;46268;47628.52371476241;7215.494915355875;7224.638768061471;7241.637918104179;7460.738874139379;7466.440016998638;32002.359952800347;32368.35263294674;32584.34831303408;33041.173970649965;33061.66938330586;39963.80018099891;40473.39289910712;41167.1766564661;41287.38068929029;41361;9212.677556285498;9662.71011869645;9705;9763.511824408894;9828.213742900407;9285.442873427615;9713.805723885624;10047.598096076075;10077.344972576759;10097.141742951637;9230.261579073793;9326.207272381924;9526.285528585522;9673.661421850202;9812.607495700093;9187.632494700405;9238.445693258158;9446.24430045581;9769.609215631579;10178.592856285963;8942.722315123945;9107.134822191882;9151.862722059308;9170.633174673205;9210.585523651318;7639;7955.323797477048;7960.417592403155;8103.918960810316;8276.503409795432;7476.19689548597;7701.922980770345;8268.131846156068;8275.08974012846;8310.584470776557 02:33:06 INFO - 2015-11-03 02:33:06,117 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:33:06 INFO - 2015-11-03 02:33:06,117 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:33:06 INFO - 2015-11-03 02:33:06,117 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,992 02:33:06 INFO - 2015-11-03 02:33:06,118 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:33:06 INFO - 2015-11-03 02:33:06,118 DEBUG : BROWSER_OUTPUT: __startTimestamp1446546786101__endTimestamp 02:33:06 INFO - 2015-11-03 02:33:06,118 DEBUG : BROWSER_OUTPUT: 02:33:06 INFO - 2015-11-03 02:33:06,118 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:33:06 INFO - 2015-11-03 02:33:06,118 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:33:06 INFO - 2015-11-03 02:33:06,118 DEBUG : BROWSER_OUTPUT: 02:33:06 INFO - 2015-11-03 02:33:06,118 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4748.62 Median:4872.37 stddev:511.39 (10.5%) stddev-sans-first:487.47 02:33:06 INFO - 2015-11-03 02:33:06,119 DEBUG : BROWSER_OUTPUT: Values: 2715.9 2810.0 2847.5 2854.3 2877.3 4743.1 4796.2 4803.1 4862.4 4864.5 4807.8 4811.1 4821.5 4822.7 4877.2 4358.3 4500.8 4506.4 4538.0 4581.4 4357.7 4433.4 4435.6 4469.1 4520.5 4390.9 4450.1 4451.7 4462.9 4534.4 4535.1 4567.2 4597.9 4623.4 4642.4 3966.2 4288.8 4386.8 4427.1 4522.8 4546.2 4584.0 4598.3 4692.9 4737.4 5037.2 5039.7 5042.0 5049.7 5078.7 4793.6 5010.9 5050.7 5072.6 5086.8 4579.5 4592.8 4628.3 4676.5 4743.6 5225.4 5306.8 5330.9 5341.5 5398.5 4730.5 5042.7 5042.8 5083.3 5085.6 4961.7 5025.9 5042.7 5060.0 5075.8 5032.6 5038.4 5133.3 5142.3 5183.9 4756.8 5071.8 5124.6 5136.4 5153.8 3884.5 3889.6 3899.7 3929.4 4004.8 3552.5 3564.9 3567.9 3594.6 3640.5 4479.2 4809.6 4869.4 4870.7 4877.8 5026.7 5059.8 5095.1 5154.6 5194.7 4736.1 4772.2 4789.4 4835.3 4851.8 4201.1 4494.6 4520.1 4523.8 4533.0 4981.0 5035.7 5072.6 5083.0 5083.1 5197.7 5219.6 5230.8 5232.6 5236.8 5194.5 5266.3 5270.6 5277.3 5300.3 4872.4 4888.3 4912.0 4990.8 5019.2 4952.7 5199.7 5208.5 5215.0 5219.0 5043.8 5050.2 5059.3 5072.1 5111.5 4780.7 4852.3 4896.2 4904.8 5048.0 4854.2 4892.3 4969.0 4970.1 5006.0 5048.3 5070.5 5072.1 5078.8 5108.0 4683.0 4774.4 4778.4 4962.8 5020.0 02:33:06 INFO - 2015-11-03 02:33:06,119 DEBUG : BROWSER_OUTPUT: 02:33:06 INFO - 2015-11-03 02:33:06,119 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46932.88 Median:33835.66 stddev:83234.74 (246.0%) stddev-sans-first:83395.18 02:33:06 INFO - 2015-11-03 02:33:06,119 DEBUG : BROWSER_OUTPUT: Values: 488.6 498.3 498.4 513.7 521.2 28188.6 29334.4 34936.3 35186.8 35380.3 37941.6 38176.6 38587.4 38699.2 38797.8 7377.3 7957.9 8149.8 8164.2 8173.9 7517.6 9697.6 9844.4 9881.1 10053.5 9562.3 9600.3 9609.0 9652.4 9766.8 7618.9 7840.3 9326.8 9453.3 9554.6 9280.2 9309.5 9339.0 9471.1 9477.6 32932.8 33447.8 33483.0 33949.7 34032.1 2598.1 2607.7 2661.2 2764.2 2874.9 24537.1 24601.1 24647.8 25338.6 25396.0 2078.5 2098.2 2110.7 2118.8 2141.3 237621.0 241142.0 241305.0 242308.0 242492.0 53361.0 56010.4 56273.0 56437.4 56628.0 50284.2 65929.0 66961.7 67002.3 67530.0 15491.7 15743.9 15747.1 15752.4 15757.5 11642.8 11680.5 11696.2 11865.5 11875.5 18329.3 18375.4 18381.0 18389.0 18392.6 7591.9 7746.3 7748.1 7838.6 7894.2 811.3 833.6 868.0 872.5 957.1 25910.2 28437.0 29304.6 29603.0 29857.7 791.9 893.0 944.8 955.9 1025.6 13774.2 14108.8 14462.3 14540.9 14581.5 322031.0 329677.0 329958.0 331170.0 331684.0 52921.2 52927.5 53506.5 53740.5 53821.7 1151.3 1196.1 1281.5 1282.7 1428.9 26454.6 27101.5 27530.3 27557.2 28260.0 44666.1 45054.5 46245.5 47227.5 47625.3 360011.0 363353.0 367974.0 368632.0 370092.0 36181.3 37297.4 37607.4 37755.0 38815.8 39134.8 39197.4 39730.0 39752.6 39871.8 32720.7 33057.8 33083.7 33469.2 33695.3 33072.0 33097.3 33106.5 33193.8 33408.0 32866.8 33651.3 33697.8 33721.7 34230.8 26937.6 29048.9 29200.4 29230.9 29319.7 21618.9 21999.5 22206.8 22321.6 22448.8 02:33:06 INFO - 2015-11-03 02:33:06,119 DEBUG : BROWSER_OUTPUT: 02:33:06 INFO - 2015-11-03 02:33:06,120 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25655.74 Median:4879.61 stddev:83225.92 (1705.6%) stddev-sans-first:83437.57 02:33:06 INFO - 2015-11-03 02:33:06,121 DEBUG : BROWSER_OUTPUT: Values: 277.6 277.8 277.8 280.5 286.0 10151.1 10797.2 15051.5 15619.0 15662.7 16951.5 17032.5 17168.4 17206.1 17563.1 4816.8 4925.3 4940.0 4997.0 5034.8 4869.2 4871.5 4887.7 4929.5 4933.4 3594.7 3757.4 4699.4 4823.3 4863.7 5344.5 5358.8 5364.0 5428.3 5465.8 4639.0 4768.5 4799.7 4836.1 4841.3 20344.0 20380.9 20602.8 20668.0 20749.1 969.9 1794.7 1801.2 1901.5 1949.5 12271.5 12343.0 12349.4 12626.9 13130.5 1523.8 1530.0 1534.3 1545.4 1562.5 54390.2 55039.4 55242.2 56715.4 57136.4 9435.0 9506.8 9604.7 9691.4 9735.8 12041.0 12061.9 12221.9 12230.4 12247.4 7433.4 7436.4 7441.0 7484.0 7504.4 7300.0 7317.1 7352.9 7355.9 7433.9 5517.5 5599.4 5601.5 5657.6 5730.1 1538.4 1616.3 1683.0 1687.5 1725.1 356.6 357.1 373.3 383.2 384.6 9982.0 10525.9 10565.7 10591.2 10617.3 377.0 393.9 399.6 404.3 405.1 5478.7 5572.2 5607.8 5637.6 5647.5 498493.0 503758.0 511216.0 515414.0 516809.0 62836.0 64434.0 64596.0 64875.0 66403.3 455.3 456.2 457.5 458.0 464.4 9285.2 9625.2 9778.6 9850.0 9974.0 29041.4 30678.8 30729.8 31656.8 32106.4 42666.8 43040.0 43083.4 43230.0 43266.4 5353.5 5655.3 5689.3 5736.3 5798.2 10217.8 10371.9 10495.1 10511.5 10655.9 8762.3 8862.4 8886.7 9073.4 9169.2 8827.3 8846.8 8906.7 8936.2 8937.6 9174.0 9366.0 9377.5 9452.5 9500.2 5017.5 5017.8 5594.7 5597.1 5599.4 8975.3 8992.1 9237.7 9262.4 9288.9 02:33:06 INFO - 2015-11-03 02:33:06,121 DEBUG : BROWSER_OUTPUT: 02:33:06 INFO - 2015-11-03 02:33:06,121 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4602.62 Median:5950.01 stddev:2381.75 (40.0%) stddev-sans-first:2374.88 02:33:06 INFO - 2015-11-03 02:33:06,123 DEBUG : BROWSER_OUTPUT: Values: 1222.8 1298.7 1336.5 1359.9 1584.5 5899.6 6117.7 6356.4 6545.6 6632.8 6419.4 6530.7 6566.0 6576.2 6663.1 1886.6 1907.9 1921.1 1921.7 1930.3 1920.3 1922.4 1924.9 1927.9 1934.1 1854.5 1856.5 1866.4 1874.9 1888.0 1832.2 1859.7 1865.3 1867.6 1884.4 1808.9 1819.8 1821.6 1847.2 1875.1 5687.9 6468.3 6497.1 6520.8 6578.4 3564.2 3705.6 3794.8 3799.9 3846.1 2431.4 2479.2 2501.6 2503.9 2521.6 731.7 742.6 748.5 751.5 752.3 8638.0 8639.7 8642.2 8659.0 8764.0 3627.0 3628.6 3677.7 3696.8 3715.2 7643.9 7669.3 7676.2 7726.0 7805.0 4103.4 4114.2 4115.3 4162.9 4166.6 3741.8 3748.3 3768.0 3791.9 3798.3 2856.2 2896.5 2930.4 2951.2 2985.5 974.5 983.3 985.0 992.3 997.4 850.0 875.8 876.8 889.5 948.1 6303.5 6427.9 6445.2 6494.8 6496.5 888.3 923.7 1001.6 1006.5 1033.5 4850.9 4930.1 4975.2 4977.1 5047.1 7253.3 7522.5 7551.6 7730.2 7743.7 7559.6 7659.7 7693.8 7752.7 7788.1 6211.8 6371.1 6379.6 6466.3 6486.7 6285.2 6326.7 6336.1 6409.7 6424.9 7117.0 7167.9 7222.8 7302.9 7309.3 7289.0 7344.4 7346.0 7400.9 7495.3 5693.5 5760.3 5766.7 5784.5 5797.7 6419.1 6469.3 6481.2 6483.3 6557.1 6032.4 6045.2 6084.1 6090.6 6101.1 5769.7 5781.1 5828.5 5968.6 6111.7 5855.5 5893.7 5943.7 5956.3 5991.0 5223.8 5315.2 5316.9 5393.8 5405.9 5528.8 5555.9 5576.0 5630.7 5639.6 02:33:06 INFO - 2015-11-03 02:33:06,123 DEBUG : BROWSER_OUTPUT: 02:33:06 INFO - 2015-11-03 02:33:06,123 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4647.06 Median:5417.89 stddev:1445.89 (26.7%) stddev-sans-first:1411.80 02:33:06 INFO - 2015-11-03 02:33:06,125 DEBUG : BROWSER_OUTPUT: Values: 251.7 258.7 259.5 263.5 263.8 5205.3 5317.7 5345.0 5369.6 5416.2 5137.5 5221.8 5259.2 5312.1 5354.7 4052.5 4058.1 4104.9 4126.2 4132.5 4004.5 4031.5 4059.0 4061.1 4132.0 4024.3 4056.4 4067.5 4089.2 4097.5 4028.0 4043.8 4070.9 4089.2 4111.4 3462.2 3476.0 3495.8 3503.7 3516.7 5053.4 5096.1 5106.7 5118.7 5200.7 4414.3 4446.1 4470.4 4475.5 4478.7 5469.4 5482.9 5551.0 5563.5 5590.0 3469.6 3548.4 3583.4 3673.7 3676.1 5708.4 5708.9 5817.1 5823.0 5891.9 3667.2 3671.0 3720.5 3744.3 3750.4 3714.2 3715.8 3724.2 3769.2 3792.1 4305.8 4413.0 4424.4 4426.4 4459.2 5493.8 5601.5 5604.8 5618.2 5619.0 1326.7 1338.2 1338.8 1357.1 1365.4 843.5 851.9 858.2 865.2 877.2 5204.6 5350.9 5380.5 5426.5 5430.9 5820.2 5837.2 5872.1 5872.1 5910.5 5370.6 5388.1 5408.2 5419.6 5445.5 3071.5 3183.0 3194.0 3204.8 3248.5 5790.4 5833.6 5919.3 5938.3 5939.1 5914.9 5941.8 5953.6 5987.2 6002.5 5637.7 5862.1 5928.3 5936.6 5937.5 5821.3 5823.1 5883.9 5890.9 5895.3 5560.6 5668.4 5701.0 5714.7 5756.0 5836.1 5855.9 5872.2 5922.4 5969.2 3605.2 3628.0 3658.4 3682.0 3706.8 5812.2 5823.0 5824.9 5838.2 5843.9 5570.6 5620.3 5708.1 5716.0 5726.3 5622.9 5622.9 5646.8 5674.7 5706.0 5518.4 5542.7 5545.5 5552.5 5578.1 5515.6 5577.5 5615.0 5678.5 5716.5 5528.5 5576.9 5637.1 5654.4 5657.0 02:33:06 INFO - 2015-11-03 02:33:06,125 DEBUG : BROWSER_OUTPUT: 02:33:06 INFO - 2015-11-03 02:33:06,125 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12137.28 Median:561.68 stddev:15185.31 (2703.6%) stddev-sans-first:15203.04 02:33:06 INFO - 2015-11-03 02:33:06,126 DEBUG : BROWSER_OUTPUT: Values: 565.3 589.6 603.5 655.3 664.8 12249.1 12690.9 12718.0 12730.4 12777.6 11491.1 11602.7 11626.4 11629.6 11644.1 612.2 622.1 758.4 766.5 770.8 721.6 763.5 770.9 774.0 774.7 628.2 634.3 789.7 790.1 798.7 767.9 780.0 780.8 787.4 799.5 572.2 572.6 575.8 576.3 580.0 12014.0 12192.9 12210.6 12217.1 12375.6 8505.7 8588.7 8683.2 9056.8 9090.3 7536.6 7559.2 7716.8 7773.6 7976.0 2496.9 2502.7 2568.8 2609.9 2649.4 43436.0 44052.3 44148.6 44180.8 44880.6 6213.5 6278.5 6279.2 6354.7 6525.0 10913.2 10921.0 11075.1 11093.5 11105.9 5483.1 5550.6 5715.4 5721.7 5753.4 3240.4 3419.2 3422.7 3430.1 3550.0 2360.5 2377.4 2378.9 2392.7 2395.8 311.8 312.6 313.5 314.3 316.0 409.2 430.7 523.3 528.3 529.7 6708.9 6793.0 6815.6 6893.4 6897.6 394.4 516.9 555.4 557.3 558.1 3019.6 3127.7 3188.4 3233.8 3314.7 50554.2 51150.7 51247.2 51292.5 55537.7 46940.5 49886.0 51299.0 51355.7 52172.2 45773.8 45818.8 45986.8 46268.0 47628.5 7215.5 7224.6 7241.6 7460.7 7466.4 32002.4 32368.4 32584.3 33041.2 33061.7 39963.8 40473.4 41167.2 41287.4 41361.0 9212.7 9662.7 9705.0 9763.5 9828.2 9285.4 9713.8 10047.6 10077.3 10097.1 9230.3 9326.2 9526.3 9673.7 9812.6 9187.6 9238.4 9446.2 9769.6 10178.6 8942.7 9107.1 9151.9 9170.6 9210.6 7639.0 7955.3 7960.4 8103.9 8276.5 7476.2 7701.9 8268.1 8275.1 8310.6 02:33:06 INFO - 2015-11-03 02:33:06,126 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:33:06 INFO - 2015-11-03 02:33:06,126 DEBUG : BROWSER_OUTPUT: 02:33:06 INFO - 2015-11-03 02:33:06,805 INFO : Browser exited with error code: 0 02:33:06 INFO - 2015-11-03 02:33:06,837 INFO : Completed test dromaeo_css (00:18:35) 02:33:06 INFO - 2015-11-03 02:33:06,838 INFO : Starting test kraken 02:33:06 INFO - 2015-11-03 02:33:06,838 DEBUG : operating with platform_type : mac_ 02:33:06 INFO - 2015-11-03 02:33:06,838 INFO : Initialising browser for kraken test... 02:33:06 INFO - 2015-11-03 02:33:06,853 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/tmpQ40ZOc/profile http://localhost:57288/getInfo.html 02:33:09 INFO - 2015-11-03 02:33:09,314 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:33:09 INFO - 2015-11-03 02:33:09,314 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:33:09 INFO - 2015-11-03 02:33:09,314 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:33:09 INFO - 2015-11-03 02:33:09,314 DEBUG : BROWSER_OUTPUT: __metrics 02:33:09 INFO - 2015-11-03 02:33:09,332 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:33:10 INFO - 2015-11-03 02:33:10,095 INFO : Browser initialized. 02:33:10 INFO - 2015-11-03 02:33:10,095 INFO : Running cycle 1/1 for kraken test... 02:33:10 INFO - 2015-11-03 02:33:10,095 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/tmpQ40ZOc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:33:22 INFO - 2015-11-03 02:33:22,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 200441856 02:33:22 INFO - 2015-11-03 02:33:22,131 DEBUG : BROWSER_OUTPUT: 02:33:24 INFO - 2015-11-03 02:33:24,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57288/tests/kraken/driver.html?testName=audio-beat-detection) 02:33:25 INFO - 2015-11-03 02:33:25,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 266633216 02:33:25 INFO - 2015-11-03 02:33:25,572 DEBUG : BROWSER_OUTPUT: 02:33:28 INFO - 2015-11-03 02:33:28,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57288/tests/kraken/driver.html?testName=audio-dft) 02:33:29 INFO - 2015-11-03 02:33:29,138 DEBUG : BROWSER_OUTPUT: RSS: Main: 278548480 02:33:29 INFO - 2015-11-03 02:33:29,138 DEBUG : BROWSER_OUTPUT: 02:33:32 INFO - 2015-11-03 02:33:32,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57288/tests/kraken/driver.html?testName=audio-fft) 02:33:32 INFO - 2015-11-03 02:33:32,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 267296768 02:33:32 INFO - 2015-11-03 02:33:32,909 DEBUG : BROWSER_OUTPUT: 02:33:35 INFO - 2015-11-03 02:33:35,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57288/tests/kraken/driver.html?testName=audio-oscillator) 02:33:35 INFO - 2015-11-03 02:33:35,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 268697600 02:33:35 INFO - 2015-11-03 02:33:35,724 DEBUG : BROWSER_OUTPUT: 02:33:38 INFO - 2015-11-03 02:33:38,164 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:33:38 INFO - 2015-11-03 02:33:38,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 267444224 02:33:38 INFO - 2015-11-03 02:33:38,746 DEBUG : BROWSER_OUTPUT: 02:33:42 INFO - 2015-11-03 02:33:42,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57288/tests/kraken/driver.html?testName=imaging-darkroom) 02:33:42 INFO - 2015-11-03 02:33:42,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 267550720 02:33:42 INFO - 2015-11-03 02:33:42,784 DEBUG : BROWSER_OUTPUT: 02:33:46 INFO - 2015-11-03 02:33:46,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57288/tests/kraken/driver.html?testName=imaging-desaturate) 02:33:46 INFO - 2015-11-03 02:33:46,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 266399744 02:33:46 INFO - 2015-11-03 02:33:46,919 DEBUG : BROWSER_OUTPUT: 02:33:50 INFO - 2015-11-03 02:33:50,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57288/tests/kraken/driver.html?testName=json-parse-financial) 02:33:50 INFO - 2015-11-03 02:33:50,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 267358208 02:33:50 INFO - 2015-11-03 02:33:50,769 DEBUG : BROWSER_OUTPUT: 02:33:52 INFO - 2015-11-03 02:33:52,509 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:33:53 INFO - 2015-11-03 02:33:53,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 300191744 02:33:53 INFO - 2015-11-03 02:33:53,084 DEBUG : BROWSER_OUTPUT: 02:33:55 INFO - 2015-11-03 02:33:55,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57288/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:33:55 INFO - 2015-11-03 02:33:55,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 301711360 02:33:55 INFO - 2015-11-03 02:33:55,725 DEBUG : BROWSER_OUTPUT: 02:33:57 INFO - 2015-11-03 02:33:57,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:33:58 INFO - 2015-11-03 02:33:58,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 307052544 02:33:58 INFO - 2015-11-03 02:33:58,582 DEBUG : BROWSER_OUTPUT: 02:34:01 INFO - 2015-11-03 02:34:01,483 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:34:02 INFO - 2015-11-03 02:34:02,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 309166080 02:34:02 INFO - 2015-11-03 02:34:02,077 DEBUG : BROWSER_OUTPUT: 02:34:04 INFO - 2015-11-03 02:34:04,837 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:34:05 INFO - 2015-11-03 02:34:05,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 307646464 02:34:05 INFO - 2015-11-03 02:34:05,419 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57288/tests/kraken/driver.html?testName=ai-astar) 02:34:07 INFO - 2015-11-03 02:34:07,554 DEBUG : BROWSER_OUTPUT: RSS: Main: 367214592 02:34:07 INFO - 2015-11-03 02:34:07,554 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,554 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:34:07 INFO - 2015-11-03 02:34:07,555 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:34:07 INFO - 2015-11-03 02:34:07,555 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:34:07 INFO - 2015-11-03 02:34:07,555 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:34:07 INFO - 2015-11-03 02:34:07,555 DEBUG : BROWSER_OUTPUT: |0;ai-astar;125;126;127;127;129;129;134;130;127;126 02:34:07 INFO - 2015-11-03 02:34:07,555 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;178;155;192;183;146;171;154;190;181;148 02:34:07 INFO - 2015-11-03 02:34:07,555 DEBUG : BROWSER_OUTPUT: |2;audio-dft;185;187;190;197;195;190;188;189;188;188 02:34:07 INFO - 2015-11-03 02:34:07,555 DEBUG : BROWSER_OUTPUT: |3;audio-fft;90;87;97;138;83;84;86;83;132;77 02:34:07 INFO - 2015-11-03 02:34:07,555 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;107;117;157;102;104;106;150;107;107;151 02:34:07 INFO - 2015-11-03 02:34:07,555 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;142;149;138;134;141;136;141;135;136;142 02:34:07 INFO - 2015-11-03 02:34:07,555 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;154;150;146;146;148;146;146;146 02:34:07 INFO - 2015-11-03 02:34:07,555 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;117;124;123;120;118;119;124;123;121;118 02:34:07 INFO - 2015-11-03 02:34:07,555 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;68;69;72;73;72;72;81;66;67 02:34:07 INFO - 2015-11-03 02:34:07,555 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;74;76;77;78;82;81;79;80;78;79 02:34:07 INFO - 2015-11-03 02:34:07,556 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;93;95;95;98;98;99;95;95;97;100 02:34:07 INFO - 2015-11-03 02:34:07,556 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;155;144;148;150;148;142;151;156;159;145 02:34:07 INFO - 2015-11-03 02:34:07,556 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;157;172;166;156;155;155;168;155;169 02:34:07 INFO - 2015-11-03 02:34:07,556 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;76;79;79;79;80;79;84;82;83 02:34:07 INFO - 2015-11-03 02:34:07,556 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:34:07 INFO - 2015-11-03 02:34:07,556 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:34:07 INFO - 2015-11-03 02:34:07,556 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,942 02:34:07 INFO - 2015-11-03 02:34:07,556 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:34:07 INFO - 2015-11-03 02:34:07,556 DEBUG : BROWSER_OUTPUT: __startTimestamp1446546847553__endTimestamp 02:34:07 INFO - 2015-11-03 02:34:07,556 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,558 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:34:07 INFO - 2015-11-03 02:34:07,558 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:34:07 INFO - 2015-11-03 02:34:07,558 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,558 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:128.00 Median:128.00 stddev:2.62 (2.1%) stddev-sans-first:2.55 02:34:07 INFO - 2015-11-03 02:34:07,558 DEBUG : BROWSER_OUTPUT: Values: 125.0 126.0 127.0 127.0 129.0 129.0 134.0 130.0 127.0 126.0 02:34:07 INFO - 2015-11-03 02:34:07,559 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,559 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:169.80 Median:179.50 stddev:17.57 (9.8%) stddev-sans-first:18.39 02:34:07 INFO - 2015-11-03 02:34:07,559 DEBUG : BROWSER_OUTPUT: Values: 178.0 155.0 192.0 183.0 146.0 171.0 154.0 190.0 181.0 148.0 02:34:07 INFO - 2015-11-03 02:34:07,559 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,559 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:189.70 Median:189.50 stddev:3.65 (1.9%) stddev-sans-first:3.46 02:34:07 INFO - 2015-11-03 02:34:07,559 DEBUG : BROWSER_OUTPUT: Values: 185.0 187.0 190.0 197.0 195.0 190.0 188.0 189.0 188.0 188.0 02:34:07 INFO - 2015-11-03 02:34:07,560 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,560 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:95.70 Median:85.00 stddev:21.40 (25.2%) stddev-sans-first:22.59 02:34:07 INFO - 2015-11-03 02:34:07,560 DEBUG : BROWSER_OUTPUT: Values: 90.0 87.0 97.0 138.0 83.0 84.0 86.0 83.0 132.0 77.0 02:34:07 INFO - 2015-11-03 02:34:07,560 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,561 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:120.80 Median:112.00 stddev:22.40 (20.0%) stddev-sans-first:23.19 02:34:07 INFO - 2015-11-03 02:34:07,561 DEBUG : BROWSER_OUTPUT: Values: 107.0 117.0 157.0 102.0 104.0 106.0 150.0 107.0 107.0 151.0 02:34:07 INFO - 2015-11-03 02:34:07,561 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,561 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:139.40 Median:141.00 stddev:4.53 (3.2%) stddev-sans-first:4.70 02:34:07 INFO - 2015-11-03 02:34:07,561 DEBUG : BROWSER_OUTPUT: Values: 142.0 149.0 138.0 134.0 141.0 136.0 141.0 135.0 136.0 142.0 02:34:07 INFO - 2015-11-03 02:34:07,561 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,561 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:2.57 (1.7%) stddev-sans-first:2.73 02:34:07 INFO - 2015-11-03 02:34:07,562 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 154.0 150.0 146.0 146.0 148.0 146.0 146.0 146.0 02:34:07 INFO - 2015-11-03 02:34:07,562 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,562 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:120.70 Median:122.00 stddev:2.67 (2.2%) stddev-sans-first:2.47 02:34:07 INFO - 2015-11-03 02:34:07,562 DEBUG : BROWSER_OUTPUT: Values: 117.0 124.0 123.0 120.0 118.0 119.0 124.0 123.0 121.0 118.0 02:34:07 INFO - 2015-11-03 02:34:07,562 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,563 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.00 Median:72.00 stddev:5.50 (7.6%) stddev-sans-first:4.48 02:34:07 INFO - 2015-11-03 02:34:07,564 DEBUG : BROWSER_OUTPUT: Values: 60.0 68.0 69.0 72.0 73.0 72.0 72.0 81.0 66.0 67.0 02:34:07 INFO - 2015-11-03 02:34:07,564 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,564 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:78.40 Median:79.00 stddev:2.37 (3.0%) stddev-sans-first:1.90 02:34:07 INFO - 2015-11-03 02:34:07,565 DEBUG : BROWSER_OUTPUT: Values: 74.0 76.0 77.0 78.0 82.0 81.0 79.0 80.0 78.0 79.0 02:34:07 INFO - 2015-11-03 02:34:07,565 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,565 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:96.50 Median:96.00 stddev:2.22 (2.3%) stddev-sans-first:1.96 02:34:07 INFO - 2015-11-03 02:34:07,565 DEBUG : BROWSER_OUTPUT: Values: 93.0 95.0 95.0 98.0 98.0 99.0 95.0 95.0 97.0 100.0 02:34:07 INFO - 2015-11-03 02:34:07,565 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,565 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:150.50 stddev:5.53 (3.7%) stddev-sans-first:5.54 02:34:07 INFO - 2015-11-03 02:34:07,565 DEBUG : BROWSER_OUTPUT: Values: 155.0 144.0 148.0 150.0 148.0 142.0 151.0 156.0 159.0 145.0 02:34:07 INFO - 2015-11-03 02:34:07,566 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,566 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:161.50 stddev:7.79 (4.8%) stddev-sans-first:7.13 02:34:07 INFO - 2015-11-03 02:34:07,566 DEBUG : BROWSER_OUTPUT: Values: 149.0 157.0 172.0 166.0 156.0 155.0 155.0 168.0 155.0 169.0 02:34:07 INFO - 2015-11-03 02:34:07,566 DEBUG : BROWSER_OUTPUT: 02:34:07 INFO - 2015-11-03 02:34:07,566 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.40 Median:79.50 stddev:3.24 (4.1%) stddev-sans-first:2.47 02:34:07 INFO - 2015-11-03 02:34:07,566 DEBUG : BROWSER_OUTPUT: Values: 73.0 76.0 79.0 79.0 79.0 80.0 79.0 84.0 82.0 83.0 02:34:07 INFO - 2015-11-03 02:34:07,566 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:34:07 INFO - 2015-11-03 02:34:07,567 DEBUG : BROWSER_OUTPUT: 02:34:08 INFO - 2015-11-03 02:34:08,256 INFO : Browser exited with error code: 0 02:34:08 INFO - 2015-11-03 02:34:08,312 INFO : Completed test kraken (00:01:01) 02:34:08 INFO - 2015-11-03 02:34:08,312 INFO : Starting test v8_7 02:34:08 INFO - 2015-11-03 02:34:08,312 DEBUG : operating with platform_type : mac_ 02:34:08 INFO - 2015-11-03 02:34:08,312 INFO : Initialising browser for v8_7 test... 02:34:08 INFO - 2015-11-03 02:34:08,327 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/tmp8wnl31/profile http://localhost:57288/getInfo.html 02:34:10 INFO - 2015-11-03 02:34:10,738 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:34:10 INFO - 2015-11-03 02:34:10,738 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:34:10 INFO - 2015-11-03 02:34:10,738 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:34:10 INFO - 2015-11-03 02:34:10,738 DEBUG : BROWSER_OUTPUT: __metrics 02:34:10 INFO - 2015-11-03 02:34:10,759 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:34:11 INFO - 2015-11-03 02:34:11,567 INFO : Browser initialized. 02:34:11 INFO - 2015-11-03 02:34:11,567 INFO : Running cycle 1/1 for v8_7 test... 02:34:11 INFO - 2015-11-03 02:34:11,567 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/tmp8wnl31/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:34:23 INFO - 2015-11-03 02:34:23,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 200318976 02:34:23 INFO - 2015-11-03 02:34:23,574 DEBUG : BROWSER_OUTPUT: 02:34:46 INFO - 2015-11-03 02:34:46,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/v8_7/run.html (next: http://localhost:57288/tests/v8_7/run.html) 02:34:46 INFO - 2015-11-03 02:34:46,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 522076160 02:34:46 INFO - 2015-11-03 02:34:46,660 DEBUG : BROWSER_OUTPUT: 02:34:46 INFO - 2015-11-03 02:34:46,660 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:34:46 INFO - 2015-11-03 02:34:46,660 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:34:46 INFO - 2015-11-03 02:34:46,660 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:34:46 INFO - 2015-11-03 02:34:46,660 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:34:46 INFO - 2015-11-03 02:34:46,660 DEBUG : BROWSER_OUTPUT: |0;Richards;189.53752843062927 02:34:46 INFO - 2015-11-03 02:34:46,660 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;220.02200220022002 02:34:46 INFO - 2015-11-03 02:34:46,660 DEBUG : BROWSER_OUTPUT: |2;Encrypt;365.4970760233918 02:34:46 INFO - 2015-11-03 02:34:46,660 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6655.6291390728475 02:34:46 INFO - 2015-11-03 02:34:46,660 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1222.2222222222222 02:34:46 INFO - 2015-11-03 02:34:46,661 DEBUG : BROWSER_OUTPUT: |5;Earley;811.0300081103001 02:34:46 INFO - 2015-11-03 02:34:46,661 DEBUG : BROWSER_OUTPUT: |6;Boyer;14940.298507462687 02:34:46 INFO - 2015-11-03 02:34:46,661 DEBUG : BROWSER_OUTPUT: |7;RegExp;33650 02:34:46 INFO - 2015-11-03 02:34:46,661 DEBUG : BROWSER_OUTPUT: |8;Splay;669.3440428380187 02:34:46 INFO - 2015-11-03 02:34:46,661 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6724.832214765101 02:34:46 INFO - 2015-11-03 02:34:46,661 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:34:46 INFO - 2015-11-03 02:34:46,661 DEBUG : BROWSER_OUTPUT: __startTimestamp1446546886653__endTimestamp 02:34:46 INFO - 2015-11-03 02:34:46,661 DEBUG : BROWSER_OUTPUT: 02:34:46 INFO - 2015-11-03 02:34:46,661 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:34:46 INFO - 2015-11-03 02:34:46,661 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:34:46 INFO - 2015-11-03 02:34:46,661 DEBUG : BROWSER_OUTPUT: 02:34:46 INFO - 2015-11-03 02:34:46,661 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.54 Median:189.54 stddev:0.00 (0.0%) 02:34:46 INFO - 2015-11-03 02:34:46,661 DEBUG : BROWSER_OUTPUT: Values: 189.5 02:34:46 INFO - 2015-11-03 02:34:46,662 DEBUG : BROWSER_OUTPUT: 02:34:46 INFO - 2015-11-03 02:34:46,662 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:220.02 Median:220.02 stddev:0.00 (0.0%) 02:34:46 INFO - 2015-11-03 02:34:46,662 DEBUG : BROWSER_OUTPUT: Values: 220.0 02:34:46 INFO - 2015-11-03 02:34:46,662 DEBUG : BROWSER_OUTPUT: 02:34:46 INFO - 2015-11-03 02:34:46,662 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:365.50 Median:365.50 stddev:0.00 (0.0%) 02:34:46 INFO - 2015-11-03 02:34:46,662 DEBUG : BROWSER_OUTPUT: Values: 365.5 02:34:46 INFO - 2015-11-03 02:34:46,662 DEBUG : BROWSER_OUTPUT: 02:34:46 INFO - 2015-11-03 02:34:46,662 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6655.63 Median:6655.63 stddev:0.00 (0.0%) 02:34:46 INFO - 2015-11-03 02:34:46,662 DEBUG : BROWSER_OUTPUT: Values: 6655.6 02:34:46 INFO - 2015-11-03 02:34:46,662 DEBUG : BROWSER_OUTPUT: 02:34:46 INFO - 2015-11-03 02:34:46,662 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1222.22 Median:1222.22 stddev:0.00 (0.0%) 02:34:46 INFO - 2015-11-03 02:34:46,662 DEBUG : BROWSER_OUTPUT: Values: 1222.2 02:34:46 INFO - 2015-11-03 02:34:46,662 DEBUG : BROWSER_OUTPUT: 02:34:46 INFO - 2015-11-03 02:34:46,662 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:811.03 Median:811.03 stddev:0.00 (0.0%) 02:34:46 INFO - 2015-11-03 02:34:46,663 DEBUG : BROWSER_OUTPUT: Values: 811.0 02:34:46 INFO - 2015-11-03 02:34:46,663 DEBUG : BROWSER_OUTPUT: 02:34:46 INFO - 2015-11-03 02:34:46,663 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14940.30 Median:14940.30 stddev:0.00 (0.0%) 02:34:46 INFO - 2015-11-03 02:34:46,663 DEBUG : BROWSER_OUTPUT: Values: 14940.3 02:34:46 INFO - 2015-11-03 02:34:46,663 DEBUG : BROWSER_OUTPUT: 02:34:46 INFO - 2015-11-03 02:34:46,663 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33650.00 Median:33650.00 stddev:0.00 (0.0%) 02:34:46 INFO - 2015-11-03 02:34:46,663 DEBUG : BROWSER_OUTPUT: Values: 33650.0 02:34:46 INFO - 2015-11-03 02:34:46,663 DEBUG : BROWSER_OUTPUT: 02:34:46 INFO - 2015-11-03 02:34:46,663 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:669.34 Median:669.34 stddev:0.00 (0.0%) 02:34:46 INFO - 2015-11-03 02:34:46,663 DEBUG : BROWSER_OUTPUT: Values: 669.3 02:34:46 INFO - 2015-11-03 02:34:46,663 DEBUG : BROWSER_OUTPUT: 02:34:46 INFO - 2015-11-03 02:34:46,663 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6724.83 Median:6724.83 stddev:0.00 (0.0%) 02:34:46 INFO - 2015-11-03 02:34:46,663 DEBUG : BROWSER_OUTPUT: Values: 6724.8 02:34:46 INFO - 2015-11-03 02:34:46,663 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:34:46 INFO - 2015-11-03 02:34:46,664 DEBUG : BROWSER_OUTPUT: 02:34:47 INFO - 2015-11-03 02:34:47,364 INFO : Browser exited with error code: 0 02:34:47 INFO - 2015-11-03 02:34:47,387 INFO : Completed test v8_7 (00:00:39) 02:34:47 INFO - 2015-11-03 02:34:47,402 INFO : Completed test suite (00:20:15) 02:34:47 INFO - 2015-11-03 02:34:47,403 DEBUG : Working with test: dromaeo_css 02:34:47 INFO - 2015-11-03 02:34:47,403 DEBUG : Generating results file: dromaeo_css 02:34:47 INFO - 2015-11-03 02:34:47,404 DEBUG : Working with test: kraken 02:34:47 INFO - 2015-11-03 02:34:47,404 DEBUG : Generating results file: kraken 02:34:47 INFO - 2015-11-03 02:34:47,404 INFO : javascript benchmark 02:34:47 INFO - 2015-11-03 02:34:47,404 DEBUG : Working with test: v8_7 02:34:47 INFO - 2015-11-03 02:34:47,404 DEBUG : Generating results file: v8_7 02:34:47 INFO - 2015-11-03 02:34:47,405 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:34:47 INFO - 2015-11-03 02:34:47,459 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 02:34:47 INFO - 2015-11-03 02:34:47,459 DEBUG : process_Request line: dromaeo_css 5979.66 graph.html#tests=[[72,52,55]] 02:34:47 INFO - 2015-11-03 02:34:47,459 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:34:47 INFO - 2015-11-03 02:34:47,492 DEBUG : process_Request line: kraken 1746.20 graph.html#tests=[[232,52,55]] 02:34:47 INFO - 2015-11-03 02:34:47,492 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:34:47 INFO - 2015-11-03 02:34:47,521 DEBUG : process_Request line: v8_7 17549.97 graph.html#tests=[[230,52,55]] 02:34:47 INFO - 2015-11-03 02:34:47,522 INFO : javascript benchmark 02:34:47 INFO - 2015-11-03 02:34:47,524 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [277.59260549016483, 277.76667599216654, 277.8291350819247, 280.5133094081768, 286.0389092648701, 10151.137153341957, 10797.190210734207, 15051.548453546397, 15619.0, 15662.686746265068, 16951.49145525636, 17032.48902532923, 17168.39910603129, 17206.13969301533, 17563.121843907786, 4816.759162041902, 4925.33507976424, 4939.950600493985, 4996.975015124919, 5034.773435195425, 4869.196582563873, 4871.488493708145, 4887.7311747853855, 4929.457759646436, 4933.407991041062, 3594.676479116879, 3757.380032294668, 4699.436067671884, 4823.276508523714, 4863.659543831933, 5344.4922732340365, 5358.758855851457, 5363.973180134113, 5428.348598168225, 5465.781368745245, 4639.0, 4768.523147685204, 4799.664023518355, 4836.081144582518, 4841.3222148899185, 20344.0, 20380.898095509576, 20602.793972060237, 20668.0, 20749.066292016894, 969.8690676758617, 1794.7487351770762, 1801.2254730465895, 1901.486598618379, 1949.4736421166206, 12271.509139634403, 12342.95084917783, 12349.382530873421, 12626.936865315614, 13130.474781008748, 1523.7790520374595, 1530.036077271312, 1534.3479021415853, 1545.3895711194127, 1562.5156201577547, 54390.18414723782, 55039.44960550383, 55242.171367429524, 56715.43284567143, 57136.42863571394, 9434.95282523583, 9506.809863802824, 9604.711858644252, 9691.370060946016, 9735.805283894424, 12041.0, 12061.85412385822, 12221.877781222252, 12230.449629766681, 12247.448864800926, 7433.4053275737815, 7436.442266829901, 7441.0, 7483.962580187064, 7504.362129218968, 7299.978003079573, 7317.085364329459, 7352.889706654404, 7355.926440735631, 7433.888491672629, 5517.503424691797, 5599.356074051536, 5601.5238704709745, 5657.632253903483, 5730.08318669011, 1538.4461593826213, 1616.3453801210528, 1682.9831701683072, 1687.4515782370534, 1725.0943254791334, 356.6112936898793, 357.05558796982353, 373.25908072476113, 383.2258837148999, 384.61730578074435, 9982.0, 10525.894741052645, 10565.735856603493, 10591.20565957541, 10617.309874858109, 376.98869033929026, 393.92121575684405, 399.6143721308951, 404.31065034117347, 405.1168452772983, 5478.698671573102, 5572.192032155314, 5607.831765047055, 5637.633553818989, 5647.519960803378, 498493.0, 503758.0, 511216.0, 515414.0, 516809.0, 62836.0, 64434.0, 64596.0, 64875.0, 66403.33596663972, 455.3033858196964, 456.2084782901663, 457.51046380373344, 457.98397056102874, 464.38932803364145, 9285.164335209864, 9625.181859541737, 9778.608855645694, 9849.950750246202, 9973.950130249303, 29041.41917161687, 30678.846605766827, 30729.846350768104, 31656.841715791274, 32106.357872841945, 42666.78666606647, 43040.0, 43083.35374969315, 43230.0, 43266.35100473432, 5353.518183363516, 5655.293088363955, 5689.260396148474, 5736.311642602747, 5798.188253644409, 10217.846732299171, 10371.896281037394, 10495.107915826935, 10511.526981286013, 10655.946720266349, 8762.299016078827, 8862.379633425857, 8886.688965886164, 9073.364864459689, 9169.174774270348, 8827.293816494794, 8846.778830529289, 8906.73279801607, 8936.195742383217, 8937.642494300155, 9174.0, 9366.0, 9377.484238366955, 9452.480113593543, 9500.239980801658, 5017.498250174954, 5017.799288028438, 5594.692291923983, 5597.132444471114, 5599.384067752462, 8975.32685048611, 8992.145746154105, 9237.722868313962, 9262.39794413361, 9288.860667090134], "dojo.html": [2715.9321016974573, 2810.016494227022, 2847.5016872047386, 2854.3292326303304, 2877.2662970942415, 4743.122522333367, 4796.232602783547, 4803.111424386491, 4862.392200974874, 4864.537868902448, 4807.807687692497, 4811.109944660231, 4821.469638339789, 4822.734749588772, 4877.195262781645, 4358.346248062784, 4500.842470513533, 4506.414166158394, 4537.954620453786, 4581.381513495686, 4357.673174511909, 4433.423654924855, 4435.556444355571, 4469.061497085616, 4520.480144783359, 4390.868273951786, 4450.132224216279, 4451.732896026233, 4462.910741785162, 4534.433195850519, 4535.092981403733, 4567.223571992769, 4597.908041839161, 4623.42207224097, 4642.373279607244, 3966.1869316790276, 4288.849890253826, 4386.758728269944, 4427.1367083418745, 4522.773861306954, 4546.158960592301, 4583.977080114611, 4598.333241679971, 4692.929606055912, 4737.407824021997, 5037.219231019198, 5039.697618142924, 5042.042012017741, 5049.671771334852, 5078.7460626968505, 4793.616510679172, 5010.924836127461, 5050.7222102784335, 5072.568831649314, 5086.79652813887, 4579.542045795394, 4592.7933243004145, 4628.305754136873, 4676.5089665584965, 4743.620510359163, 5225.372955245319, 5306.840794776086, 5330.893382132335, 5341.465853414627, 5398.4871437213405, 4730.479647238801, 5042.722650254198, 5042.84871453857, 5083.2883396323805, 5085.593152547787, 4961.677490963148, 5025.874353141127, 5042.722650254272, 5059.988002399535, 5075.8223462179385, 5032.622553308516, 5038.445770965191, 5133.307003554547, 5142.30578871855, 5183.922241166386, 4756.7859446325, 5071.797128114834, 5124.590032797368, 5136.357955255593, 5153.793848246029, 3884.514435695538, 3889.630485103911, 3899.727019108635, 3929.410588411761, 4004.839806407769, 3552.5381700379303, 3564.8752293669595, 3567.8751243706865, 3594.5686517618055, 3640.508531348287, 4479.238529450001, 4809.567138957511, 4869.391326084239, 4870.732109733999, 4877.804887804448, 5026.698398096126, 5059.772310246048, 5095.133827249377, 5154.639175257696, 5194.68831870089, 4736.076465089343, 4772.164871147535, 4789.377380940456, 4835.274708793709, 4851.781669824866, 4201.075763332062, 4494.617957473652, 4520.073384956077, 4523.84166554169, 4532.9773351133035, 4981.0, 5035.697858128524, 5072.6195535335, 5082.974585127125, 5083.110455670169, 5197.688138711689, 5219.634625576173, 5230.8169214077325, 5232.581393488588, 5236.764345604381, 5194.506521880416, 5266.289050978069, 5270.604704647243, 5277.28756617867, 5300.337457817773, 4872.366592342973, 4888.340074089952, 4912.0175964807895, 4990.750462476789, 5019.196928491424, 4952.653314267966, 5199.66202196856, 5208.453112423293, 5215.0, 5219.034478621467, 5043.773030213576, 5050.242463630485, 5059.342285502861, 5072.137736584863, 5111.46329635383, 4780.713157210578, 4852.272159176152, 4896.216605343128, 4904.803807847647, 5048.040872234264, 4854.150523658416, 4892.2661600760175, 4968.975155124202, 4970.055689418999, 5006.048850718352, 5048.318477005704, 5070.4676009019995, 5072.112380333353, 5078.771455284595, 5107.974460127675, 4682.976585117052, 4774.379330686988, 4778.354922085613, 4962.776675049704, 5019.974900125476], "mootools.html": [1222.8349172861663, 1298.714282857771, 1336.4787732784216, 1359.8912087033038, 1584.477122549558, 5899.557533185007, 6117.724702388392, 6356.396142366473, 6545.574537655049, 6632.834179145524, 6419.422251997319, 6530.70611822468, 6566.0, 6576.177977752781, 6663.100481435004, 1886.5849513107094, 1907.8759880607786, 1921.1354890299351, 1921.7309576659209, 1930.3436831477295, 1920.270297287029, 1922.3848368522079, 1924.894130822804, 1927.9036048197604, 1934.1103092577362, 1854.545636319097, 1856.5358660334916, 1866.4120801947342, 1874.8500119990367, 1888.046536499073, 1832.1938347127289, 1859.7024476083761, 1865.272543707955, 1867.6451474219855, 1884.387574038443, 1808.94573162804, 1819.754333165019, 1821.6174603333316, 1847.2333981397837, 1875.0905810681809, 5687.886242275173, 6468.256150542654, 6497.090407342976, 6520.836979075513, 6578.407943285128, 3564.1624218308934, 3705.6294370562728, 3794.829232684536, 3799.9240015199543, 3846.11539345952, 2431.4043059450546, 2479.157086590568, 2501.58723810571, 2503.874806259698, 2521.6091505816626, 731.7365748330596, 742.6027075514573, 748.5022460064105, 751.4927423988786, 752.3229093815555, 8637.956810215908, 8639.65441382344, 8642.178992995656, 8659.04750477447, 8763.956180219122, 3626.9818650906577, 3628.600853906068, 3677.742558020913, 3696.77819330841, 3715.21980384117, 7643.923560764321, 7669.271419215165, 7676.19399963007, 7726.0, 7804.960975195201, 4103.384492326175, 4114.1977314424, 4115.34154535273, 4162.854300099542, 4166.604172603597, 3741.831617577161, 3748.250349930025, 3767.962320376816, 3791.9431208531896, 3798.2593394287846, 2856.243095579673, 2896.4786338458857, 2930.4285664295685, 2951.2031751426994, 2985.462616728966, 974.488393593355, 983.2969426859829, 984.9704508864745, 992.3202606214766, 997.3766396002499, 849.9660013599387, 875.7941883657336, 876.7764220123828, 889.4840992224495, 948.1277224952922, 6303.495720342362, 6427.903581446282, 6445.1943507061615, 6494.772682956168, 6496.480281577463, 888.2849306308354, 923.7459698582809, 1001.62439085343, 1006.4514839412537, 1033.4625994482976, 4850.927236091461, 4930.13722598551, 4975.228839529878, 4977.0792403405485, 5047.091523525727, 7253.347198752138, 7522.473426860177, 7551.5846628434865, 7730.226977302224, 7743.651535680795, 7559.584222867685, 7659.693612255559, 7693.807654808675, 7752.7286544971785, 7788.14330423653, 6211.81364559064, 6371.139896114058, 6379.64911929839, 6466.288708242089, 6486.740530378826, 6285.182926219745, 6326.715297811517, 6336.1446204763615, 6409.679516024087, 6424.903626445701, 7116.964415177891, 7167.892481612885, 7222.819429514304, 7302.926970730225, 7309.342159205697, 7289.0, 7344.449166312441, 7346.0, 7400.851982960418, 7495.287947644965, 5693.5160511357, 5760.251167348386, 5766.740496677576, 5784.479396854304, 5797.710114494174, 6419.133416988833, 6469.288378278292, 6481.189851268591, 6483.2544257411, 6557.114789503356, 6032.426919442646, 6045.183900173421, 6084.117802918464, 6090.573659843945, 6101.115338276014, 5769.682667453162, 5781.132830075522, 5828.504577110823, 5968.612040217372, 6111.724972376165, 5855.502282306052, 5893.734781934738, 5943.732532036155, 5956.285245770535, 5990.9700451497465, 5223.764930578209, 5315.202719592092, 5316.946830531645, 5393.757280922289, 5405.86485337854, 5528.778848846162, 5555.861103472445, 5576.0, 5630.718464076862, 5639.6334238274385], "ext.html": [488.58470300244784, 498.33721150869326, 498.3820063121728, 513.6994858008065, 521.1557277210919, 28188.577171342422, 29334.41331173378, 34936.30127397454, 35186.824065879635, 35380.2923941521, 37941.62058379415, 38176.61823381765, 38587.421188682194, 38699.226015479675, 38797.80601096997, 7377.262273772633, 7957.880631790514, 8149.837003259931, 8164.224398682116, 8173.918260817375, 7517.586532740725, 9697.612095516171, 9844.409335439897, 9881.110700036996, 10053.49732513375, 9562.282828787835, 9600.279979001569, 9608.951955240214, 9652.372595781288, 9766.755831104208, 7618.885716714254, 7840.255175758294, 9326.766830829216, 9453.291003174754, 9554.617815287414, 9280.1647851693, 9309.53452327381, 9339.0, 9471.052894710543, 9477.573509192103, 32932.83533582317, 33447.83276083604, 33483.0, 33949.660503394894, 34032.149196270046, 2598.1296265751, 2607.6610040694777, 2661.161734053767, 2764.156932135698, 2874.9263442483953, 24537.14120005791, 24601.138960136308, 24647.753522464725, 25338.619920701203, 25396.0, 2078.4803799050237, 2098.1607357057146, 2110.693949377347, 2118.766935637079, 2141.2612648636195, 237621.0, 241142.0, 241305.0, 242308.0, 242492.0, 53361.0, 56010.43989560134, 56273.0, 56437.43562564404, 56628.0, 50284.245736313984, 65929.0, 66961.66519167373, 67002.32997670058, 67530.0, 15491.690166196839, 15743.921280393524, 15747.055176689435, 15752.448664296924, 15757.527274181793, 11642.825357619642, 11680.532778688927, 11696.181267311207, 11865.466054027589, 11875.524979000917, 18329.266829326945, 18375.356862509747, 18381.0, 18389.0, 18392.632147356977, 7591.8861217081785, 7746.30283274508, 7748.108967468813, 7838.608069596497, 7894.21057894206, 811.3428123220093, 833.629035079396, 868.0, 872.4590753732599, 957.1337939165066, 25910.222693319232, 28437.0, 29304.56043159354, 29603.0, 29857.70142298549, 791.8535071011881, 892.9776755581163, 944.7874228298577, 955.9426434413957, 1025.6153942271649, 13774.242416667179, 14108.788368174486, 14462.27688615565, 14540.927295363455, 14581.489647862274, 322031.0, 329677.0, 329958.0, 331170.0, 331684.0, 52921.206181906535, 52927.470725293024, 53506.46493535015, 53740.462595373545, 53821.73089134607, 1151.2574389518713, 1196.132803717298, 1281.5130250504749, 1282.7242142939126, 1428.9428422863177, 26454.603180952687, 27101.457970840867, 27530.311742206606, 27557.173284801487, 28260.0, 44666.10667786691, 45054.54945450504, 46245.53754462547, 47227.52772472369, 47625.285620715025, 360011.0, 363353.0, 367974.0, 368632.0, 370092.0, 36181.27637447184, 37297.440538391405, 37607.43588846115, 37755.0, 38815.80592097021, 39134.804325978184, 39197.41203881887, 39730.0, 39752.60247397489, 39871.80064099661, 32720.672793271762, 33057.83471082629, 33083.669163308055, 33469.16327091842, 33695.3260934775, 33072.0, 33097.338053238316, 33106.5034024485, 33193.842400243906, 33408.0, 32866.83566582152, 33651.326973460884, 33697.83151084229, 33721.66278337185, 34230.82884585561, 26937.59593606058, 29048.854755726086, 29200.41599168047, 29230.853845731486, 29319.706802931698, 21618.891905541, 21999.450013749785, 22206.77793222047, 22321.553568928204, 22448.77551224467], "prototype.html": [251.7055045596652, 258.7373815577189, 259.46550106780035, 263.51907768322815, 263.79160463234047, 5205.3233079699585, 5317.734113294339, 5345.037893179227, 5369.5704343652515, 5416.187571864222, 5137.51193636604, 5221.791128354871, 5259.158534634459, 5312.096943519601, 5354.732263386825, 4052.53395859477, 4058.086930440657, 4104.8563300284495, 4126.2160189563965, 4132.5454200037975, 4004.4593979812644, 4031.5162180538377, 4059.025833799896, 4061.0659548303906, 4132.049628585427, 4024.3158663027357, 4056.3509838425857, 4067.5118985721756, 4089.20260549193, 4097.467329247193, 4028.03327201471, 4043.7573745575064, 4070.8778736637946, 4089.1821635672986, 4111.444954931076, 3462.2036931505645, 3476.0, 3495.8252087395526, 3503.7372197085065, 3516.6834984851484, 5053.393592768854, 5096.133657278235, 5106.744662766884, 5118.667286626357, 5200.713960732158, 4414.271645178542, 4446.088551846864, 4470.374147619336, 4475.485319188302, 4478.664100192498, 5469.398366179717, 5482.945170548283, 5551.028570000234, 5563.527100196488, 5589.965856316554, 3469.60099588548, 3548.414511605582, 3583.4266517357096, 3673.7061035117126, 3676.099355657854, 5708.4291570843, 5708.857278568069, 5817.0983497557945, 5822.970885145547, 5891.882162356772, 3667.156553992597, 3670.9816450917574, 3720.4605332226674, 3744.344739670547, 3750.4374343848094, 3714.23858109087, 3715.8327875245677, 3724.1992971511254, 3769.151940813295, 3792.0898984244136, 4305.784710764512, 4413.0, 4424.402705634762, 4426.358178064227, 4459.152760975404, 5493.835184944378, 5601.467860553241, 5604.8038318658655, 5618.185363122325, 5619.0, 1326.6683329167709, 1338.2238301784942, 1338.7991801229698, 1357.077187512501, 1365.378752667534, 843.4896887383045, 851.9350811485643, 858.1847245117164, 865.2126564825978, 877.1754550722428, 5204.635675502678, 5350.946490535122, 5380.515753582196, 5426.457354264542, 5430.864228394322, 5820.214271073351, 5837.182794408786, 5872.0898260769645, 5872.119182122716, 5910.497607703393, 5370.624056316098, 5388.084025715638, 5408.215808707794, 5419.593530485229, 5445.482679145475, 3071.5239137933654, 3183.0, 3193.9840300798346, 3204.83975801209, 3248.480243161083, 5790.420957904176, 5833.591648584558, 5919.3192782829665, 5938.257717785277, 5939.13882487037, 5914.852128696731, 5941.792037278675, 5953.642781433128, 5987.221661184019, 6002.4897883679505, 5637.718114094197, 5862.12068189775, 5928.347881733006, 5936.614120082095, 5937.465628093492, 5821.301443826768, 5823.068309070529, 5883.911741323798, 5890.941090589039, 5895.263092113486, 5560.638558493685, 5668.433156684298, 5701.0, 5714.742836572281, 5756.021476348947, 5836.124581312667, 5855.912161317498, 5872.1778950946045, 5922.407759224043, 5969.224000879858, 3605.2248766515327, 3628.0, 3658.414653655402, 3682.0058584181584, 3706.8331925063976, 5812.18629391894, 5823.010088284917, 5824.9417505826095, 5838.1826544282985, 5843.912341314799, 5570.5543556516195, 5620.297462817148, 5708.143778433268, 5715.971420142872, 5726.341470730753, 5622.85942851432, 5622.887542249214, 5646.830595082154, 5674.687892165971, 5705.971470142623, 5518.392976772632, 5542.667439953616, 5545.473180047889, 5552.472515111058, 5578.051731205624, 5515.558755299647, 5577.52591029767, 5614.9719251403485, 5678.4605462480995, 5716.514096301695, 5528.502434780889, 5576.860578485408, 5637.069883469182, 5654.378018417889, 5657.038303488499], "yui.html": [565.2962062232518, 589.5961266532423, 603.4990957505271, 655.3021032600284, 664.7772996046326, 12249.142560020802, 12690.873091269084, 12718.0, 12730.427130779113, 12777.552785652504, 11491.138164637643, 11602.651920442378, 11626.360550169737, 11629.592964246252, 11644.068474522039, 612.1827360473761, 622.1352320274822, 758.3516093739855, 766.5362455714296, 770.7687693691898, 721.6103304215717, 763.4541302968377, 770.8997830282084, 774.020863607537, 774.6707649249075, 628.1896353703717, 634.2515831319041, 789.72754399732, 790.0716657926941, 798.7124635131348, 767.9155292917775, 780.0249687890138, 780.7969927818808, 787.4055088408244, 799.5003123048095, 572.2274928846066, 572.6392372805107, 575.7610591604479, 576.3400905962691, 579.9797007104773, 12014.0, 12192.878071219264, 12210.633680989584, 12217.144799864012, 12375.62873113808, 8505.702300419518, 8588.699395521127, 8683.175098365646, 9056.818863622757, 9090.318226133066, 7536.585487798169, 7559.206283340225, 7716.7684969451, 7773.572453515055, 7976.042874854997, 2496.862672553009, 2502.687164104487, 2568.7944964402805, 2609.8825552850167, 2649.3641526033807, 43436.0, 44052.3392149118, 44148.55851441476, 44180.779096104634, 44880.55119448829, 6213.5339849510565, 6278.497720182374, 6279.246490421178, 6354.682265886687, 6524.9673751630935, 10913.23607347494, 10921.0, 11075.05862001739, 11093.500792464358, 11105.944470277596, 5483.067878460672, 5550.583706221969, 5715.428457154251, 5721.713914304268, 5753.424657534297, 3240.4329242382487, 3419.196488825124, 3422.7261819054415, 3430.073880052422, 3550.0237434705145, 2360.4924941137397, 2377.429416939922, 2378.9167379141995, 2392.6889504364667, 2395.8203134764963, 311.83784432095183, 312.59050643656883, 313.50309759031734, 314.2677561282207, 315.9921001974923, 409.1673444540406, 430.71787978873886, 523.3249108649799, 528.3342987835279, 529.684837521674, 6708.932910670831, 6793.0, 6815.591064536144, 6893.379595836399, 6897.586144831326, 394.3591663546737, 516.8630312967067, 555.3668817547998, 557.289455943667, 558.0540983033719, 3019.637643482752, 3127.6559578446354, 3188.426083304981, 3233.7736358455154, 3314.7016768490953, 50554.241686374735, 51150.74424627853, 51247.231291530654, 51292.48707512952, 55537.72231138899, 46940.5305946943, 49886.0, 51299.0, 51355.7432212844, 52172.21741673878, 45773.77113114413, 45818.770906145925, 45986.77006614945, 46268.0, 47628.52371476241, 7215.494915355875, 7224.638768061471, 7241.637918104179, 7460.738874139379, 7466.440016998638, 32002.359952800347, 32368.35263294674, 32584.34831303408, 33041.173970649965, 33061.66938330586, 39963.80018099891, 40473.39289910712, 41167.1766564661, 41287.38068929029, 41361.0, 9212.677556285498, 9662.71011869645, 9705.0, 9763.511824408894, 9828.213742900407, 9285.442873427615, 9713.805723885624, 10047.598096076075, 10077.344972576759, 10097.141742951637, 9230.261579073793, 9326.207272381924, 9526.285528585522, 9673.661421850202, 9812.607495700093, 9187.632494700405, 9238.445693258158, 9446.24430045581, 9769.609215631579, 10178.592856285963, 8942.722315123945, 9107.134822191882, 9151.862722059308, 9170.633174673205, 9210.585523651318, 7639.0, 7955.323797477048, 7960.417592403155, 8103.918960810316, 8276.503409795432, 7476.19689548597, 7701.922980770345, 8268.131846156068, 8275.08974012846, 8310.584470776557]}, "summary": {"suite": 5979.664474673921, "subtests": {"jquery.html": {"filtered": 6878.6018117541435, "value": 6878.6018117541435}, "dojo.html": {"filtered": 4716.487435348799, "value": 4716.487435348799}, "mootools.html": {"filtered": 3763.0836953332746, "value": 3763.0836953332746}, "ext.html": {"filtered": 17418.943534472146, "value": 17418.943534472146}, "prototype.html": {"filtered": 4157.023108700513, "value": 4157.023108700513}, "yui.html": {"filtered": 5170.656402474098, "value": 5170.656402474098}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0089"}, "testrun": {"date": 1446545671, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151103002805", "branch": "Mozilla-Aurora", "revision": "56e2e69aea4d8e87652f560a72c5dc7376d834ad"}}, {"talos_counters": {}, "results": {"audio-dft": [185.0, 187.0, 190.0, 197.0, 195.0, 190.0, 188.0, 189.0, 188.0, 188.0], "ai-astar": [125.0, 126.0, 127.0, 127.0, 129.0, 129.0, 134.0, 130.0, 127.0, 126.0], "imaging-gaussian-blur": [142.0, 149.0, 138.0, 134.0, 141.0, 136.0, 141.0, 135.0, 136.0, 142.0], "audio-beat-detection": [178.0, 155.0, 192.0, 183.0, 146.0, 171.0, 154.0, 190.0, 181.0, 148.0], "json-stringify-tinderbox": [74.0, 76.0, 77.0, 78.0, 82.0, 81.0, 79.0, 80.0, 78.0, 79.0], "stanford-crypto-pbkdf2": [149.0, 157.0, 172.0, 166.0, 156.0, 155.0, 155.0, 168.0, 155.0, 169.0], "json-parse-financial": [60.0, 68.0, 69.0, 72.0, 73.0, 72.0, 72.0, 81.0, 66.0, 67.0], "stanford-crypto-sha256-iterative": [73.0, 76.0, 79.0, 79.0, 79.0, 80.0, 79.0, 84.0, 82.0, 83.0], "audio-fft": [90.0, 87.0, 97.0, 138.0, 83.0, 84.0, 86.0, 83.0, 132.0, 77.0], "imaging-darkroom": [148.0, 148.0, 154.0, 150.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0], "stanford-crypto-ccm": [155.0, 144.0, 148.0, 150.0, 148.0, 142.0, 151.0, 156.0, 159.0, 145.0], "audio-oscillator": [107.0, 117.0, 157.0, 102.0, 104.0, 106.0, 150.0, 107.0, 107.0, 151.0], "stanford-crypto-aes": [93.0, 95.0, 95.0, 98.0, 98.0, 99.0, 95.0, 95.0, 97.0, 100.0], "imaging-desaturate": [117.0, 124.0, 123.0, 120.0, 118.0, 119.0, 124.0, 123.0, 121.0, 118.0]}, "summary": {"suite": 1746.2000000000003, "subtests": {"audio-fft": {"filtered": 95.7, "value": 95.7}, "stanford-crypto-pbkdf2": {"filtered": 160.2, "value": 160.2}, "audio-beat-detection": {"filtered": 169.8, "value": 169.8}, "stanford-crypto-ccm": {"filtered": 149.8, "value": 149.8}, "imaging-darkroom": {"filtered": 147.8, "value": 147.8}, "json-parse-financial": {"filtered": 70.0, "value": 70.0}, "audio-oscillator": {"filtered": 120.8, "value": 120.8}, "ai-astar": {"filtered": 128.0, "value": 128.0}, "audio-dft": {"filtered": 189.7, "value": 189.7}, "stanford-crypto-sha256-iterative": {"filtered": 79.4, "value": 79.4}, "json-stringify-tinderbox": {"filtered": 78.4, "value": 78.4}, "imaging-gaussian-blur": {"filtered": 139.4, "value": 139.4}, "stanford-crypto-aes": {"filtered": 96.5, "value": 96.5}, "imaging-desaturate": {"filtered": 120.7, "value": 120.7}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0089"}, "testrun": {"date": 1446545671, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151103002805", "branch": "Mozilla-Aurora", "revision": "56e2e69aea4d8e87652f560a72c5dc7376d834ad"}}, {"talos_counters": {}, "results": {"DeltaBlue": [220.02200220022002], "Encrypt": [365.4970760233918], "NavierStokes": [6724.832214765101], "Decrypt": [6655.6291390728475], "Splay": [669.3440428380187], "Richards": [189.53752843062927], "RegExp": [33650.0], "Earley": [811.0300081103001], "Boyer": [14940.298507462687], "RayTrace": [1222.2222222222222]}, "summary": {"suite": 17549.973389915198, "subtests": {"DeltaBlue": {"filtered": 300.50631, "value": 300.50631}, "Encrypt": {"filtered": 728.2712159999999, "value": 728.2712159999999}, "NavierStokes": {"filtered": 220.67465069860268, "value": 220.67465069860268}, "Decrypt": {"filtered": 39.99336417910451, "value": 39.99336417910451}, "Splay": {"filtered": 121.74755400000002, "value": 121.74755400000002}, "RegExp": {"filtered": 27.072362555720638, "value": 27.072362555720638}, "Richards": {"filtered": 186.25335200000006, "value": 186.25335200000006}, "Earley": {"filtered": 821.7488789999996, "value": 821.7488789999996}, "Boyer": {"filtered": 44.60841258741261, "value": 44.60841258741261}, "RayTrace": {"filtered": 605.4455454545453, "value": 605.4455454545453}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0089"}, "testrun": {"date": 1446545671, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151103002805", "branch": "Mozilla-Aurora", "revision": "56e2e69aea4d8e87652f560a72c5dc7376d834ad"}}] 02:34:47 INFO - RETURN: dromaeo_css: 5979.66 02:34:47 INFO - RETURN: kraken: 1746.20 02:34:47 INFO - RETURN: v8_7: 17549.97 02:34:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "17549.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1746.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5979.66"}}} 02:34:47 INFO - Return code: 0 02:34:47 INFO - # TBPL SUCCESS # 02:34:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:34:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:34:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:34:47 INFO - 2015-11-03 02:34:47.629 screenresolution[2238:21197] starting screenresolution argv=screenresolution get 02:34:47 INFO - 2015-11-03 02:34:47.636 screenresolution[2238:21197] Display 0: 1600x1200x32@60 02:34:47 INFO - 2015-11-03 02:34:47.643 screenresolution[2239:21200] starting screenresolution argv=screenresolution list 02:34:47 INFO - Available Modes on Display 0 02:34:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:34:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:34:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:34:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:34:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:34:47 INFO - Intel HD Graphics 3000: 02:34:47 INFO - Chipset Model: Intel HD Graphics 3000 02:34:47 INFO - Type: GPU 02:34:47 INFO - Bus: Built-In 02:34:47 INFO - VRAM (Total): 512 MB 02:34:47 INFO - VRAM (Dynamic, Max): 10 02:34:47 INFO - Vendor: Intel (0x8086) 02:34:47 INFO - Device ID: 0x0116 02:34:47 INFO - Revision ID: 0x0009 02:34:47 INFO - Displays: 02:34:47 INFO - Display: 02:34:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:34:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:34:47 INFO - Display Serial Number: 1600x1200 60 02:34:47 INFO - Main Display: Yes 02:34:47 INFO - Mirror: Off 02:34:47 INFO - Online: Yes 02:34:47 INFO - Rotation: Supported 02:34:47 INFO - Return code: 0 02:34:47 INFO - Running post-action listener: _resource_record_post_action 02:34:47 INFO - Running post-run listener: _resource_record_post_run 02:34:49 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 356352; Write bytes: 687865856; Read time: 899; Write time: 43489 02:34:49 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 339618304; Write bytes: 334522368; Read time: 36466; Write time: 7093 02:34:49 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 356352; Write bytes: 341901312; Read time: 899; Write time: 34545 02:34:49 INFO - Running post-run listener: _upload_blobber_files 02:34:49 INFO - Blob upload gear active. 02:34:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:34:49 INFO - Copying logs to upload dir... 02:34:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1343.589725 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 23 secs) (at 2015-11-03 02:34:49.097461) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-03 02:34:49.101590) ========= 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.klHMMKfvwC/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.Aw7UPUHeNO/Listeners TMPDIR=/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010516 build_url: 'https://queue.taskcluster.net/v1/task/fTyiqpvwRxK1bfzIvHot1A/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-03 02:34:49.133282) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2015-11-03 02:34:49.133680) ========= 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.klHMMKfvwC/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.Aw7UPUHeNO/Listeners TMPDIR=/var/folders/t_/bv_ctpx94r99tfm1h_wdzg9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005784 ========= master_lag: 3.74 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2015-11-03 02:34:52.880166) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-03 02:34:52.881435) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-03 02:34:52.885553) ========= ========= Total master_lag: 3.94 =========