builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0101 starttime: 1448368775.2 results: success (0) buildid: 20151124031430 builduid: 6c336417cd914e19b4cdbf47fb413e66 revision: 124aaf8a8940cf68c741f7185b317c2afd0516b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:35.204392) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:35.204875) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:35.205398) ========= 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.3JMVxMZiHY/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.Wi31xM56Xt/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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.005610 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:35.228507) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:35.228824) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:35.258160) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:35.258426) ========= 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.3JMVxMZiHY/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.Wi31xM56Xt/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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.005409 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:35.312814) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:35.313120) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:35.313463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:35.314254) ========= 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.3JMVxMZiHY/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.Wi31xM56Xt/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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-24 04:39:35-- 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, 63.245.215.25, ... 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% 6.57M=0.002s 2015-11-24 04:39:35 (6.57 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.466002 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:35.793626) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:35.797208) ========= 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.3JMVxMZiHY/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.Wi31xM56Xt/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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.020572 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:35.849859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 04:39:35.850220) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 124aaf8a8940cf68c741f7185b317c2afd0516b9 --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 124aaf8a8940cf68c741f7185b317c2afd0516b9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3JMVxMZiHY/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.Wi31xM56Xt/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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-24 04:39:35,929 truncating revision to first 12 chars 2015-11-24 04:39:35,929 Setting DEBUG logging. 2015-11-24 04:39:35,929 attempt 1/10 2015-11-24 04:39:35,929 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/124aaf8a8940?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 04:39:37,188 unpacking tar archive at: mozilla-aurora-124aaf8a8940/testing/mozharness/ program finished with exit code 0 elapsedTime=1.525357 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 04:39:37.388946) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:37.389263) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:37.398550) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:37.398801) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 04:39:37.399172) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2015-11-24 04:39:37.399442) ========= /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.3JMVxMZiHY/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.Wi31xM56Xt/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 04:39:37 INFO - MultiFileLogger online at 20151124 04:39:37 in /builds/slave/test 04:39:37 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 04:39:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:39:37 INFO - {'append_to_log': False, 04:39:37 INFO - 'base_work_dir': '/builds/slave/test', 04:39:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:39:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:39:37 INFO - 'branch': 'Mozilla-Aurora', 04:39:37 INFO - 'buildbot_json_path': 'buildprops.json', 04:39:37 INFO - 'config_files': ('talos/mac_config.py',), 04:39:37 INFO - 'default_actions': ('clobber', 04:39:37 INFO - 'read-buildbot-config', 04:39:37 INFO - 'download-and-extract', 04:39:37 INFO - 'populate-webroot', 04:39:37 INFO - 'create-virtualenv', 04:39:37 INFO - 'install', 04:39:37 INFO - 'run-tests'), 04:39:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:39:37 INFO - 'download_minidump_stackwalk': True, 04:39:37 INFO - 'download_symbols': 'ondemand', 04:39:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:39:37 INFO - 'tooltool.py': '/tools/tooltool.py', 04:39:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:39:37 INFO - '/tools/misc-python/virtualenv.py')}, 04:39:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:39:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:39:37 INFO - 'installer_path': 'installer.exe', 04:39:37 INFO - 'log_level': 'info', 04:39:37 INFO - 'log_name': 'talos', 04:39:37 INFO - 'log_to_console': True, 04:39:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:39:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:39:37 INFO - 'opt_config_files': (), 04:39:37 INFO - 'pip_index': False, 04:39:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:39:37 INFO - 'cmd': ('bash', 04:39:37 INFO - '-c', 04:39:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:39:37 INFO - 'enabled': True, 04:39:37 INFO - 'halt_on_failure': False, 04:39:37 INFO - 'name': 'check_screen_resolution'},), 04:39:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:39:37 INFO - 'cmd': ('bash', 04:39:37 INFO - '-c', 04:39:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:39:37 INFO - 'enabled': True, 04:39:37 INFO - 'halt_on_failure': False, 04:39:37 INFO - 'name': 'check_screen_resolution'},), 04:39:37 INFO - 'run_cmd_checks_enabled': True, 04:39:37 INFO - 'sps_profile': False, 04:39:37 INFO - 'sps_profile_interval': 0, 04:39:37 INFO - 'suite': 'dromaeojs', 04:39:37 INFO - 'system_bits': '64', 04:39:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:39:37 INFO - 'title': 't-yosemite-r5-0101', 04:39:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:39:37 INFO - 'use_talos_json': True, 04:39:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:39:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:39:37 INFO - 'work_dir': 'build'} 04:39:37 INFO - ##### 04:39:37 INFO - ##### Running clobber step. 04:39:37 INFO - ##### 04:39:37 INFO - Running pre-action listener: _resource_record_pre_action 04:39:37 INFO - Running main action method: clobber 04:39:37 INFO - rmtree: /builds/slave/test/build 04:39:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:39:39 INFO - Running post-action listener: _resource_record_post_action 04:39:39 INFO - ##### 04:39:39 INFO - ##### Running read-buildbot-config step. 04:39:39 INFO - ##### 04:39:39 INFO - Running pre-action listener: _resource_record_pre_action 04:39:39 INFO - Running main action method: read_buildbot_config 04:39:39 INFO - Using buildbot properties: 04:39:39 INFO - { 04:39:39 INFO - "properties": { 04:39:39 INFO - "buildnumber": 278, 04:39:39 INFO - "product": "firefox", 04:39:39 INFO - "script_repo_revision": "production", 04:39:39 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 04:39:39 INFO - "repository": "", 04:39:39 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 04:39:39 INFO - "buildid": "20151124031430", 04:39:39 INFO - "slavename": "t-yosemite-r5-0101", 04:39:39 INFO - "pgo_build": "False", 04:39:39 INFO - "basedir": "/builds/slave/test", 04:39:39 INFO - "project": "", 04:39:39 INFO - "platform": "yosemite", 04:39:39 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:39:39 INFO - "slavebuilddir": "test", 04:39:39 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:39:39 INFO - "branch": "mozilla-aurora", 04:39:39 INFO - "repo_path": "releases/mozilla-aurora", 04:39:39 INFO - "stage_platform": "macosx64", 04:39:39 INFO - "builduid": "6c336417cd914e19b4cdbf47fb413e66", 04:39:39 INFO - "revision": "124aaf8a8940cf68c741f7185b317c2afd0516b9" 04:39:39 INFO - }, 04:39:39 INFO - "sourcestamp": { 04:39:39 INFO - "repository": "", 04:39:39 INFO - "hasPatch": false, 04:39:39 INFO - "project": "", 04:39:39 INFO - "branch": "mozilla-aurora-macosx64-talos", 04:39:39 INFO - "changes": [ 04:39:39 INFO - { 04:39:39 INFO - "category": null, 04:39:39 INFO - "files": [ 04:39:39 INFO - { 04:39:39 INFO - "url": null, 04:39:39 INFO - "name": "https://queue.taskcluster.net/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 04:39:39 INFO - } 04:39:39 INFO - ], 04:39:39 INFO - "repository": "", 04:39:39 INFO - "rev": "124aaf8a8940cf68c741f7185b317c2afd0516b9", 04:39:39 INFO - "who": "cbook@mozilla.com", 04:39:39 INFO - "when": 1448368740, 04:39:39 INFO - "number": 6699958, 04:39:39 INFO - "comments": "Bug 1222866 - P3. Fix mochitest. r=me, a=lizzard\n\nActual calculated duration was 9.2879819869995117. The new behaviour and rounded value is as such more correct", 04:39:39 INFO - "project": "", 04:39:39 INFO - "at": "Tue 24 Nov 2015 04:39:00", 04:39:39 INFO - "branch": "mozilla-aurora-macosx64-talos", 04:39:39 INFO - "revlink": "", 04:39:39 INFO - "properties": [ 04:39:39 INFO - [ 04:39:39 INFO - "buildid", 04:39:39 INFO - "20151124031430", 04:39:39 INFO - "Change" 04:39:39 INFO - ], 04:39:39 INFO - [ 04:39:39 INFO - "builduid", 04:39:39 INFO - "6c336417cd914e19b4cdbf47fb413e66", 04:39:39 INFO - "Change" 04:39:39 INFO - ], 04:39:39 INFO - [ 04:39:39 INFO - "pgo_build", 04:39:39 INFO - "False", 04:39:39 INFO - "Change" 04:39:39 INFO - ] 04:39:39 INFO - ], 04:39:39 INFO - "revision": "124aaf8a8940cf68c741f7185b317c2afd0516b9" 04:39:39 INFO - } 04:39:39 INFO - ], 04:39:39 INFO - "revision": "124aaf8a8940cf68c741f7185b317c2afd0516b9" 04:39:39 INFO - } 04:39:39 INFO - } 04:39:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 04:39:39 INFO - Running post-action listener: _resource_record_post_action 04:39:39 INFO - ##### 04:39:39 INFO - ##### Running download-and-extract step. 04:39:39 INFO - ##### 04:39:39 INFO - Running pre-action listener: _resource_record_pre_action 04:39:39 INFO - Running main action method: download_and_extract 04:39:39 INFO - mkdir: /builds/slave/test/build/tests 04:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:39 INFO - https://queue.taskcluster.net/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:39:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/test_packages.json 04:39:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/test_packages.json 04:39:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:39:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:39:40 INFO - Downloaded 1149 bytes. 04:39:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:39:40 INFO - Using the following test package requirements: 04:39:40 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 04:39:40 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:39:40 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 04:39:40 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:39:40 INFO - u'jsshell-mac.zip'], 04:39:40 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:39:40 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 04:39:40 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 04:39:40 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:39:40 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 04:39:40 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:39:40 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 04:39:40 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:39:40 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 04:39:40 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 04:39:40 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 04:39:40 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 04:39:40 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:40 INFO - https://queue.taskcluster.net/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:39:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:39:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:39:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/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 04:39:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/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 04:39:42 INFO - Downloaded 17447969 bytes. 04:39:42 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 04:39:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:39:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 04:39:47 INFO - Return code: 0 04:39:47 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 04:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:47 INFO - https://queue.taskcluster.net/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:39:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:39:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:39:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/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 04:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/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 04:39:49 INFO - Downloaded 17447969 bytes. 04:39:49 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 04:39:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 04:39:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 04:39:55 INFO - Return code: 0 04:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:55 INFO - https://queue.taskcluster.net/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:39:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 04:39:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 04:39:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/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 04:39:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/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 04:39:56 INFO - Downloaded 11131307 bytes. 04:39:56 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 04:39:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 04:39:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 04:39:57 INFO - Return code: 0 04:39: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')]} 04:39:57 INFO - https://queue.taskcluster.net/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 04:39:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 04:39:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 04:39:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 04:39:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/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 04:40:08 INFO - Downloaded 107803822 bytes. 04:40:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 04:40:08 INFO - mkdir: /builds/slave/test/properties 04:40:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:40:08 INFO - Writing to file /builds/slave/test/properties/build_url 04:40:08 INFO - Contents: 04:40:08 INFO - build_url:https://queue.taskcluster.net/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 04:40:08 INFO - Running post-action listener: _resource_record_post_action 04:40:08 INFO - Running post-action listener: set_extra_try_arguments 04:40:08 INFO - ##### 04:40:08 INFO - ##### Running populate-webroot step. 04:40:08 INFO - ##### 04:40:08 INFO - Running pre-action listener: _resource_record_pre_action 04:40:08 INFO - Running main action method: populate_webroot 04:40:08 INFO - Guessing talos json url... 04:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:08 INFO - https://queue.taskcluster.net/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 04:40:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 04:40:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 04:40:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 04:40:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eu1qtpcoQPiDZ3qREXMynw/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 04:40:08 INFO - Downloaded 107 bytes. 04:40:08 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 04:40:08 INFO - Contents: 04:40:08 INFO - 20151124031430 04:40:08 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/124aaf8a8940cf68c741f7185b317c2afd0516b9 04:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:08 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/124aaf8a89/testing/talos/talos.json 04:40:08 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/124aaf8a89/testing/talos/talos.json to /builds/slave/test/build/talos.json 04:40:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/124aaf8a89/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 04:40:09 INFO - Downloaded 4264 bytes. 04:40:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:40:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:40:09 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:40:09 INFO - '../fennec_ids.txt'], 04:40:09 INFO - 'tests': ['tcheck2']}, 04:40:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:40:09 INFO - '--tppagecycles', 04:40:09 INFO - '7'], 04:40:09 INFO - 'tests': ['tsvgm']}}, 04:40:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:40:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:40:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:40:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:40:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:40:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:40:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:09 INFO - 'talos_options': ['--e10s'], 04:40:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:09 INFO - 'tests': ['damp', 'tps']}, 04:40:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:09 INFO - 'talos_options': ['--e10s'], 04:40:09 INFO - 'tests': ['damp', 'tps']}, 04:40:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:40:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:40:09 INFO - 'other': {'tests': ['a11yr', 04:40:09 INFO - 'ts_paint', 04:40:09 INFO - 'tpaint', 04:40:09 INFO - 'sessionrestore', 04:40:09 INFO - 'sessionrestore_no_auto_restore']}, 04:40:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:40:09 INFO - 'tests': ['a11yr', 04:40:09 INFO - 'ts_paint', 04:40:09 INFO - 'tpaint', 04:40:09 INFO - 'sessionrestore', 04:40:09 INFO - 'sessionrestore_no_auto_restore']}, 04:40:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:40:09 INFO - 'tests': ['a11yr', 04:40:09 INFO - 'ts_paint', 04:40:09 INFO - 'tpaint', 04:40:09 INFO - 'sessionrestore', 04:40:09 INFO - 'sessionrestore_no_auto_restore']}, 04:40:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:40:09 INFO - 'tests': ['a11yr', 04:40:09 INFO - 'ts_paint', 04:40:09 INFO - 'tpaint', 04:40:09 INFO - 'sessionrestore', 04:40:09 INFO - 'sessionrestore_no_auto_restore']}, 04:40:09 INFO - 'other_l64': {'tests': ['a11yr', 04:40:09 INFO - 'ts_paint', 04:40:09 INFO - 'tpaint', 04:40:09 INFO - 'sessionrestore', 04:40:09 INFO - 'sessionrestore_no_auto_restore']}, 04:40:09 INFO - 'other_nol64': {'tests': ['a11yr', 04:40:09 INFO - 'ts_paint', 04:40:09 INFO - 'tpaint', 04:40:09 INFO - 'sessionrestore', 04:40:09 INFO - 'sessionrestore_no_auto_restore']}, 04:40:09 INFO - 'svgr': {'tests': ['tsvgx', 04:40:09 INFO - 'tsvgr_opacity', 04:40:09 INFO - 'tart', 04:40:09 INFO - 'tscrollx', 04:40:09 INFO - 'cart']}, 04:40:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:40:09 INFO - 'tests': ['tsvgx', 04:40:09 INFO - 'tsvgr_opacity', 04:40:09 INFO - 'tart', 04:40:09 INFO - 'tscrollx', 04:40:09 INFO - 'cart']}, 04:40:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:09 INFO - 'tests': ['tp5o']}, 04:40:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:09 INFO - 'talos_options': ['--e10s'], 04:40:09 INFO - 'tests': ['tp5o']}, 04:40:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:09 INFO - 'talos_options': ['--xperf_path', 04:40:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:09 INFO - 'tests': ['tp5n']}, 04:40:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:09 INFO - 'talos_options': ['--e10s', 04:40:09 INFO - '--xperf_path', 04:40:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 04:40:09 INFO - 'C:/slave/talos-data/talos/xperf.config'], 04:40:09 INFO - 'tests': ['tp5n']}}, 04:40:09 INFO - 'talos.zip': {'path': '', 04:40:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:40:09 INFO - Running post-action listener: _resource_record_post_action 04:40:09 INFO - ##### 04:40:09 INFO - ##### Running create-virtualenv step. 04:40:09 INFO - ##### 04:40:09 INFO - Running pre-action listener: _resource_record_pre_action 04:40:09 INFO - Running main action method: create_virtualenv 04:40:09 INFO - Creating virtualenv /builds/slave/test/build/venv 04:40:09 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 04:40:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:40:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:40:09 INFO - Using real prefix '/tools/python27' 04:40:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:40:10 INFO - Installing distribute.............................................................................................................................................................................................done. 04:40:14 INFO - Installing pip.................done. 04:40:14 INFO - Return code: 0 04:40:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:40:14 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')]} 04:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:14 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')]} 04:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:14 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 0x100be1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c4e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd820668ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b969f0>, '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 0x1008f5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b60990>, '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.3JMVxMZiHY/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.Wi31xM56Xt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 04:40:14 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 04:40:14 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 04:40:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3JMVxMZiHY/Render', 04:40:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:14 INFO - 'HOME': '/Users/cltbld', 04:40:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:14 INFO - 'LOGNAME': 'cltbld', 04:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:14 INFO - 'MOZ_NO_REMOTE': '1', 04:40:14 INFO - 'NO_EM_RESTART': '1', 04:40:14 INFO - 'PAGER': '/bin/cat', 04:40:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:14 INFO - 'PWD': '/builds/slave/test', 04:40:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:14 INFO - 'SHELL': '/bin/bash', 04:40:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wi31xM56Xt/Listeners', 04:40:14 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 04:40:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:14 INFO - 'USER': 'cltbld', 04:40:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:14 INFO - 'XPC_FLAGS': '0x0', 04:40:14 INFO - 'XPC_SERVICE_NAME': '0', 04:40:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:14 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 04:40:14 INFO - Cleaning up... 04:40:14 INFO - Return code: 0 04:40:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:40:14 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')]} 04:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:14 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')]} 04:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:14 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 0x100be1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c4e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd820668ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b969f0>, '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 0x1008f5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b60990>, '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.3JMVxMZiHY/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.Wi31xM56Xt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 04:40:14 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 04:40:14 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 04:40:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3JMVxMZiHY/Render', 04:40:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:14 INFO - 'HOME': '/Users/cltbld', 04:40:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:14 INFO - 'LOGNAME': 'cltbld', 04:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:14 INFO - 'MOZ_NO_REMOTE': '1', 04:40:14 INFO - 'NO_EM_RESTART': '1', 04:40:14 INFO - 'PAGER': '/bin/cat', 04:40:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:14 INFO - 'PWD': '/builds/slave/test', 04:40:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:14 INFO - 'SHELL': '/bin/bash', 04:40:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wi31xM56Xt/Listeners', 04:40:14 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 04:40:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:14 INFO - 'USER': 'cltbld', 04:40:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:14 INFO - 'XPC_FLAGS': '0x0', 04:40:14 INFO - 'XPC_SERVICE_NAME': '0', 04:40:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:14 INFO - Downloading/unpacking psutil>=0.7.1 04:40:14 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 04:40:14 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 04:40:14 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 04:40:14 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 04:40:14 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 04:40:14 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 04:40:17 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:40:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:40:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:40:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:17 INFO - Installing collected packages: psutil 04:40:17 INFO - Running setup.py install for psutil 04:40:17 INFO - building 'psutil._psutil_osx' extension 04:40:17 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 04:40:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:40:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:40:18 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 04:40:18 INFO - building 'psutil._psutil_posix' extension 04:40:18 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 04:40:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:40:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:40:18 INFO - ^ 04:40:18 INFO - 1 warning generated. 04:40:18 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 04:40:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:18 INFO - Successfully installed psutil 04:40:18 INFO - Cleaning up... 04:40:18 INFO - Return code: 0 04:40:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:40: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')]} 04:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40: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')]} 04:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:18 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 0x100be1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c4e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd820668ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b969f0>, '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 0x1008f5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b60990>, '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.3JMVxMZiHY/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.Wi31xM56Xt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 04:40:18 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 04:40:18 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 04:40:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3JMVxMZiHY/Render', 04:40:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:18 INFO - 'HOME': '/Users/cltbld', 04:40:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:18 INFO - 'LOGNAME': 'cltbld', 04:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:18 INFO - 'MOZ_NO_REMOTE': '1', 04:40:18 INFO - 'NO_EM_RESTART': '1', 04:40:18 INFO - 'PAGER': '/bin/cat', 04:40:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:18 INFO - 'PWD': '/builds/slave/test', 04:40:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:18 INFO - 'SHELL': '/bin/bash', 04:40:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wi31xM56Xt/Listeners', 04:40:18 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 04:40:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:18 INFO - 'USER': 'cltbld', 04:40:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:18 INFO - 'XPC_FLAGS': '0x0', 04:40:18 INFO - 'XPC_SERVICE_NAME': '0', 04:40:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:40:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:40:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:40:22 INFO - Installing collected packages: mozsystemmonitor 04:40:22 INFO - Running setup.py install for mozsystemmonitor 04:40:22 INFO - Successfully installed mozsystemmonitor 04:40:22 INFO - Cleaning up... 04:40:22 INFO - Return code: 0 04:40:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100be1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c4e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd820668ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b969f0>, '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 0x1008f5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b60990>, '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.3JMVxMZiHY/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.Wi31xM56Xt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 04:40:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:40:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:40:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3JMVxMZiHY/Render', 04:40:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:22 INFO - 'HOME': '/Users/cltbld', 04:40:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:22 INFO - 'LOGNAME': 'cltbld', 04:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:22 INFO - 'MOZ_NO_REMOTE': '1', 04:40:22 INFO - 'NO_EM_RESTART': '1', 04:40:22 INFO - 'PAGER': '/bin/cat', 04:40:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:22 INFO - 'PWD': '/builds/slave/test', 04:40:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:22 INFO - 'SHELL': '/bin/bash', 04:40:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wi31xM56Xt/Listeners', 04:40:22 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 04:40:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:22 INFO - 'USER': 'cltbld', 04:40:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:22 INFO - 'XPC_FLAGS': '0x0', 04:40:22 INFO - 'XPC_SERVICE_NAME': '0', 04:40:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:22 INFO - Downloading/unpacking blobuploader==1.2.4 04:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:25 INFO - Downloading blobuploader-1.2.4.tar.gz 04:40:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:40:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:40:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:40:26 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 04:40:26 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 04:40:26 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 04:40:26 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 04:40:26 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 04:40:26 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 04:40:26 INFO - Downloading docopt-0.6.1.tar.gz 04:40:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:40:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:40:26 INFO - Installing collected packages: blobuploader, requests, docopt 04:40:26 INFO - Running setup.py install for blobuploader 04:40:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:40:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:40:26 INFO - Running setup.py install for requests 04:40:27 INFO - Running setup.py install for docopt 04:40:27 INFO - Successfully installed blobuploader requests docopt 04:40:27 INFO - Cleaning up... 04:40:27 INFO - Return code: 0 04:40:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:27 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')]} 04:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:27 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')]} 04:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:27 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 0x100be1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c4e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd820668ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b969f0>, '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 0x1008f5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b60990>, '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.3JMVxMZiHY/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.Wi31xM56Xt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 04:40:27 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 04:40:27 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 04:40:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3JMVxMZiHY/Render', 04:40:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:27 INFO - 'HOME': '/Users/cltbld', 04:40:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:27 INFO - 'LOGNAME': 'cltbld', 04:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:27 INFO - 'MOZ_NO_REMOTE': '1', 04:40:27 INFO - 'NO_EM_RESTART': '1', 04:40:27 INFO - 'PAGER': '/bin/cat', 04:40:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:27 INFO - 'PWD': '/builds/slave/test', 04:40:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:27 INFO - 'SHELL': '/bin/bash', 04:40:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wi31xM56Xt/Listeners', 04:40:27 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 04:40:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:27 INFO - 'USER': 'cltbld', 04:40:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:27 INFO - 'XPC_FLAGS': '0x0', 04:40:27 INFO - 'XPC_SERVICE_NAME': '0', 04:40:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:40:28 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-rll88Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:40:28 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-bhM_eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:40:28 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-sWjHRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:40:28 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-hu9WPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:40:28 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-qk7_ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:40:28 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-0IeBLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:40:29 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-0XLxgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:40:29 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-8WG6oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:40:29 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-HiEgjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:40:29 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-BIWNY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:40:29 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-DZnCl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:40:29 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-mXvA10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:40:29 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-ukM8QE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:40:29 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-JuoiYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:30 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-ttzWhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:40:30 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-wnnlTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:40:30 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-jYNvyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:40:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:40:30 INFO - Running setup.py install for manifestparser 04:40:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:40:30 INFO - Running setup.py install for mozcrash 04:40:30 INFO - Running setup.py install for mozdebug 04:40:31 INFO - Running setup.py install for mozdevice 04:40:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:40:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:40:31 INFO - Running setup.py install for mozfile 04:40:31 INFO - Running setup.py install for mozhttpd 04:40:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:40:31 INFO - Running setup.py install for mozinfo 04:40:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:40:31 INFO - Running setup.py install for mozInstall 04:40:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:40:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:40:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:40:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:40:31 INFO - Running setup.py install for mozleak 04:40:32 INFO - Running setup.py install for mozlog 04:40:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:40:32 INFO - Running setup.py install for moznetwork 04:40:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:40:32 INFO - Running setup.py install for mozprocess 04:40:32 INFO - Running setup.py install for mozprofile 04:40:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:40:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:40:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:40:32 INFO - Running setup.py install for mozrunner 04:40:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:40:33 INFO - Running setup.py install for mozscreenshot 04:40:33 INFO - Running setup.py install for moztest 04:40:33 INFO - Running setup.py install for mozversion 04:40:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:40:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:40:33 INFO - Cleaning up... 04:40:33 INFO - Return code: 0 04:40:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:33 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 0x100be1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c4e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd820668ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b969f0>, '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 0x1008f5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b60990>, '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.3JMVxMZiHY/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.Wi31xM56Xt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 04:40:33 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 04:40:33 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 04:40:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3JMVxMZiHY/Render', 04:40:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:33 INFO - 'HOME': '/Users/cltbld', 04:40:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:33 INFO - 'LOGNAME': 'cltbld', 04:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:33 INFO - 'MOZ_NO_REMOTE': '1', 04:40:33 INFO - 'NO_EM_RESTART': '1', 04:40:33 INFO - 'PAGER': '/bin/cat', 04:40:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:33 INFO - 'PWD': '/builds/slave/test', 04:40:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:33 INFO - 'SHELL': '/bin/bash', 04:40:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wi31xM56Xt/Listeners', 04:40:33 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 04:40:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:33 INFO - 'USER': 'cltbld', 04:40:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:33 INFO - 'XPC_FLAGS': '0x0', 04:40:33 INFO - 'XPC_SERVICE_NAME': '0', 04:40:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:40:34 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-wnaL23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:40:34 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)) 04:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:40:34 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-83TFhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:40:34 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)) 04:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:40:34 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-yDc5Me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:40:34 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)) 04:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:40:34 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-T3zV08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:40:34 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)) 04:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:40:34 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-vAGRQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:40:34 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)) 04:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:40:34 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-kG7OC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:40:34 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)) 04:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:40:34 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-zQ05gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:40:35 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)) 04:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:40:35 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-K3f9YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:40:35 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)) 04:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:40:35 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-dgN3Cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:40:35 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)) 04:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:40:35 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-pvswiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:40:35 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)) 04:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:40:35 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-kLvTx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:40:35 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)) 04:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:40:35 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-H5D6WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:40:35 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)) 04:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:40:35 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-NRQ0_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:40:35 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)) 04:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:40:35 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-3cCLyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:40:36 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)) 04:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:36 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-VIg3Wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:40:36 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)) 04:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:40:36 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-tdhIOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:40:36 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)) 04:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:40:36 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-9rJF04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:40:36 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)) 04:40:36 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)) 04:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:40:36 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)) 04:40:36 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)) 04:40:36 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)) 04:40:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:40:36 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 04:40:36 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 04:40:36 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 04:40:36 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 04:40:36 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 04:40:36 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 04:40:39 INFO - Downloading blessings-1.5.1.tar.gz 04:40:39 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 04:40:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:40:39 INFO - Installing collected packages: blessings 04:40:39 INFO - Running setup.py install for blessings 04:40:39 INFO - Successfully installed blessings 04:40:39 INFO - Cleaning up... 04:40:39 INFO - Return code: 0 04:40:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:40:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:40:39 INFO - Reading from file tmpfile_stdout 04:40:39 INFO - Current package versions: 04:40:39 INFO - blessings == 1.5.1 04:40:39 INFO - blobuploader == 1.2.4 04:40:39 INFO - docopt == 0.6.1 04:40:39 INFO - manifestparser == 1.1 04:40:39 INFO - mozInstall == 1.12 04:40:39 INFO - mozcrash == 0.16 04:40:39 INFO - mozdebug == 0.1 04:40:39 INFO - mozdevice == 0.46 04:40:39 INFO - mozfile == 1.2 04:40:39 INFO - mozhttpd == 0.7 04:40:39 INFO - mozinfo == 0.8 04:40:39 INFO - mozleak == 0.1 04:40:39 INFO - mozlog == 3.0 04:40:39 INFO - moznetwork == 0.27 04:40:39 INFO - mozprocess == 0.22 04:40:39 INFO - mozprofile == 0.27 04:40:39 INFO - mozrunner == 6.11 04:40:39 INFO - mozscreenshot == 0.1 04:40:39 INFO - mozsystemmonitor == 0.0 04:40:39 INFO - moztest == 0.7 04:40:39 INFO - mozversion == 1.4 04:40:39 INFO - psutil == 3.1.1 04:40:39 INFO - requests == 1.2.3 04:40:39 INFO - wsgiref == 0.1.2 04:40:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:39 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 0x100be1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c4e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd820668ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b969f0>, '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 0x1008f5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b60990>, '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.3JMVxMZiHY/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.Wi31xM56Xt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 04:40:39 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 04:40:39 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 04:40:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3JMVxMZiHY/Render', 04:40:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:39 INFO - 'HOME': '/Users/cltbld', 04:40:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:39 INFO - 'LOGNAME': 'cltbld', 04:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:39 INFO - 'MOZ_NO_REMOTE': '1', 04:40:39 INFO - 'NO_EM_RESTART': '1', 04:40:39 INFO - 'PAGER': '/bin/cat', 04:40:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:39 INFO - 'PWD': '/builds/slave/test', 04:40:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:39 INFO - 'SHELL': '/bin/bash', 04:40:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wi31xM56Xt/Listeners', 04:40:39 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 04:40:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:39 INFO - 'USER': 'cltbld', 04:40:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:39 INFO - 'XPC_FLAGS': '0x0', 04:40:39 INFO - 'XPC_SERVICE_NAME': '0', 04:40:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:40 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)) 04:40:40 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)) 04:40:40 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)) 04:40:40 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)) 04:40:40 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)) 04:40:40 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)) 04:40:40 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)) 04:40:40 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)) 04:40:40 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)) 04:40:40 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)) 04:40:40 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)) 04:40:40 INFO - Cleaning up... 04:40:40 INFO - Return code: 0 04:40:40 INFO - Running post-action listener: _resource_record_post_action 04:40:40 INFO - Running post-action listener: _start_resource_monitoring 04:40:40 INFO - Starting resource monitoring. 04:40:40 INFO - ##### 04:40:40 INFO - ##### Running install step. 04:40:40 INFO - ##### 04:40:40 INFO - Running pre-action listener: _resource_record_pre_action 04:40:40 INFO - Running main action method: install 04:40:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:40:40 INFO - Reading from file tmpfile_stdout 04:40:40 INFO - Detecting whether we're running mozinstall >=1.0... 04:40:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:40:40 INFO - Reading from file tmpfile_stdout 04:40:40 INFO - Output received: 04:40:40 INFO - Usage: mozinstall [options] installer 04:40:40 INFO - Options: 04:40:40 INFO - -h, --help show this help message and exit 04:40:40 INFO - -d DEST, --destination=DEST 04:40:40 INFO - Directory to install application into. [default: 04:40:40 INFO - "/builds/slave/test"] 04:40:40 INFO - --app=APP Application being installed. [default: firefox] 04:40:40 INFO - mkdir: /builds/slave/test/build/application 04:40:40 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'] 04:40:40 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 04:41:21 INFO - Reading from file tmpfile_stdout 04:41:21 INFO - Output received: 04:41:21 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:41:21 INFO - Running post-action listener: _resource_record_post_action 04:41:21 INFO - ##### 04:41:21 INFO - ##### Running run-tests step. 04:41:21 INFO - ##### 04:41:21 INFO - Running pre-action listener: _resource_record_pre_action 04:41:21 INFO - Running main action method: run_tests 04:41:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:41:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:41:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:41:21 INFO - 2015-11-24 04:41:21.639 screenresolution[2268:19684] starting screenresolution argv=screenresolution get 04:41:21 INFO - 2015-11-24 04:41:21.643 screenresolution[2268:19684] Display 0: 1600x1200x32@60 04:41:21 INFO - 2015-11-24 04:41:21.650 screenresolution[2269:19686] starting screenresolution argv=screenresolution list 04:41:21 INFO - Available Modes on Display 0 04:41:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:41:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:41:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:41:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:41:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:41:21 INFO - Intel HD Graphics 3000: 04:41:21 INFO - Chipset Model: Intel HD Graphics 3000 04:41:21 INFO - Type: GPU 04:41:21 INFO - Bus: Built-In 04:41:21 INFO - VRAM (Total): 512 MB 04:41:21 INFO - VRAM (Dynamic, Max): 10 04:41:21 INFO - Vendor: Intel (0x8086) 04:41:21 INFO - Device ID: 0x0116 04:41:21 INFO - Revision ID: 0x0009 04:41:21 INFO - Displays: 04:41:21 INFO - Display: 04:41:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:41:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:41:21 INFO - Display Serial Number: 1600x1200 60 04:41:21 INFO - Main Display: Yes 04:41:21 INFO - Mirror: Off 04:41:21 INFO - Online: Yes 04:41:21 INFO - Rotation: Supported 04:41:21 INFO - Return code: 0 04:41:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:41:21 INFO - Python 2.7.3 04:41:21 INFO - Return code: 0 04:41:21 INFO - grabbing minidump binary from tooltool 04:41:21 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')]} 04:41:21 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 0x100b969f0>, '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 0x1008f5cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b60990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:41:21 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 04:41:21 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 04:41:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:41:22 INFO - Return code: 0 04:41:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:41:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:41:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:41:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:41:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:41:22 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/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0101', '--webServer', 'localhost'] in /builds/slave/test/build 04:41:22 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/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0101 --webServer localhost 04:41:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3JMVxMZiHY/Render', 04:41:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:22 INFO - 'HOME': '/Users/cltbld', 04:41:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:22 INFO - 'LOGNAME': 'cltbld', 04:41:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:41:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:22 INFO - 'MOZ_NO_REMOTE': '1', 04:41:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:41:22 INFO - 'NO_EM_RESTART': '1', 04:41:22 INFO - 'PAGER': '/bin/cat', 04:41:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:22 INFO - 'PWD': '/builds/slave/test', 04:41:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:41:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:22 INFO - 'SHELL': '/bin/bash', 04:41:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wi31xM56Xt/Listeners', 04:41:22 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 04:41:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:22 INFO - 'USER': 'cltbld', 04:41:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:22 INFO - 'XPC_FLAGS': '0x0', 04:41:22 INFO - 'XPC_SERVICE_NAME': '0', 04:41:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:41:22 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/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0101', '--webServer', 'localhost'] with output_timeout 3600 04:41:22 INFO - mozversion INFO | application_buildid: 20151124031430 04:41:22 INFO - mozversion INFO | application_changeset: 124aaf8a8940cf68c741f7185b317c2afd0516b9 04:41:22 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 04:41:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:41:22 INFO - mozversion INFO | application_name: Firefox 04:41:22 INFO - mozversion INFO | application_remotingname: firefox-dev 04:41:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:41:22 INFO - mozversion INFO | application_vendor: Mozilla 04:41:22 INFO - mozversion INFO | application_version: 44.0a2 04:41:22 INFO - mozversion INFO | platform_buildid: 20151124031430 04:41:22 INFO - mozversion INFO | platform_changeset: 124aaf8a8940cf68c741f7185b317c2afd0516b9 04:41:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:41:22 INFO - mozversion INFO | platform_version: 44.0a2 04:41:22 INFO - 2015-11-24 04:41:22,325 DEBUG : using testdate: 1448368882 04:41:22 INFO - 2015-11-24 04:41:22,325 DEBUG : actual date: 1448368882 04:41:22 INFO - 2015-11-24 04:41:22,334 INFO : starting webserver on 'localhost:50015' 04:41:22 INFO - 2015-11-24 04:41:22,335 INFO : Starting test suite t-yosemite-r5-0101 04:41:22 INFO - 2015-11-24 04:41:22,335 INFO : Starting test dromaeo_css 04:41:22 INFO - 2015-11-24 04:41:22,336 DEBUG : operating with platform_type : mac_ 04:41:22 INFO - 2015-11-24 04:41:22,336 INFO : Initialising browser for dromaeo_css test... 04:41:22 INFO - 2015-11-24 04:41:22,352 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpkNtJCi/profile http://localhost:50015/getInfo.html 04:41:24 INFO - 2015-11-24 04:41:24,891 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:41:24 INFO - 2015-11-24 04:41:24,891 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:41:24 INFO - 2015-11-24 04:41:24,891 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:41:24 INFO - 2015-11-24 04:41:24,891 DEBUG : BROWSER_OUTPUT: __metrics 04:41:24 INFO - 2015-11-24 04:41:24,907 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:41:25 INFO - 2015-11-24 04:41:25,699 INFO : Browser initialized. 04:41:25 INFO - 2015-11-24 04:41:25,700 INFO : Running cycle 1/1 for dromaeo_css test... 04:41:25 INFO - 2015-11-24 04:41:25,700 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpkNtJCi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:41:37 INFO - 2015-11-24 04:41:37,773 DEBUG : BROWSER_OUTPUT: RSS: Main: 199757824 04:41:37 INFO - 2015-11-24 04:41:37,773 DEBUG : BROWSER_OUTPUT: 04:42:29 INFO - 2015-11-24 04:42:29,173 DEBUG : BROWSER_OUTPUT: 1448368949172 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] 04:44:39 INFO - 2015-11-24 04:44:39,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50015/tests/dromaeo/cssquery-ext.html) 04:44:40 INFO - 2015-11-24 04:44:40,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 314462208 04:44:40 INFO - 2015-11-24 04:44:40,607 DEBUG : BROWSER_OUTPUT: 04:47:43 INFO - 2015-11-24 04:47:43,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/dromaeo/cssquery-ext.html (next: http://localhost:50015/tests/dromaeo/cssquery-jquery.html) 04:47:44 INFO - 2015-11-24 04:47:44,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 343281664 04:47:44 INFO - 2015-11-24 04:47:44,064 DEBUG : BROWSER_OUTPUT: 04:50:46 INFO - 2015-11-24 04:50:46,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50015/tests/dromaeo/cssquery-mootools.html) 04:50:46 INFO - 2015-11-24 04:50:46,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 307740672 04:50:46 INFO - 2015-11-24 04:50:46,859 DEBUG : BROWSER_OUTPUT: 04:53:48 INFO - 2015-11-24 04:53:48,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50015/tests/dromaeo/cssquery-prototype.html) 04:53:49 INFO - 2015-11-24 04:53:49,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 300662784 04:53:49 INFO - 2015-11-24 04:53:49,539 DEBUG : BROWSER_OUTPUT: 04:56:52 INFO - 2015-11-24 04:56:52,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50015/tests/dromaeo/cssquery-yui.html) 04:56:53 INFO - 2015-11-24 04:56:53,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 301096960 04:56:53 INFO - 2015-11-24 04:56:53,466 DEBUG : BROWSER_OUTPUT: 04:59:56 INFO - 2015-11-24 04:59:56,132 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/dromaeo/cssquery-yui.html (next: http://localhost:50015/tests/dromaeo/cssquery-dojo.html) 04:59:56 INFO - 2015-11-24 04:59:56,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 349196288 04:59:56 INFO - 2015-11-24 04:59:56,393 DEBUG : BROWSER_OUTPUT: 04:59:56 INFO - 2015-11-24 04:59:56,393 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:59:56 INFO - 2015-11-24 04:59:56,393 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:59:56 INFO - 2015-11-24 04:59:56,394 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:59:56 INFO - 2015-11-24 04:59:56,394 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:59:56 INFO - 2015-11-24 04:59:56,394 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2648.1790644900075;2655.721149279326;2707.011940641664;2718.524258254806;2727.2363738153313;4493.281075027988;4495.6628252881;4537.886552836181;4588.311753237016;4597.931031034533;4514.48083470401;4531.139083574119;4551.8634440966825;4590.449146102464;4617.261238201889;4145.606167414091;4151.377293405983;4193.93709094363;4250.149970005996;4252.2983707688345;4302.376155457457;4304.483461984566;4363;4379.9926017016105;4415.779211039435;4439.378487011821;4488.596026357627;4488.8877778055485;4503.211937910869;4544.750038747868;4193.287141186006;4461.553844615545;4478.193925093482;4487.416635837353;4538.6369090472845;4069.7151199416053;4260.957390426087;4266.978665106686;4276.786160691984;4393.714408563465;4653.88365290867;4735.408073990751;4775.594074503671;4781.617470602343;4827.758612069418;5073.340465739467;5076.54311111998;5127.384713834326;5135.204043373283;5156;4915.778789954461;4989.476105008995;5117.208976858107;5133.153029750087;5206.271122042917;4707.199776038116;4709.293605959134;4713.269443236304;4743.501932297128;4748.833790817339;5125.948740512622;5131.512506311894;5137.17805151174;5144.768485418165;5160.277561141444;4803.567678908915;4807.399075115611;4936.308916751657;4946.431160416526;4951.158303088484;5158.174692049254;5158.458361872024;5162.251473536317;5173.3533308336455;5175.120229560984;5080.339555857715;5084.8220312288895;5098.923516147261;5117.155669314596;5119.308893299357;4764.071006153767;4885.951140488621;4898.755062246873;4959.851204463872;5143.12566863634;3799.506064211635;3862.5558060822805;3887.319719049155;3918.529776426847;3927.410888366711;3420.452727563578;3426.1777173478185;3473.635268296843;3512.455569386749;3608.314420260142;4583.977080114578;4607.976960115178;4626.051659409813;4628.60656844172;4630.305454181832;4802.951970480321;4881.8535443936735;4893.437254715682;4983.377077865267;5087.211482220262;4672.065586882637;4672.57946784791;4758.690685105457;4771.045790841846;4776.355192049098;4401.603855653007;4429.202743506135;4442.5557444255965;4442.8222871085445;4462.352958820953;4962.354893863775;5119.385673719103;5119.564836988898;5134.947335796228;5205.037068142406;5032.446430892525;5044.2685810558;5065.037642847848;5068.771905264346;5105.846824595268;5107.489251074863;5246.2392953020835;5251.186066159751;5259.132243179833;5262.763175657028;4881.536254055859;5099.745012749422;5108.514691104339;5114;5123.257127716534;5014.84955451337;5109.437961824122;5152.458991805956;5168.870778230575;5194.870128246824;5025.773840177128;5078.4921507850395;5078.873028174326;5101.8724531887;5119.180931051014;4835.081334546425;5014.899702005867;5068.59451243907;5069.822556210515;5083.92374114396;4664.0905023521445;4818.975905120452;4908.92636610444;4918.114739346952;4926.039422312615;4981.900361992813;5002.824901128443;5041.1430056889685;5044.2685810558;5058.924116138334;4940.802367905388;4956.504349565014;4973.104841128632;4984.102861484823;5035.16919708244 04:59:56 INFO - 2015-11-24 04:59:56,397 DEBUG : BROWSER_OUTPUT: |1;ext.html;488.38707422185155;499.555395697829;500.81970490623394;512.8846009647829;529.8728305206752;27880.163595092155;28587.142385728435;34500;34812.47781283277;35536.46695299566;37472.62527374725;37650.81174594123;37831.62168378315;37919.431208531896;37948;7363.447741419388;7656.655450504727;7824.608769561499;7845.176256493043;7923.366130709529;7353.374963128141;9538.713838584854;9634.9518252409;9650.034996500364;9782.16851567614;9546.474943878118;9548.18840398567;9555.665551705692;9572.856407153899;9614.567344469515;7497.325240728361;7665.386769058462;9456.669016584387;9473.526323683822;9504.904950950506;9239.445633262027;9401.294902882311;9408.95295523518;9431.90568094324;9534.570944307454;34866.47700284498;35322;35324.823375883214;35345.646543534494;35363.646363536296;2551.693796744384;2566.7176610572824;2602.2973797074683;2791.1207969489546;2937.4712551740677;24046.398840028964;24148.758512414828;24462.877685611635;24591;24947.126850560144;2033.6746120620778;2047.2834507922257;2062.257587268582;2090.2997495838913;2127.638301488735;238698;240055;241789;242417;243239;44978;46350;51390.48609513932;52178.47821521812;52669.73665131727;58883;60198.09702854461;60307.396926030175;60420.18739437824;61026.55893764288;14978.17620030887;15130;15320.923395383175;15353.846461535464;15363.462278820187;11084.168687348481;11109.666709998713;11291.830622540669;11292.71768205785;11294.265872718412;16523.421680241136;16553.172341382884;16577.336906523844;16687.415940442028;16829.663406731797;7253.310935461122;7289.95881153278;7293.52592081513;7344.70621175147;7359.521631093961;809.7566770278504;830.8130670599066;905.9184673379427;907.7821322882461;985.9359141655913;23937.91702065283;26722.331941701614;26963.325916852235;26979.730202697723;26994.325141871217;908.0873721909571;911.4941207629696;924.5284904698652;966.2946049383849;1012.6759436980243;10533.262671613067;11970.40147992597;12186.207896486878;12187.45156467961;12452.688682782822;221543;222131;222744;222994;223702;38911.80544097262;39754.403683944765;42634;43129.784351078044;43992.78003609961;1192.9701757456132;1225.0505857960152;1230.4489006767008;1238.5231685801032;1257.3964497041654;24151;24719.62920556157;25213.11754088598;25367.873160634077;25421;37968.430473542365;38374.424383634825;42621.78689106535;44115;44256;180717.0964145171;182389;185271;187257;187442;25927.092551760597;25961.091361802246;26196.345091372867;26532.469350613264;26636;32567.511487327236;32649.34701306008;33734.32531349408;34038.829805850815;34315.828420858736;29782.404351913272;29816.552751709176;29841.701582983893;29845.70154298429;30254.394912102074;28838;29372;30059.699403006565;30723.385532288783;31210.843945780125;30710.539341909443;31549.684503155593;31745.5238171423;31905.883294085525;31921;25338.366540836625;27432.58851117195;27433.45133097367;27879.442411151256;28343.14970550887;20689.58620827545;20763.68854467154;20801.479963001046;21129.366119016453;22053.889730551244 04:59:56 INFO - 2015-11-24 04:59:56,399 DEBUG : BROWSER_OUTPUT: |2;jquery.html;302.8552073163443;307.4189781313318;308.3293835906902;311.5015974440895;315.79315548315844;15008.39966401344;15350.462733804305;15523;16207.756883646754;16232.75650865238;10647.2014598905;10743.83884241737;10786;10798.6760397188;15519.689606207869;3791.052236940765;3796.5823759386444;3908.1988192420627;3973.1259122992897;3982.8207730652043;3881.844726210948;3889.105505733683;3890.3386424307937;3915.569287378386;3940.5074365704286;3089.474789285827;3175.0950978971;3182.427163110639;3844.077421418853;3905.082305658168;4124.876253712393;4179.038821071171;4240.957590424103;4241.766702831358;4301.483821941356;3614.9277014459826;3616.132128289218;3621;3624.782513049199;3662.816859157058;10058.547365368502;10371.533281002374;10399.428031458267;11261.43692815356;11309.660710178709;1570.4974408189385;1578.5895667126515;1586.5874872533109;1623.115402105855;1674.1712852138269;8215;8239.917600824036;8499.915000849975;8552.871706924401;8658.87011694825;1346.6229455752307;1357.2399456304502;1380.565121986581;1388.7639101352693;1401.7476854166246;48172;48901.266481002815;49011.75494122578;54183;54722.726386367816;5917.940820591825;5954.077118046623;6014.578979471395;6046.032634778414;6058.0610005449225;6766.83082922921;6824.976253562006;6840.452763778886;6841.452683785285;6845.212800527904;4926.162552366035;4980.477049909779;4982.950170498321;4987.850364489072;5014.323066385991;5124.590032797368;5228.241904923765;5261.894762104813;5308.283381743415;5313.415524292324;2629.7501737334924;2633.3285012322117;2633.8024648151463;2690.448458066092;2696.474187533451;922.8523436250168;943.0381011368365;949.3449519831432;954.4941181173989;1008.2035192198229;347.7791602332537;353.1348196917562;376.7268730170604;395.6676391830876;423.9152169566099;8759.255463285692;10210.744731381626;10279.229057820694;10394.844077338847;10428;383.6374625978424;411.78381349791;414.9647279981235;419.57203652274507;431.11836294777254;5009.373828271466;5245.7114858683135;5620.690862002547;5654.6889921054735;5734.369219385864;514643;518410;523287;523384;532181;66479;67534.66232668805;68152.3184768146;68176.6591167041;68693.96959045618;420.2393667461904;422.67031715262146;422.68932334733944;425.10091157202294;429.7314178638351;9724.659636912675;9921.900780992097;9947.403155810674;9971.900280997388;10174.389536627827;31464.213394664403;31496.055118346485;31655.683443165275;31929.201769955936;31990.68009319877;44504.777476113704;45062.972166251944;45167.32249016333;46177.53822461867;46289;5464.153056276284;5728.856778580569;5734.59857809966;5782.306123265067;5792.797252096157;10376.481175941324;10382.480875956324;10550.683479495627;10554;10645.0951669109;8771.210591046836;8921.955390223007;8958.283337333129;9157.679481218393;9282.62869485213;8685.522296273766;8983.592839424857;9001.909980900107;9094.863577046483;9214.539273036187;9129.634814607607;9248.537573121452;9297.163255307054;9500.524973751422;9513.904860951301;4629.166749985035;5564.888702226014;5653.802116925888;5660.547156227574;5661.094224923992;8940.46357218569;9090.500022498825;9138.63445462174;9159.175674189355;9172.266218702354 04:59:56 INFO - 2015-11-24 04:59:56,402 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1132.773445310938;1427.9286035698215;1528.0984219310606;1539.1303913288991;1580.84981926717;6323.968380158099;6377.9043314350265;6490.156279683641;6586.736530538773;6710.597364158154;6547.90178147327;6680.632565208912;6720.327967203277;6724.495662825296;6821.283765204656;1925.8074192580734;1952.023988005997;1954.2280799084353;1957.7552805899263;1958.5789055353096;1943.319838056683;1967.5081229692578;1970.2217624038497;1971.3691618682028;1981.9108140133728;1884.7832499262554;1894.6589613869498;1898.0509745127436;1898.8955607441585;1926.5376309685714;1907.9523011924673;1940.3693799515213;1940.9708854367195;1941.9514512137168;1942.3784388995527;1931.748872646547;1937.3219373219401;1943.4558323669396;1944.0182707732647;1946.7079938009413;6163;6637.668116594151;6659.034440006172;6664.133662623828;6767.221769496522;3845.384738441836;4075.1034772350035;4188.5811418858175;4203.243416185085;4255.553166917491;2549.961750573743;2592.235290589281;2597.7921766258655;2606.192080455046;2643.537380958325;749.24700675821;760.9086909570832;771.8109063279533;773.4701729315437;775.6858472318663;9149.130832570896;9159.77100572491;9188.219001384958;9195;9340.859887101698;3676.0809797550614;3793.0327766419387;3826.732128750961;3844.154286057063;3852.325842977468;8122.106568277485;8127.878081828777;8130;8208.384371172186;8252.422330436812;4285.785710714452;4285.978570107191;4292.334688123284;4296.613304802583;4348.586884245991;3864.072622570563;3911.1982043681546;3928.7839168845417;3929.0373858404873;3968.6031396860662;3083.383323335342;3098.4732595458827;3125.749940004794;3132.2326030122767;3139.3250451152653;986.4722373530127;1000.1548691355792;1008.0322890025511;1008.0776089877826;1008.3848852200152;1055.3984228989402;1058.714147180257;1087.0216804875674;1091.5142761471227;1100.862392200975;6053.8486537836025;6123.693815309217;6142.017277235621;6164.506839452833;6213.409726076015;399.41884557968086;1052.2581579986092;1082.3830416662427;1096.6381094238882;1105.723569107723;4814.181589129857;4818.445878723922;4826;4880.170371036932;5020.297158397754;7584.2794934481135;7983.68065277394;8126.959365203136;8228.588570571448;8256.752297431087;8008.559529225832;8097.35221182304;8103.594820258963;8145.981752280964;8232.464889782264;6396.168498095218;6518.771842985568;6536.150300460909;6628.4697224221945;6647.468202543785;6523.347665233438;6532.738690452328;6568.770093046721;6622.701978410887;6637.203535575569;7103;7391.889121663072;7486.064241969754;7497.250274972459;7509.286617771303;7358.521696089737;7622.733204338044;7699.191584883731;7738.071431428265;7741.341985931033;5853.1805547222575;5873.5594830388745;5901.704914754331;5956.434138756811;6010.038393856962;6655.168103987002;6701.927691569325;6724.529282950147;6804.455643548603;6811.080504131879;6151.815445536641;6303.306636270098;6311.652859092794;6372.458341041063;6472.223333200046;6078.45293923549;6079.844829482384;6091.939080609137;6211.689415529296;6266.467350275278;6276.8430789228805;6278.843028924313;6293.716782744879;6348.174737284308;6351.460125889351;5405.864853378697;5412.052890744183;5441.755121019484;5454.972725136349;5527.336719593513;5437.157240627709;5508.697021663847;5595.188697638901;5603.159526071122;5640.717964101696 04:59:56 INFO - 2015-11-24 04:59:56,402 DEBUG : BROWSER_OUTPUT: |4;prototype.html;273.7085004470239;274.38263906211023;279.9146260390581;287.290392729957;299.3265153404839;5178.611604129686;5205.661631993918;5248.186531087683;5306.761195746191;5390.757415916283;5186.299849520314;5237.947620523793;5286.31277933868;5310.230016647583;5327.600429967758;4079.102597428561;4079.1841631673637;4091;4099.7745124018165;4155.376693495977;3926.7840268785208;3957.821898014582;3965.9603403966025;4065.166640838636;4101.446304748851;4004.6796256299426;4044.1102957349335;4045.2314060328445;4060.4112403701447;4063.674906007527;3987.063040185554;4014.7791871447057;4021.195760847842;4075.0219947212454;4095.7303235996787;3496.1958749487508;3499.7550171488006;3510.192655689206;3542.6811586957297;3552.1119720069983;4977.402711674622;5104.234364845266;5109;5163.896722065575;5179.715115668637;4663.906721865544;4663.930041049353;4680.602148817355;4690.577847993697;4712.387389639359;5571.8607034824045;5572.721363931828;5624.437556244384;5645.915311270293;5654.46282603152;3584.9283014339826;3668.321360548307;3798.981005094957;3879.7090218233743;3936.5472970608175;5676.205331253628;5709.914351284692;5746.655200687972;5798.855028624318;5842.415758424124;3910.276598829226;3931.941020884689;3933.8623148189677;3955.940660890089;3979.1047014421524;3976.9204615908097;4015.377616469452;4021.8391264349098;4030.717849750548;4032.6169013943627;4513.796879140446;4569.2689169732685;4643.3731446255;4698.647601429906;4732.95267047332;5467.589930755209;5550.389457159709;5555.30558680165;5556.333240011225;5613.607047506717;1409.7110092431028;1409.8872090232758;1409.9083559568596;1414.0525847682077;1426.5221150914351;933.6312156698066;958.755517343087;963.5615794813343;965.3821554205314;980.8921018687938;5235.921461178085;5257;5259.342582177228;5324.148136298174;5343.866403339947;5780.421957804186;5796.014677504834;5808.593398462067;5875.559333050039;5950.9107363389585;5319.946800532022;5331.573474122061;5340.946590534045;5373.731313434313;5405.108157154104;3147.1502694272417;3190.489521676521;3209.0533292678715;3215.951760723591;3273.29624130813;5837.357890632027;5851;5869.442402971711;5949.583529152917;5962.1056841473255;5895.4399332063385;5919.230500034968;5956.374580668968;5977.641341519436;6005.6997150142315;5776.393478684846;5852.092925596539;5875.882482350329;5945.851353716192;5958.64248145104;5815.76736930518;5832.24180856486;5843.737031833492;5915.467607915309;5918.348981611933;5557.360903495988;5566.944330556805;5738.9139162913425;5756.597038207286;5782.884342313046;5844.211031510692;5856.4143585641095;5872.735726892215;5895.67573783446;5947.940520594739;3681.963180368162;3717.85128594864;3727.7017838572306;3779.9244015118993;3787.5265591801026;5760.884782304414;5775.422457754191;5783.248177736868;5812.099124635688;5841.357450680337;5577.553795696415;5606.803761868478;5618.6628802272;5621.831345059655;5707.286589176353;5611.775528978958;5615.971920140373;5667.149927510906;5672.716364181857;5704.030314846403;5493.395726470005;5498.1752737089755;5538.307711536058;5571.275734154534;5591.776328946797;5457.754401052041;5592.636478628876;5622.269105016322;5686.488216060409;5699.686517241592;5513.917291240555;5514.035043867388;5575.052241118939;5609.691466969356;5631.605787594993 04:59:56 INFO - 2015-11-24 04:59:56,406 DEBUG : BROWSER_OUTPUT: |5;yui.html;558.5392051557463;576.3084298841388;610.8961476548986;661.8940969444889;676.8274090107022;10689.30519516231;10922.344659320446;11058.778824423516;11256.043236324913;11288.661340159788;10272.332298400599;10341.844872326903;10411.583536658543;10425.687229383111;10433.739156521091;739.589527812064;751.4627041665208;757.0196595408959;760.8402235530546;767.9539227646331;746.8692978728728;764.8776195808643;765.885117232414;765.8889461028148;767.5816679909435;791.0151860933146;791.695197349019;791.9168487308837;792.7066985215449;793.5595744361876;768.258630421643;775.1279810213538;783.9608019598998;786.3669745854585;788.4717239449583;577.8093229234385;585.8652509922699;586.574733318345;586.9823905282848;587.5475883569627;11871.287722736663;12088;12147.210431322024;12176.086793490524;12179.451924663412;7928.8810667840025;8241.134680858544;8287.378446616527;8521.786955326104;8698.260647844942;7479.401647868158;7491.32578067971;7575.393968482508;7700.4708168298;7919.683212671486;2473.1591258971857;2505.6241563765398;2544.2494464133124;2564.012855050819;2579.0457530713757;35267.64732352669;35496.64503354959;39069.21861562781;41937.16125677469;42512.78743606293;5156.535911767884;5271.578273738091;5316.734163291897;5594.524465420403;5679.233303503974;10995.230333876552;11019.889801101886;11032.06227470674;11193.440327983568;11205;5048.217526283432;5073.467285934998;5156.8968620627375;5250.422453530108;5293.708846013506;3227.5320078588943;3248.058063161704;3251.219707270238;3269.836508174582;3320.900372988814;2343.5312937412587;2345.6012477878803;2353.188150088217;2376.8455050421667;2377.9643305350432;349.8425708431216;350.411309000881;354.5745105872963;357.05736854703605;358.3513839949699;388.40186113385636;397.70172370721957;419.42329297216327;450.08183306055935;461.5499887609621;6295.181626388632;6397.136386587844;6577;6648.202215734143;6698.196216454056;366.7087886221197;384.68648051837664;390.00743108787634;485.8178183181307;528.8968651113073;3161.6206055273515;3167.920801979923;3262.5921759780026;3317.2370354818527;3364.360771453416;50395.496045039814;55482.16776748352;55788.16317755237;56635.716821415626;56725.43274567284;43784.56215437805;44082.33876491855;44136.77931610322;44159.11681766347;44173.779131104784;37399.25201496009;37404;40647.1870562593;41828.372574411405;43349;6655.633940133339;7152.821179470555;7441.553506789393;7499.379929559911;7570.886436703564;32653.673463265062;32676.50985235176;33202.33595328128;33692;34221.14447138841;35672.64327356693;35675.82162089277;40590.39114413227;40773.38839917344;41499.1700166001;6446.67766611677;6470.5147113965695;6556.901646475211;6706.8993965089585;6723.361280678328;9924.950375248078;10077.500012491755;10159.390436573829;10492.790144197226;10611.363318200623;8388.748337549883;8814.559272036244;9236.538173091185;9238;9371.812563748823;9119.452832830051;9296.116868897443;9367.531623418665;9381.452554089421;9711.465869377253;8817.206451419403;9019;9135.04082071373;9185.862212066691;9411.247100232102;7916.920830791619;7956.2043795619975;8103.594820258845;8167.387445941459;8309.964058805632;7960.283574478325;7994.2805147537;7997.320227780471;8098.756102653912;8135 04:59:56 INFO - 2015-11-24 04:59:56,406 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:59:56 INFO - 2015-11-24 04:59:56,406 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:59:56 INFO - 2015-11-24 04:59:56,406 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,934 04:59:56 INFO - 2015-11-24 04:59:56,406 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:59:56 INFO - 2015-11-24 04:59:56,407 DEBUG : BROWSER_OUTPUT: __startTimestamp1448369996390__endTimestamp 04:59:56 INFO - 2015-11-24 04:59:56,407 DEBUG : BROWSER_OUTPUT: 04:59:56 INFO - 2015-11-24 04:59:56,407 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:59:56 INFO - 2015-11-24 04:59:56,407 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:59:56 INFO - 2015-11-24 04:59:56,407 DEBUG : BROWSER_OUTPUT: 04:59:56 INFO - 2015-11-24 04:59:56,407 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4697.89 Median:4881.54 stddev:537.77 (11.0%) stddev-sans-first:514.82 04:59:56 INFO - 2015-11-24 04:59:56,407 DEBUG : BROWSER_OUTPUT: Values: 2648.2 2655.7 2707.0 2718.5 2727.2 4493.3 4495.7 4537.9 4588.3 4597.9 4514.5 4531.1 4551.9 4590.4 4617.3 4145.6 4151.4 4193.9 4250.1 4252.3 4302.4 4304.5 4363.0 4380.0 4415.8 4439.4 4488.6 4488.9 4503.2 4544.8 4193.3 4461.6 4478.2 4487.4 4538.6 4069.7 4261.0 4267.0 4276.8 4393.7 4653.9 4735.4 4775.6 4781.6 4827.8 5073.3 5076.5 5127.4 5135.2 5156.0 4915.8 4989.5 5117.2 5133.2 5206.3 4707.2 4709.3 4713.3 4743.5 4748.8 5125.9 5131.5 5137.2 5144.8 5160.3 4803.6 4807.4 4936.3 4946.4 4951.2 5158.2 5158.5 5162.3 5173.4 5175.1 5080.3 5084.8 5098.9 5117.2 5119.3 4764.1 4886.0 4898.8 4959.9 5143.1 3799.5 3862.6 3887.3 3918.5 3927.4 3420.5 3426.2 3473.6 3512.5 3608.3 4584.0 4608.0 4626.1 4628.6 4630.3 4803.0 4881.9 4893.4 4983.4 5087.2 4672.1 4672.6 4758.7 4771.0 4776.4 4401.6 4429.2 4442.6 4442.8 4462.4 4962.4 5119.4 5119.6 5134.9 5205.0 5032.4 5044.3 5065.0 5068.8 5105.8 5107.5 5246.2 5251.2 5259.1 5262.8 4881.5 5099.7 5108.5 5114.0 5123.3 5014.8 5109.4 5152.5 5168.9 5194.9 5025.8 5078.5 5078.9 5101.9 5119.2 4835.1 5014.9 5068.6 5069.8 5083.9 4664.1 4819.0 4908.9 4918.1 4926.0 4981.9 5002.8 5041.1 5044.3 5058.9 4940.8 4956.5 4973.1 4984.1 5035.2 04:59:56 INFO - 2015-11-24 04:59:56,407 DEBUG : BROWSER_OUTPUT: 04:59:56 INFO - 2015-11-24 04:59:56,408 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37141.74 Median:30482.47 stddev:56532.82 (185.5%) stddev-sans-first:56624.41 04:59:56 INFO - 2015-11-24 04:59:56,409 DEBUG : BROWSER_OUTPUT: Values: 488.4 499.6 500.8 512.9 529.9 27880.2 28587.1 34500.0 34812.5 35536.5 37472.6 37650.8 37831.6 37919.4 37948.0 7363.4 7656.7 7824.6 7845.2 7923.4 7353.4 9538.7 9635.0 9650.0 9782.2 9546.5 9548.2 9555.7 9572.9 9614.6 7497.3 7665.4 9456.7 9473.5 9504.9 9239.4 9401.3 9409.0 9431.9 9534.6 34866.5 35322.0 35324.8 35345.6 35363.6 2551.7 2566.7 2602.3 2791.1 2937.5 24046.4 24148.8 24462.9 24591.0 24947.1 2033.7 2047.3 2062.3 2090.3 2127.6 238698.0 240055.0 241789.0 242417.0 243239.0 44978.0 46350.0 51390.5 52178.5 52669.7 58883.0 60198.1 60307.4 60420.2 61026.6 14978.2 15130.0 15320.9 15353.8 15363.5 11084.2 11109.7 11291.8 11292.7 11294.3 16523.4 16553.2 16577.3 16687.4 16829.7 7253.3 7290.0 7293.5 7344.7 7359.5 809.8 830.8 905.9 907.8 985.9 23937.9 26722.3 26963.3 26979.7 26994.3 908.1 911.5 924.5 966.3 1012.7 10533.3 11970.4 12186.2 12187.5 12452.7 221543.0 222131.0 222744.0 222994.0 223702.0 38911.8 39754.4 42634.0 43129.8 43992.8 1193.0 1225.1 1230.4 1238.5 1257.4 24151.0 24719.6 25213.1 25367.9 25421.0 37968.4 38374.4 42621.8 44115.0 44256.0 180717.1 182389.0 185271.0 187257.0 187442.0 25927.1 25961.1 26196.3 26532.5 26636.0 32567.5 32649.3 33734.3 34038.8 34315.8 29782.4 29816.6 29841.7 29845.7 30254.4 28838.0 29372.0 30059.7 30723.4 31210.8 30710.5 31549.7 31745.5 31905.9 31921.0 25338.4 27432.6 27433.5 27879.4 28343.1 20689.6 20763.7 20801.5 21129.4 22053.9 04:59:56 INFO - 2015-11-24 04:59:56,409 DEBUG : BROWSER_OUTPUT: 04:59:56 INFO - 2015-11-24 04:59:56,409 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24960.01 Median:22467.95 stddev:85595.79 (381.0%) stddev-sans-first:85815.88 04:59:56 INFO - 2015-11-24 04:59:56,411 DEBUG : BROWSER_OUTPUT: Values: 302.9 307.4 308.3 311.5 315.8 15008.4 15350.5 15523.0 16207.8 16232.8 10647.2 10743.8 10786.0 10798.7 15519.7 3791.1 3796.6 3908.2 3973.1 3982.8 3881.8 3889.1 3890.3 3915.6 3940.5 3089.5 3175.1 3182.4 3844.1 3905.1 4124.9 4179.0 4241.0 4241.8 4301.5 3614.9 3616.1 3621.0 3624.8 3662.8 10058.5 10371.5 10399.4 11261.4 11309.7 1570.5 1578.6 1586.6 1623.1 1674.2 8215.0 8239.9 8499.9 8552.9 8658.9 1346.6 1357.2 1380.6 1388.8 1401.7 48172.0 48901.3 49011.8 54183.0 54722.7 5917.9 5954.1 6014.6 6046.0 6058.1 6766.8 6825.0 6840.5 6841.5 6845.2 4926.2 4980.5 4983.0 4987.9 5014.3 5124.6 5228.2 5261.9 5308.3 5313.4 2629.8 2633.3 2633.8 2690.4 2696.5 922.9 943.0 949.3 954.5 1008.2 347.8 353.1 376.7 395.7 423.9 8759.3 10210.7 10279.2 10394.8 10428.0 383.6 411.8 415.0 419.6 431.1 5009.4 5245.7 5620.7 5654.7 5734.4 514643.0 518410.0 523287.0 523384.0 532181.0 66479.0 67534.7 68152.3 68176.7 68694.0 420.2 422.7 422.7 425.1 429.7 9724.7 9921.9 9947.4 9971.9 10174.4 31464.2 31496.1 31655.7 31929.2 31990.7 44504.8 45063.0 45167.3 46177.5 46289.0 5464.2 5728.9 5734.6 5782.3 5792.8 10376.5 10382.5 10550.7 10554.0 10645.1 8771.2 8922.0 8958.3 9157.7 9282.6 8685.5 8983.6 9001.9 9094.9 9214.5 9129.6 9248.5 9297.2 9500.5 9513.9 4629.2 5564.9 5653.8 5660.5 5661.1 8940.5 9090.5 9138.6 9159.2 9172.3 04:59:56 INFO - 2015-11-24 04:59:56,411 DEBUG : BROWSER_OUTPUT: 04:59:56 INFO - 2015-11-24 04:59:56,411 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4769.02 Median:5887.63 stddev:2474.47 (42.0%) stddev-sans-first:2466.31 04:59:56 INFO - 2015-11-24 04:59:56,411 DEBUG : BROWSER_OUTPUT: Values: 1132.8 1427.9 1528.1 1539.1 1580.8 6324.0 6377.9 6490.2 6586.7 6710.6 6547.9 6680.6 6720.3 6724.5 6821.3 1925.8 1952.0 1954.2 1957.8 1958.6 1943.3 1967.5 1970.2 1971.4 1981.9 1884.8 1894.7 1898.1 1898.9 1926.5 1908.0 1940.4 1941.0 1942.0 1942.4 1931.7 1937.3 1943.5 1944.0 1946.7 6163.0 6637.7 6659.0 6664.1 6767.2 3845.4 4075.1 4188.6 4203.2 4255.6 2550.0 2592.2 2597.8 2606.2 2643.5 749.2 760.9 771.8 773.5 775.7 9149.1 9159.8 9188.2 9195.0 9340.9 3676.1 3793.0 3826.7 3844.2 3852.3 8122.1 8127.9 8130.0 8208.4 8252.4 4285.8 4286.0 4292.3 4296.6 4348.6 3864.1 3911.2 3928.8 3929.0 3968.6 3083.4 3098.5 3125.7 3132.2 3139.3 986.5 1000.2 1008.0 1008.1 1008.4 1055.4 1058.7 1087.0 1091.5 1100.9 6053.8 6123.7 6142.0 6164.5 6213.4 399.4 1052.3 1082.4 1096.6 1105.7 4814.2 4818.4 4826.0 4880.2 5020.3 7584.3 7983.7 8127.0 8228.6 8256.8 8008.6 8097.4 8103.6 8146.0 8232.5 6396.2 6518.8 6536.2 6628.5 6647.5 6523.3 6532.7 6568.8 6622.7 6637.2 7103.0 7391.9 7486.1 7497.3 7509.3 7358.5 7622.7 7699.2 7738.1 7741.3 5853.2 5873.6 5901.7 5956.4 6010.0 6655.2 6701.9 6724.5 6804.5 6811.1 6151.8 6303.3 6311.7 6372.5 6472.2 6078.5 6079.8 6091.9 6211.7 6266.5 6276.8 6278.8 6293.7 6348.2 6351.5 5405.9 5412.1 5441.8 5455.0 5527.3 5437.2 5508.7 5595.2 5603.2 5640.7 04:59:56 INFO - 2015-11-24 04:59:56,412 DEBUG : BROWSER_OUTPUT: 04:59:56 INFO - 2015-11-24 04:59:56,412 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4676.29 Median:5342.41 stddev:1412.73 (26.4%) stddev-sans-first:1377.50 04:59:56 INFO - 2015-11-24 04:59:56,413 DEBUG : BROWSER_OUTPUT: Values: 273.7 274.4 279.9 287.3 299.3 5178.6 5205.7 5248.2 5306.8 5390.8 5186.3 5237.9 5286.3 5310.2 5327.6 4079.1 4079.2 4091.0 4099.8 4155.4 3926.8 3957.8 3966.0 4065.2 4101.4 4004.7 4044.1 4045.2 4060.4 4063.7 3987.1 4014.8 4021.2 4075.0 4095.7 3496.2 3499.8 3510.2 3542.7 3552.1 4977.4 5104.2 5109.0 5163.9 5179.7 4663.9 4663.9 4680.6 4690.6 4712.4 5571.9 5572.7 5624.4 5645.9 5654.5 3584.9 3668.3 3799.0 3879.7 3936.5 5676.2 5709.9 5746.7 5798.9 5842.4 3910.3 3931.9 3933.9 3955.9 3979.1 3976.9 4015.4 4021.8 4030.7 4032.6 4513.8 4569.3 4643.4 4698.6 4733.0 5467.6 5550.4 5555.3 5556.3 5613.6 1409.7 1409.9 1409.9 1414.1 1426.5 933.6 958.8 963.6 965.4 980.9 5235.9 5257.0 5259.3 5324.1 5343.9 5780.4 5796.0 5808.6 5875.6 5950.9 5319.9 5331.6 5340.9 5373.7 5405.1 3147.2 3190.5 3209.1 3216.0 3273.3 5837.4 5851.0 5869.4 5949.6 5962.1 5895.4 5919.2 5956.4 5977.6 6005.7 5776.4 5852.1 5875.9 5945.9 5958.6 5815.8 5832.2 5843.7 5915.5 5918.3 5557.4 5566.9 5738.9 5756.6 5782.9 5844.2 5856.4 5872.7 5895.7 5947.9 3682.0 3717.9 3727.7 3779.9 3787.5 5760.9 5775.4 5783.2 5812.1 5841.4 5577.6 5606.8 5618.7 5621.8 5707.3 5611.8 5616.0 5667.1 5672.7 5704.0 5493.4 5498.2 5538.3 5571.3 5591.8 5457.8 5592.6 5622.3 5686.5 5699.7 5513.9 5514.0 5575.1 5609.7 5631.6 04:59:56 INFO - 2015-11-24 04:59:56,413 DEBUG : BROWSER_OUTPUT: 04:59:56 INFO - 2015-11-24 04:59:56,413 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11457.91 Median:2911.30 stddev:14330.31 (492.2%) stddev-sans-first:14347.14 04:59:56 INFO - 2015-11-24 04:59:56,415 DEBUG : BROWSER_OUTPUT: Values: 558.5 576.3 610.9 661.9 676.8 10689.3 10922.3 11058.8 11256.0 11288.7 10272.3 10341.8 10411.6 10425.7 10433.7 739.6 751.5 757.0 760.8 768.0 746.9 764.9 765.9 765.9 767.6 791.0 791.7 791.9 792.7 793.6 768.3 775.1 784.0 786.4 788.5 577.8 585.9 586.6 587.0 587.5 11871.3 12088.0 12147.2 12176.1 12179.5 7928.9 8241.1 8287.4 8521.8 8698.3 7479.4 7491.3 7575.4 7700.5 7919.7 2473.2 2505.6 2544.2 2564.0 2579.0 35267.6 35496.6 39069.2 41937.2 42512.8 5156.5 5271.6 5316.7 5594.5 5679.2 10995.2 11019.9 11032.1 11193.4 11205.0 5048.2 5073.5 5156.9 5250.4 5293.7 3227.5 3248.1 3251.2 3269.8 3320.9 2343.5 2345.6 2353.2 2376.8 2378.0 349.8 350.4 354.6 357.1 358.4 388.4 397.7 419.4 450.1 461.5 6295.2 6397.1 6577.0 6648.2 6698.2 366.7 384.7 390.0 485.8 528.9 3161.6 3167.9 3262.6 3317.2 3364.4 50395.5 55482.2 55788.2 56635.7 56725.4 43784.6 44082.3 44136.8 44159.1 44173.8 37399.3 37404.0 40647.2 41828.4 43349.0 6655.6 7152.8 7441.6 7499.4 7570.9 32653.7 32676.5 33202.3 33692.0 34221.1 35672.6 35675.8 40590.4 40773.4 41499.2 6446.7 6470.5 6556.9 6706.9 6723.4 9925.0 10077.5 10159.4 10492.8 10611.4 8388.7 8814.6 9236.5 9238.0 9371.8 9119.5 9296.1 9367.5 9381.5 9711.5 8817.2 9019.0 9135.0 9185.9 9411.2 7916.9 7956.2 8103.6 8167.4 8310.0 7960.3 7994.3 7997.3 8098.8 8135.0 04:59:56 INFO - 2015-11-24 04:59:56,415 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:59:56 INFO - 2015-11-24 04:59:56,415 DEBUG : BROWSER_OUTPUT: 04:59:57 INFO - 2015-11-24 04:59:57,094 INFO : Browser exited with error code: 0 04:59:57 INFO - 2015-11-24 04:59:57,126 INFO : Completed test dromaeo_css (00:18:34) 04:59:57 INFO - 2015-11-24 04:59:57,126 INFO : Starting test kraken 04:59:57 INFO - 2015-11-24 04:59:57,127 DEBUG : operating with platform_type : mac_ 04:59:57 INFO - 2015-11-24 04:59:57,127 INFO : Initialising browser for kraken test... 04:59:57 INFO - 2015-11-24 04:59:57,142 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpxzPij4/profile http://localhost:50015/getInfo.html 04:59:59 INFO - 2015-11-24 04:59:59,613 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:59:59 INFO - 2015-11-24 04:59:59,613 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:59:59 INFO - 2015-11-24 04:59:59,613 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:59:59 INFO - 2015-11-24 04:59:59,613 DEBUG : BROWSER_OUTPUT: __metrics 04:59:59 INFO - 2015-11-24 04:59:59,632 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:00:00 INFO - 2015-11-24 05:00:00,383 INFO : Browser initialized. 05:00:00 INFO - 2015-11-24 05:00:00,384 INFO : Running cycle 1/1 for kraken test... 05:00:00 INFO - 2015-11-24 05:00:00,384 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpxzPij4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:00:12 INFO - 2015-11-24 05:00:12,392 DEBUG : BROWSER_OUTPUT: RSS: Main: 200790016 05:00:12 INFO - 2015-11-24 05:00:12,392 DEBUG : BROWSER_OUTPUT: 05:00:15 INFO - 2015-11-24 05:00:15,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50015/tests/kraken/driver.html?testName=audio-beat-detection) 05:00:15 INFO - 2015-11-24 05:00:15,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 265003008 05:00:15 INFO - 2015-11-24 05:00:15,849 DEBUG : BROWSER_OUTPUT: 05:00:18 INFO - 2015-11-24 05:00:18,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50015/tests/kraken/driver.html?testName=audio-dft) 05:00:19 INFO - 2015-11-24 05:00:19,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 279867392 05:00:19 INFO - 2015-11-24 05:00:19,418 DEBUG : BROWSER_OUTPUT: 05:00:22 INFO - 2015-11-24 05:00:22,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50015/tests/kraken/driver.html?testName=audio-fft) 05:00:23 INFO - 2015-11-24 05:00:23,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 266514432 05:00:23 INFO - 2015-11-24 05:00:23,191 DEBUG : BROWSER_OUTPUT: 05:00:25 INFO - 2015-11-24 05:00:25,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50015/tests/kraken/driver.html?testName=audio-oscillator) 05:00:26 INFO - 2015-11-24 05:00:26,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 267923456 05:00:26 INFO - 2015-11-24 05:00:26,055 DEBUG : BROWSER_OUTPUT: 05:00:28 INFO - 2015-11-24 05:00:28,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50015/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:00:29 INFO - 2015-11-24 05:00:29,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 266375168 05:00:29 INFO - 2015-11-24 05:00:29,101 DEBUG : BROWSER_OUTPUT: 05:00:32 INFO - 2015-11-24 05:00:32,581 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50015/tests/kraken/driver.html?testName=imaging-darkroom) 05:00:33 INFO - 2015-11-24 05:00:33,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 265162752 05:00:33 INFO - 2015-11-24 05:00:33,173 DEBUG : BROWSER_OUTPUT: 05:00:36 INFO - 2015-11-24 05:00:36,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50015/tests/kraken/driver.html?testName=imaging-desaturate) 05:00:37 INFO - 2015-11-24 05:00:37,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 266047488 05:00:37 INFO - 2015-11-24 05:00:37,334 DEBUG : BROWSER_OUTPUT: 05:00:40 INFO - 2015-11-24 05:00:40,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50015/tests/kraken/driver.html?testName=json-parse-financial) 05:00:41 INFO - 2015-11-24 05:00:41,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 267104256 05:00:41 INFO - 2015-11-24 05:00:41,237 DEBUG : BROWSER_OUTPUT: 05:00:42 INFO - 2015-11-24 05:00:42,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50015/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:00:43 INFO - 2015-11-24 05:00:43,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 298672128 05:00:43 INFO - 2015-11-24 05:00:43,547 DEBUG : BROWSER_OUTPUT: 05:00:45 INFO - 2015-11-24 05:00:45,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50015/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:00:46 INFO - 2015-11-24 05:00:46,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 301518848 05:00:46 INFO - 2015-11-24 05:00:46,194 DEBUG : BROWSER_OUTPUT: 05:00:48 INFO - 2015-11-24 05:00:48,492 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50015/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:00:49 INFO - 2015-11-24 05:00:49,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 306671616 05:00:49 INFO - 2015-11-24 05:00:49,087 DEBUG : BROWSER_OUTPUT: 05:00:51 INFO - 2015-11-24 05:00:51,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:00:52 INFO - 2015-11-24 05:00:52,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 310005760 05:00:52 INFO - 2015-11-24 05:00:52,596 DEBUG : BROWSER_OUTPUT: 05:00:55 INFO - 2015-11-24 05:00:55,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:00:56 INFO - 2015-11-24 05:00:56,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 308088832 05:00:56 INFO - 2015-11-24 05:00:56,041 DEBUG : BROWSER_OUTPUT: 05:00:57 INFO - 2015-11-24 05:00:57,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50015/tests/kraken/driver.html?testName=ai-astar) 05:00:58 INFO - 2015-11-24 05:00:58,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 368451584 05:00:58 INFO - 2015-11-24 05:00:58,208 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,208 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:00:58 INFO - 2015-11-24 05:00:58,209 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:00:58 INFO - 2015-11-24 05:00:58,209 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:00:58 INFO - 2015-11-24 05:00:58,209 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:00:58 INFO - 2015-11-24 05:00:58,209 DEBUG : BROWSER_OUTPUT: |0;ai-astar;123;129;123;129;131;135;119;127;126;128 05:00:58 INFO - 2015-11-24 05:00:58,209 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;175;154;194;181;152;171;147;191;181;153 05:00:58 INFO - 2015-11-24 05:00:58,209 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;188;190;195;195;188;189;189;189;188 05:00:58 INFO - 2015-11-24 05:00:58,209 DEBUG : BROWSER_OUTPUT: |3;audio-fft;84;95;91;142;80;86;86;86;144;78 05:00:58 INFO - 2015-11-24 05:00:58,210 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;112;114;164;108;112;105;150;103;103;153 05:00:58 INFO - 2015-11-24 05:00:58,210 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;139;143;141;136;141;134;148;145;135;141 05:00:58 INFO - 2015-11-24 05:00:58,210 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;153;151;147;146;153;153;147;146 05:00:58 INFO - 2015-11-24 05:00:58,210 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;119;124;125;124;122;119;124;126;136;129 05:00:58 INFO - 2015-11-24 05:00:58,210 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;71;71;73;72;73;73;84;70;72 05:00:58 INFO - 2015-11-24 05:00:58,211 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;73;78;77;81;78;79;85;82;83;79 05:00:58 INFO - 2015-11-24 05:00:58,211 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;95;98;103;100;100;99;97;97;102 05:00:58 INFO - 2015-11-24 05:00:58,211 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;155;146;144;144;153;145;155;156;146;149 05:00:58 INFO - 2015-11-24 05:00:58,211 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;155;170;172;181;181;174;171;169;159;159 05:00:58 INFO - 2015-11-24 05:00:58,213 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;76;77;81;80;83;84;85;85;83;80 05:00:58 INFO - 2015-11-24 05:00:58,213 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:00:58 INFO - 2015-11-24 05:00:58,213 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:00:58 INFO - 2015-11-24 05:00:58,213 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,949 05:00:58 INFO - 2015-11-24 05:00:58,213 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:00:58 INFO - 2015-11-24 05:00:58,214 DEBUG : BROWSER_OUTPUT: __startTimestamp1448370058207__endTimestamp 05:00:58 INFO - 2015-11-24 05:00:58,214 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,214 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:00:58 INFO - 2015-11-24 05:00:58,214 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:00:58 INFO - 2015-11-24 05:00:58,214 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,214 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:127.00 Median:128.50 stddev:4.55 (3.5%) stddev-sans-first:4.59 05:00:58 INFO - 2015-11-24 05:00:58,214 DEBUG : BROWSER_OUTPUT: Values: 123.0 129.0 123.0 129.0 131.0 135.0 119.0 127.0 126.0 128.0 05:00:58 INFO - 2015-11-24 05:00:58,215 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,215 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:169.90 Median:178.00 stddev:17.27 (9.7%) stddev-sans-first:18.21 05:00:58 INFO - 2015-11-24 05:00:58,215 DEBUG : BROWSER_OUTPUT: Values: 175.0 154.0 194.0 181.0 152.0 171.0 147.0 191.0 181.0 153.0 05:00:58 INFO - 2015-11-24 05:00:58,215 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,215 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:189.40 Median:189.00 stddev:3.50 (1.9%) stddev-sans-first:2.85 05:00:58 INFO - 2015-11-24 05:00:58,217 DEBUG : BROWSER_OUTPUT: Values: 183.0 188.0 190.0 195.0 195.0 188.0 189.0 189.0 189.0 188.0 05:00:58 INFO - 2015-11-24 05:00:58,217 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,217 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:97.20 Median:86.00 stddev:24.62 (28.6%) stddev-sans-first:25.65 05:00:58 INFO - 2015-11-24 05:00:58,218 DEBUG : BROWSER_OUTPUT: Values: 84.0 95.0 91.0 142.0 80.0 86.0 86.0 86.0 144.0 78.0 05:00:58 INFO - 2015-11-24 05:00:58,218 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,218 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:122.40 Median:113.00 stddev:23.52 (20.8%) stddev-sans-first:24.64 05:00:58 INFO - 2015-11-24 05:00:58,218 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 164.0 108.0 112.0 105.0 150.0 103.0 103.0 153.0 05:00:58 INFO - 2015-11-24 05:00:58,219 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,219 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:140.30 Median:141.00 stddev:4.45 (3.2%) stddev-sans-first:4.69 05:00:58 INFO - 2015-11-24 05:00:58,219 DEBUG : BROWSER_OUTPUT: Values: 139.0 143.0 141.0 136.0 141.0 134.0 148.0 145.0 135.0 141.0 05:00:58 INFO - 2015-11-24 05:00:58,219 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,219 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:3.09 (2.1%) stddev-sans-first:3.19 05:00:58 INFO - 2015-11-24 05:00:58,219 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 153.0 151.0 147.0 146.0 153.0 153.0 147.0 146.0 05:00:58 INFO - 2015-11-24 05:00:58,219 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,219 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:124.80 Median:124.50 stddev:4.96 (4.0%) stddev-sans-first:4.80 05:00:58 INFO - 2015-11-24 05:00:58,220 DEBUG : BROWSER_OUTPUT: Values: 119.0 124.0 125.0 124.0 122.0 119.0 124.0 126.0 136.0 129.0 05:00:58 INFO - 2015-11-24 05:00:58,220 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,220 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.00 Median:72.50 stddev:5.52 (7.6%) stddev-sans-first:4.18 05:00:58 INFO - 2015-11-24 05:00:58,220 DEBUG : BROWSER_OUTPUT: Values: 61.0 71.0 71.0 73.0 72.0 73.0 73.0 84.0 70.0 72.0 05:00:58 INFO - 2015-11-24 05:00:58,220 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,220 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:79.50 Median:80.00 stddev:3.41 (4.3%) stddev-sans-first:2.68 05:00:58 INFO - 2015-11-24 05:00:58,221 DEBUG : BROWSER_OUTPUT: Values: 73.0 78.0 77.0 81.0 78.0 79.0 85.0 82.0 83.0 79.0 05:00:58 INFO - 2015-11-24 05:00:58,221 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,221 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:98.20 Median:96.00 stddev:3.49 (3.6%) stddev-sans-first:2.55 05:00:58 INFO - 2015-11-24 05:00:58,221 DEBUG : BROWSER_OUTPUT: Values: 91.0 95.0 98.0 103.0 100.0 100.0 99.0 97.0 97.0 102.0 05:00:58 INFO - 2015-11-24 05:00:58,221 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,221 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:149.30 Median:151.00 stddev:4.95 (3.3%) stddev-sans-first:4.80 05:00:58 INFO - 2015-11-24 05:00:58,221 DEBUG : BROWSER_OUTPUT: Values: 155.0 146.0 144.0 144.0 153.0 145.0 155.0 156.0 146.0 149.0 05:00:58 INFO - 2015-11-24 05:00:58,221 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,222 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:171.50 stddev:8.96 (5.2%) stddev-sans-first:7.92 05:00:58 INFO - 2015-11-24 05:00:58,222 DEBUG : BROWSER_OUTPUT: Values: 155.0 170.0 172.0 181.0 181.0 174.0 171.0 169.0 159.0 159.0 05:00:58 INFO - 2015-11-24 05:00:58,222 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,222 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.40 Median:83.00 stddev:3.17 (3.8%) stddev-sans-first:2.69 05:00:58 INFO - 2015-11-24 05:00:58,222 DEBUG : BROWSER_OUTPUT: Values: 76.0 77.0 81.0 80.0 83.0 84.0 85.0 85.0 83.0 80.0 05:00:58 INFO - 2015-11-24 05:00:58,222 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:00:58 INFO - 2015-11-24 05:00:58,224 DEBUG : BROWSER_OUTPUT: 05:00:58 INFO - 2015-11-24 05:00:58,946 INFO : Browser exited with error code: 0 05:00:59 INFO - 2015-11-24 05:00:59,003 INFO : Completed test kraken (00:01:01) 05:00:59 INFO - 2015-11-24 05:00:59,003 INFO : Starting test v8_7 05:00:59 INFO - 2015-11-24 05:00:59,004 DEBUG : operating with platform_type : mac_ 05:00:59 INFO - 2015-11-24 05:00:59,004 INFO : Initialising browser for v8_7 test... 05:00:59 INFO - 2015-11-24 05:00:59,019 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpt2blOY/profile http://localhost:50015/getInfo.html 05:01:01 INFO - 2015-11-24 05:01:01,534 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:01:01 INFO - 2015-11-24 05:01:01,534 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:01:01 INFO - 2015-11-24 05:01:01,534 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:01:01 INFO - 2015-11-24 05:01:01,534 DEBUG : BROWSER_OUTPUT: __metrics 05:01:01 INFO - 2015-11-24 05:01:01,550 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:01:02 INFO - 2015-11-24 05:01:02,269 INFO : Browser initialized. 05:01:02 INFO - 2015-11-24 05:01:02,269 INFO : Running cycle 1/1 for v8_7 test... 05:01:02 INFO - 2015-11-24 05:01:02,269 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpt2blOY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:01:14 INFO - 2015-11-24 05:01:14,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 200355840 05:01:14 INFO - 2015-11-24 05:01:14,280 DEBUG : BROWSER_OUTPUT: 05:01:36 INFO - 2015-11-24 05:01:36,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50015/tests/v8_7/run.html (next: http://localhost:50015/tests/v8_7/run.html) 05:01:37 INFO - 2015-11-24 05:01:37,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 518606848 05:01:37 INFO - 2015-11-24 05:01:37,184 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-24 05:01:37,184 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:01:37 INFO - 2015-11-24 05:01:37,184 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:01:37 INFO - 2015-11-24 05:01:37,184 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:01:37 INFO - 2015-11-24 05:01:37,185 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:01:37 INFO - 2015-11-24 05:01:37,185 DEBUG : BROWSER_OUTPUT: |0;Richards;194.51468585878234 05:01:37 INFO - 2015-11-24 05:01:37,185 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;221.14108801415304 05:01:37 INFO - 2015-11-24 05:01:37,185 DEBUG : BROWSER_OUTPUT: |2;Encrypt;370.78235076010384 05:01:37 INFO - 2015-11-24 05:01:37,185 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6532.467532467533 05:01:37 INFO - 2015-11-24 05:01:37,185 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1226.993865030675 05:01:37 INFO - 2015-11-24 05:01:37,185 DEBUG : BROWSER_OUTPUT: |5;Earley;823.0452674897119 05:01:37 INFO - 2015-11-24 05:01:37,185 DEBUG : BROWSER_OUTPUT: |6;Boyer;14735.29411764706 05:01:37 INFO - 2015-11-24 05:01:37,185 DEBUG : BROWSER_OUTPUT: |7;RegExp;36280.70175438596 05:01:37 INFO - 2015-11-24 05:01:37,186 DEBUG : BROWSER_OUTPUT: |8;Splay;668.4491978609626 05:01:37 INFO - 2015-11-24 05:01:37,186 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6738.255033557047 05:01:37 INFO - 2015-11-24 05:01:37,186 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:01:37 INFO - 2015-11-24 05:01:37,186 DEBUG : BROWSER_OUTPUT: __startTimestamp1448370097181__endTimestamp 05:01:37 INFO - 2015-11-24 05:01:37,186 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-24 05:01:37,186 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:01:37 INFO - 2015-11-24 05:01:37,186 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:01:37 INFO - 2015-11-24 05:01:37,187 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-24 05:01:37,187 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:194.51 Median:194.51 stddev:0.00 (0.0%) 05:01:37 INFO - 2015-11-24 05:01:37,187 DEBUG : BROWSER_OUTPUT: Values: 194.5 05:01:37 INFO - 2015-11-24 05:01:37,187 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-24 05:01:37,187 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:221.14 Median:221.14 stddev:0.00 (0.0%) 05:01:37 INFO - 2015-11-24 05:01:37,187 DEBUG : BROWSER_OUTPUT: Values: 221.1 05:01:37 INFO - 2015-11-24 05:01:37,187 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-24 05:01:37,187 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:370.78 Median:370.78 stddev:0.00 (0.0%) 05:01:37 INFO - 2015-11-24 05:01:37,187 DEBUG : BROWSER_OUTPUT: Values: 370.8 05:01:37 INFO - 2015-11-24 05:01:37,188 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-24 05:01:37,188 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6532.47 Median:6532.47 stddev:0.00 (0.0%) 05:01:37 INFO - 2015-11-24 05:01:37,188 DEBUG : BROWSER_OUTPUT: Values: 6532.5 05:01:37 INFO - 2015-11-24 05:01:37,188 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-24 05:01:37,188 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1226.99 Median:1226.99 stddev:0.00 (0.0%) 05:01:37 INFO - 2015-11-24 05:01:37,188 DEBUG : BROWSER_OUTPUT: Values: 1227.0 05:01:37 INFO - 2015-11-24 05:01:37,188 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-24 05:01:37,188 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:823.05 Median:823.05 stddev:0.00 (0.0%) 05:01:37 INFO - 2015-11-24 05:01:37,189 DEBUG : BROWSER_OUTPUT: Values: 823.0 05:01:37 INFO - 2015-11-24 05:01:37,189 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-24 05:01:37,189 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14735.29 Median:14735.29 stddev:0.00 (0.0%) 05:01:37 INFO - 2015-11-24 05:01:37,189 DEBUG : BROWSER_OUTPUT: Values: 14735.3 05:01:37 INFO - 2015-11-24 05:01:37,189 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-24 05:01:37,189 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:36280.70 Median:36280.70 stddev:0.00 (0.0%) 05:01:37 INFO - 2015-11-24 05:01:37,189 DEBUG : BROWSER_OUTPUT: Values: 36280.7 05:01:37 INFO - 2015-11-24 05:01:37,189 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-24 05:01:37,190 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:668.45 Median:668.45 stddev:0.00 (0.0%) 05:01:37 INFO - 2015-11-24 05:01:37,190 DEBUG : BROWSER_OUTPUT: Values: 668.4 05:01:37 INFO - 2015-11-24 05:01:37,190 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-24 05:01:37,190 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6738.26 Median:6738.26 stddev:0.00 (0.0%) 05:01:37 INFO - 2015-11-24 05:01:37,190 DEBUG : BROWSER_OUTPUT: Values: 6738.3 05:01:37 INFO - 2015-11-24 05:01:37,190 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:01:37 INFO - 2015-11-24 05:01:37,190 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-24 05:01:37,912 INFO : Browser exited with error code: 0 05:01:37 INFO - 2015-11-24 05:01:37,935 INFO : Completed test v8_7 (00:00:38) 05:01:38 INFO - 2015-11-24 05:01:38,120 INFO : Completed test suite (00:20:15) 05:01:38 INFO - 2015-11-24 05:01:38,120 DEBUG : Working with test: dromaeo_css 05:01:38 INFO - 2015-11-24 05:01:38,120 DEBUG : Generating results file: dromaeo_css 05:01:38 INFO - 2015-11-24 05:01:38,121 DEBUG : Working with test: kraken 05:01:38 INFO - 2015-11-24 05:01:38,121 DEBUG : Generating results file: kraken 05:01:38 INFO - 2015-11-24 05:01:38,121 INFO : javascript benchmark 05:01:38 INFO - 2015-11-24 05:01:38,122 DEBUG : Working with test: v8_7 05:01:38 INFO - 2015-11-24 05:01:38,122 DEBUG : Generating results file: v8_7 05:01:38 INFO - 2015-11-24 05:01:38,122 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:01:38 INFO - 2015-11-24 05:01:38,254 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 05:01:38 INFO - 2015-11-24 05:01:38,255 DEBUG : process_Request line: dromaeo_css 5740.60 graph.html#tests=[[72,52,55]] 05:01:38 INFO - 2015-11-24 05:01:38,255 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:01:38 INFO - 2015-11-24 05:01:38,288 DEBUG : process_Request line: kraken 1769.50 graph.html#tests=[[232,52,55]] 05:01:38 INFO - 2015-11-24 05:01:38,288 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:01:38 INFO - 2015-11-24 05:01:38,397 DEBUG : process_Request line: v8_7 17365.34 graph.html#tests=[[230,52,55]] 05:01:38 INFO - 2015-11-24 05:01:38,398 INFO : javascript benchmark 05:01:38 INFO - 2015-11-24 05:01:38,400 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [302.8552073163443, 307.4189781313318, 308.3293835906902, 311.5015974440895, 315.79315548315844, 15008.39966401344, 15350.462733804305, 15523.0, 16207.756883646754, 16232.75650865238, 10647.2014598905, 10743.83884241737, 10786.0, 10798.6760397188, 15519.689606207869, 3791.052236940765, 3796.5823759386444, 3908.1988192420627, 3973.1259122992897, 3982.8207730652043, 3881.844726210948, 3889.105505733683, 3890.3386424307937, 3915.569287378386, 3940.5074365704286, 3089.474789285827, 3175.0950978971, 3182.427163110639, 3844.077421418853, 3905.082305658168, 4124.876253712393, 4179.038821071171, 4240.957590424103, 4241.766702831358, 4301.483821941356, 3614.9277014459826, 3616.132128289218, 3621.0, 3624.782513049199, 3662.816859157058, 10058.547365368502, 10371.533281002374, 10399.428031458267, 11261.43692815356, 11309.660710178709, 1570.4974408189385, 1578.5895667126515, 1586.5874872533109, 1623.115402105855, 1674.1712852138269, 8215.0, 8239.917600824036, 8499.915000849975, 8552.871706924401, 8658.87011694825, 1346.6229455752307, 1357.2399456304502, 1380.565121986581, 1388.7639101352693, 1401.7476854166246, 48172.0, 48901.266481002815, 49011.75494122578, 54183.0, 54722.726386367816, 5917.940820591825, 5954.077118046623, 6014.578979471395, 6046.032634778414, 6058.0610005449225, 6766.83082922921, 6824.976253562006, 6840.452763778886, 6841.452683785285, 6845.212800527904, 4926.162552366035, 4980.477049909779, 4982.950170498321, 4987.850364489072, 5014.323066385991, 5124.590032797368, 5228.241904923765, 5261.894762104813, 5308.283381743415, 5313.415524292324, 2629.7501737334924, 2633.3285012322117, 2633.8024648151463, 2690.448458066092, 2696.474187533451, 922.8523436250168, 943.0381011368365, 949.3449519831432, 954.4941181173989, 1008.2035192198229, 347.7791602332537, 353.1348196917562, 376.7268730170604, 395.6676391830876, 423.9152169566099, 8759.255463285692, 10210.744731381626, 10279.229057820694, 10394.844077338847, 10428.0, 383.6374625978424, 411.78381349791, 414.9647279981235, 419.57203652274507, 431.11836294777254, 5009.373828271466, 5245.7114858683135, 5620.690862002547, 5654.6889921054735, 5734.369219385864, 514643.0, 518410.0, 523287.0, 523384.0, 532181.0, 66479.0, 67534.66232668805, 68152.3184768146, 68176.6591167041, 68693.96959045618, 420.2393667461904, 422.67031715262146, 422.68932334733944, 425.10091157202294, 429.7314178638351, 9724.659636912675, 9921.900780992097, 9947.403155810674, 9971.900280997388, 10174.389536627827, 31464.213394664403, 31496.055118346485, 31655.683443165275, 31929.201769955936, 31990.68009319877, 44504.777476113704, 45062.972166251944, 45167.32249016333, 46177.53822461867, 46289.0, 5464.153056276284, 5728.856778580569, 5734.59857809966, 5782.306123265067, 5792.797252096157, 10376.481175941324, 10382.480875956324, 10550.683479495627, 10554.0, 10645.0951669109, 8771.210591046836, 8921.955390223007, 8958.283337333129, 9157.679481218393, 9282.62869485213, 8685.522296273766, 8983.592839424857, 9001.909980900107, 9094.863577046483, 9214.539273036187, 9129.634814607607, 9248.537573121452, 9297.163255307054, 9500.524973751422, 9513.904860951301, 4629.166749985035, 5564.888702226014, 5653.802116925888, 5660.547156227574, 5661.094224923992, 8940.46357218569, 9090.500022498825, 9138.63445462174, 9159.175674189355, 9172.266218702354], "dojo.html": [2648.1790644900075, 2655.721149279326, 2707.011940641664, 2718.524258254806, 2727.2363738153313, 4493.281075027988, 4495.6628252881, 4537.886552836181, 4588.311753237016, 4597.931031034533, 4514.48083470401, 4531.139083574119, 4551.8634440966825, 4590.449146102464, 4617.261238201889, 4145.606167414091, 4151.377293405983, 4193.93709094363, 4250.149970005996, 4252.2983707688345, 4302.376155457457, 4304.483461984566, 4363.0, 4379.9926017016105, 4415.779211039435, 4439.378487011821, 4488.596026357627, 4488.8877778055485, 4503.211937910869, 4544.750038747868, 4193.287141186006, 4461.553844615545, 4478.193925093482, 4487.416635837353, 4538.6369090472845, 4069.7151199416053, 4260.957390426087, 4266.978665106686, 4276.786160691984, 4393.714408563465, 4653.88365290867, 4735.408073990751, 4775.594074503671, 4781.617470602343, 4827.758612069418, 5073.340465739467, 5076.54311111998, 5127.384713834326, 5135.204043373283, 5156.0, 4915.778789954461, 4989.476105008995, 5117.208976858107, 5133.153029750087, 5206.271122042917, 4707.199776038116, 4709.293605959134, 4713.269443236304, 4743.501932297128, 4748.833790817339, 5125.948740512622, 5131.512506311894, 5137.17805151174, 5144.768485418165, 5160.277561141444, 4803.567678908915, 4807.399075115611, 4936.308916751657, 4946.431160416526, 4951.158303088484, 5158.174692049254, 5158.458361872024, 5162.251473536317, 5173.3533308336455, 5175.120229560984, 5080.339555857715, 5084.8220312288895, 5098.923516147261, 5117.155669314596, 5119.308893299357, 4764.071006153767, 4885.951140488621, 4898.755062246873, 4959.851204463872, 5143.12566863634, 3799.506064211635, 3862.5558060822805, 3887.319719049155, 3918.529776426847, 3927.410888366711, 3420.452727563578, 3426.1777173478185, 3473.635268296843, 3512.455569386749, 3608.314420260142, 4583.977080114578, 4607.976960115178, 4626.051659409813, 4628.60656844172, 4630.305454181832, 4802.951970480321, 4881.8535443936735, 4893.437254715682, 4983.377077865267, 5087.211482220262, 4672.065586882637, 4672.57946784791, 4758.690685105457, 4771.045790841846, 4776.355192049098, 4401.603855653007, 4429.202743506135, 4442.5557444255965, 4442.8222871085445, 4462.352958820953, 4962.354893863775, 5119.385673719103, 5119.564836988898, 5134.947335796228, 5205.037068142406, 5032.446430892525, 5044.2685810558, 5065.037642847848, 5068.771905264346, 5105.846824595268, 5107.489251074863, 5246.2392953020835, 5251.186066159751, 5259.132243179833, 5262.763175657028, 4881.536254055859, 5099.745012749422, 5108.514691104339, 5114.0, 5123.257127716534, 5014.84955451337, 5109.437961824122, 5152.458991805956, 5168.870778230575, 5194.870128246824, 5025.773840177128, 5078.4921507850395, 5078.873028174326, 5101.8724531887, 5119.180931051014, 4835.081334546425, 5014.899702005867, 5068.59451243907, 5069.822556210515, 5083.92374114396, 4664.0905023521445, 4818.975905120452, 4908.92636610444, 4918.114739346952, 4926.039422312615, 4981.900361992813, 5002.824901128443, 5041.1430056889685, 5044.2685810558, 5058.924116138334, 4940.802367905388, 4956.504349565014, 4973.104841128632, 4984.102861484823, 5035.16919708244], "mootools.html": [1132.773445310938, 1427.9286035698215, 1528.0984219310606, 1539.1303913288991, 1580.84981926717, 6323.968380158099, 6377.9043314350265, 6490.156279683641, 6586.736530538773, 6710.597364158154, 6547.90178147327, 6680.632565208912, 6720.327967203277, 6724.495662825296, 6821.283765204656, 1925.8074192580734, 1952.023988005997, 1954.2280799084353, 1957.7552805899263, 1958.5789055353096, 1943.319838056683, 1967.5081229692578, 1970.2217624038497, 1971.3691618682028, 1981.9108140133728, 1884.7832499262554, 1894.6589613869498, 1898.0509745127436, 1898.8955607441585, 1926.5376309685714, 1907.9523011924673, 1940.3693799515213, 1940.9708854367195, 1941.9514512137168, 1942.3784388995527, 1931.748872646547, 1937.3219373219401, 1943.4558323669396, 1944.0182707732647, 1946.7079938009413, 6163.0, 6637.668116594151, 6659.034440006172, 6664.133662623828, 6767.221769496522, 3845.384738441836, 4075.1034772350035, 4188.5811418858175, 4203.243416185085, 4255.553166917491, 2549.961750573743, 2592.235290589281, 2597.7921766258655, 2606.192080455046, 2643.537380958325, 749.24700675821, 760.9086909570832, 771.8109063279533, 773.4701729315437, 775.6858472318663, 9149.130832570896, 9159.77100572491, 9188.219001384958, 9195.0, 9340.859887101698, 3676.0809797550614, 3793.0327766419387, 3826.732128750961, 3844.154286057063, 3852.325842977468, 8122.106568277485, 8127.878081828777, 8130.0, 8208.384371172186, 8252.422330436812, 4285.785710714452, 4285.978570107191, 4292.334688123284, 4296.613304802583, 4348.586884245991, 3864.072622570563, 3911.1982043681546, 3928.7839168845417, 3929.0373858404873, 3968.6031396860662, 3083.383323335342, 3098.4732595458827, 3125.749940004794, 3132.2326030122767, 3139.3250451152653, 986.4722373530127, 1000.1548691355792, 1008.0322890025511, 1008.0776089877826, 1008.3848852200152, 1055.3984228989402, 1058.714147180257, 1087.0216804875674, 1091.5142761471227, 1100.862392200975, 6053.8486537836025, 6123.693815309217, 6142.017277235621, 6164.506839452833, 6213.409726076015, 399.41884557968086, 1052.2581579986092, 1082.3830416662427, 1096.6381094238882, 1105.723569107723, 4814.181589129857, 4818.445878723922, 4826.0, 4880.170371036932, 5020.297158397754, 7584.2794934481135, 7983.68065277394, 8126.959365203136, 8228.588570571448, 8256.752297431087, 8008.559529225832, 8097.35221182304, 8103.594820258963, 8145.981752280964, 8232.464889782264, 6396.168498095218, 6518.771842985568, 6536.150300460909, 6628.4697224221945, 6647.468202543785, 6523.347665233438, 6532.738690452328, 6568.770093046721, 6622.701978410887, 6637.203535575569, 7103.0, 7391.889121663072, 7486.064241969754, 7497.250274972459, 7509.286617771303, 7358.521696089737, 7622.733204338044, 7699.191584883731, 7738.071431428265, 7741.341985931033, 5853.1805547222575, 5873.5594830388745, 5901.704914754331, 5956.434138756811, 6010.038393856962, 6655.168103987002, 6701.927691569325, 6724.529282950147, 6804.455643548603, 6811.080504131879, 6151.815445536641, 6303.306636270098, 6311.652859092794, 6372.458341041063, 6472.223333200046, 6078.45293923549, 6079.844829482384, 6091.939080609137, 6211.689415529296, 6266.467350275278, 6276.8430789228805, 6278.843028924313, 6293.716782744879, 6348.174737284308, 6351.460125889351, 5405.864853378697, 5412.052890744183, 5441.755121019484, 5454.972725136349, 5527.336719593513, 5437.157240627709, 5508.697021663847, 5595.188697638901, 5603.159526071122, 5640.717964101696], "ext.html": [488.38707422185155, 499.555395697829, 500.81970490623394, 512.8846009647829, 529.8728305206752, 27880.163595092155, 28587.142385728435, 34500.0, 34812.47781283277, 35536.46695299566, 37472.62527374725, 37650.81174594123, 37831.62168378315, 37919.431208531896, 37948.0, 7363.447741419388, 7656.655450504727, 7824.608769561499, 7845.176256493043, 7923.366130709529, 7353.374963128141, 9538.713838584854, 9634.9518252409, 9650.034996500364, 9782.16851567614, 9546.474943878118, 9548.18840398567, 9555.665551705692, 9572.856407153899, 9614.567344469515, 7497.325240728361, 7665.386769058462, 9456.669016584387, 9473.526323683822, 9504.904950950506, 9239.445633262027, 9401.294902882311, 9408.95295523518, 9431.90568094324, 9534.570944307454, 34866.47700284498, 35322.0, 35324.823375883214, 35345.646543534494, 35363.646363536296, 2551.693796744384, 2566.7176610572824, 2602.2973797074683, 2791.1207969489546, 2937.4712551740677, 24046.398840028964, 24148.758512414828, 24462.877685611635, 24591.0, 24947.126850560144, 2033.6746120620778, 2047.2834507922257, 2062.257587268582, 2090.2997495838913, 2127.638301488735, 238698.0, 240055.0, 241789.0, 242417.0, 243239.0, 44978.0, 46350.0, 51390.48609513932, 52178.47821521812, 52669.73665131727, 58883.0, 60198.09702854461, 60307.396926030175, 60420.18739437824, 61026.55893764288, 14978.17620030887, 15130.0, 15320.923395383175, 15353.846461535464, 15363.462278820187, 11084.168687348481, 11109.666709998713, 11291.830622540669, 11292.71768205785, 11294.265872718412, 16523.421680241136, 16553.172341382884, 16577.336906523844, 16687.415940442028, 16829.663406731797, 7253.310935461122, 7289.95881153278, 7293.52592081513, 7344.70621175147, 7359.521631093961, 809.7566770278504, 830.8130670599066, 905.9184673379427, 907.7821322882461, 985.9359141655913, 23937.91702065283, 26722.331941701614, 26963.325916852235, 26979.730202697723, 26994.325141871217, 908.0873721909571, 911.4941207629696, 924.5284904698652, 966.2946049383849, 1012.6759436980243, 10533.262671613067, 11970.40147992597, 12186.207896486878, 12187.45156467961, 12452.688682782822, 221543.0, 222131.0, 222744.0, 222994.0, 223702.0, 38911.80544097262, 39754.403683944765, 42634.0, 43129.784351078044, 43992.78003609961, 1192.9701757456132, 1225.0505857960152, 1230.4489006767008, 1238.5231685801032, 1257.3964497041654, 24151.0, 24719.62920556157, 25213.11754088598, 25367.873160634077, 25421.0, 37968.430473542365, 38374.424383634825, 42621.78689106535, 44115.0, 44256.0, 180717.0964145171, 182389.0, 185271.0, 187257.0, 187442.0, 25927.092551760597, 25961.091361802246, 26196.345091372867, 26532.469350613264, 26636.0, 32567.511487327236, 32649.34701306008, 33734.32531349408, 34038.829805850815, 34315.828420858736, 29782.404351913272, 29816.552751709176, 29841.701582983893, 29845.70154298429, 30254.394912102074, 28838.0, 29372.0, 30059.699403006565, 30723.385532288783, 31210.843945780125, 30710.539341909443, 31549.684503155593, 31745.5238171423, 31905.883294085525, 31921.0, 25338.366540836625, 27432.58851117195, 27433.45133097367, 27879.442411151256, 28343.14970550887, 20689.58620827545, 20763.68854467154, 20801.479963001046, 21129.366119016453, 22053.889730551244], "prototype.html": [273.7085004470239, 274.38263906211023, 279.9146260390581, 287.290392729957, 299.3265153404839, 5178.611604129686, 5205.661631993918, 5248.186531087683, 5306.761195746191, 5390.757415916283, 5186.299849520314, 5237.947620523793, 5286.31277933868, 5310.230016647583, 5327.600429967758, 4079.102597428561, 4079.1841631673637, 4091.0, 4099.7745124018165, 4155.376693495977, 3926.7840268785208, 3957.821898014582, 3965.9603403966025, 4065.166640838636, 4101.446304748851, 4004.6796256299426, 4044.1102957349335, 4045.2314060328445, 4060.4112403701447, 4063.674906007527, 3987.063040185554, 4014.7791871447057, 4021.195760847842, 4075.0219947212454, 4095.7303235996787, 3496.1958749487508, 3499.7550171488006, 3510.192655689206, 3542.6811586957297, 3552.1119720069983, 4977.402711674622, 5104.234364845266, 5109.0, 5163.896722065575, 5179.715115668637, 4663.906721865544, 4663.930041049353, 4680.602148817355, 4690.577847993697, 4712.387389639359, 5571.8607034824045, 5572.721363931828, 5624.437556244384, 5645.915311270293, 5654.46282603152, 3584.9283014339826, 3668.321360548307, 3798.981005094957, 3879.7090218233743, 3936.5472970608175, 5676.205331253628, 5709.914351284692, 5746.655200687972, 5798.855028624318, 5842.415758424124, 3910.276598829226, 3931.941020884689, 3933.8623148189677, 3955.940660890089, 3979.1047014421524, 3976.9204615908097, 4015.377616469452, 4021.8391264349098, 4030.717849750548, 4032.6169013943627, 4513.796879140446, 4569.2689169732685, 4643.3731446255, 4698.647601429906, 4732.95267047332, 5467.589930755209, 5550.389457159709, 5555.30558680165, 5556.333240011225, 5613.607047506717, 1409.7110092431028, 1409.8872090232758, 1409.9083559568596, 1414.0525847682077, 1426.5221150914351, 933.6312156698066, 958.755517343087, 963.5615794813343, 965.3821554205314, 980.8921018687938, 5235.921461178085, 5257.0, 5259.342582177228, 5324.148136298174, 5343.866403339947, 5780.421957804186, 5796.014677504834, 5808.593398462067, 5875.559333050039, 5950.9107363389585, 5319.946800532022, 5331.573474122061, 5340.946590534045, 5373.731313434313, 5405.108157154104, 3147.1502694272417, 3190.489521676521, 3209.0533292678715, 3215.951760723591, 3273.29624130813, 5837.357890632027, 5851.0, 5869.442402971711, 5949.583529152917, 5962.1056841473255, 5895.4399332063385, 5919.230500034968, 5956.374580668968, 5977.641341519436, 6005.6997150142315, 5776.393478684846, 5852.092925596539, 5875.882482350329, 5945.851353716192, 5958.64248145104, 5815.76736930518, 5832.24180856486, 5843.737031833492, 5915.467607915309, 5918.348981611933, 5557.360903495988, 5566.944330556805, 5738.9139162913425, 5756.597038207286, 5782.884342313046, 5844.211031510692, 5856.4143585641095, 5872.735726892215, 5895.67573783446, 5947.940520594739, 3681.963180368162, 3717.85128594864, 3727.7017838572306, 3779.9244015118993, 3787.5265591801026, 5760.884782304414, 5775.422457754191, 5783.248177736868, 5812.099124635688, 5841.357450680337, 5577.553795696415, 5606.803761868478, 5618.6628802272, 5621.831345059655, 5707.286589176353, 5611.775528978958, 5615.971920140373, 5667.149927510906, 5672.716364181857, 5704.030314846403, 5493.395726470005, 5498.1752737089755, 5538.307711536058, 5571.275734154534, 5591.776328946797, 5457.754401052041, 5592.636478628876, 5622.269105016322, 5686.488216060409, 5699.686517241592, 5513.917291240555, 5514.035043867388, 5575.052241118939, 5609.691466969356, 5631.605787594993], "yui.html": [558.5392051557463, 576.3084298841388, 610.8961476548986, 661.8940969444889, 676.8274090107022, 10689.30519516231, 10922.344659320446, 11058.778824423516, 11256.043236324913, 11288.661340159788, 10272.332298400599, 10341.844872326903, 10411.583536658543, 10425.687229383111, 10433.739156521091, 739.589527812064, 751.4627041665208, 757.0196595408959, 760.8402235530546, 767.9539227646331, 746.8692978728728, 764.8776195808643, 765.885117232414, 765.8889461028148, 767.5816679909435, 791.0151860933146, 791.695197349019, 791.9168487308837, 792.7066985215449, 793.5595744361876, 768.258630421643, 775.1279810213538, 783.9608019598998, 786.3669745854585, 788.4717239449583, 577.8093229234385, 585.8652509922699, 586.574733318345, 586.9823905282848, 587.5475883569627, 11871.287722736663, 12088.0, 12147.210431322024, 12176.086793490524, 12179.451924663412, 7928.8810667840025, 8241.134680858544, 8287.378446616527, 8521.786955326104, 8698.260647844942, 7479.401647868158, 7491.32578067971, 7575.393968482508, 7700.4708168298, 7919.683212671486, 2473.1591258971857, 2505.6241563765398, 2544.2494464133124, 2564.012855050819, 2579.0457530713757, 35267.64732352669, 35496.64503354959, 39069.21861562781, 41937.16125677469, 42512.78743606293, 5156.535911767884, 5271.578273738091, 5316.734163291897, 5594.524465420403, 5679.233303503974, 10995.230333876552, 11019.889801101886, 11032.06227470674, 11193.440327983568, 11205.0, 5048.217526283432, 5073.467285934998, 5156.8968620627375, 5250.422453530108, 5293.708846013506, 3227.5320078588943, 3248.058063161704, 3251.219707270238, 3269.836508174582, 3320.900372988814, 2343.5312937412587, 2345.6012477878803, 2353.188150088217, 2376.8455050421667, 2377.9643305350432, 349.8425708431216, 350.411309000881, 354.5745105872963, 357.05736854703605, 358.3513839949699, 388.40186113385636, 397.70172370721957, 419.42329297216327, 450.08183306055935, 461.5499887609621, 6295.181626388632, 6397.136386587844, 6577.0, 6648.202215734143, 6698.196216454056, 366.7087886221197, 384.68648051837664, 390.00743108787634, 485.8178183181307, 528.8968651113073, 3161.6206055273515, 3167.920801979923, 3262.5921759780026, 3317.2370354818527, 3364.360771453416, 50395.496045039814, 55482.16776748352, 55788.16317755237, 56635.716821415626, 56725.43274567284, 43784.56215437805, 44082.33876491855, 44136.77931610322, 44159.11681766347, 44173.779131104784, 37399.25201496009, 37404.0, 40647.1870562593, 41828.372574411405, 43349.0, 6655.633940133339, 7152.821179470555, 7441.553506789393, 7499.379929559911, 7570.886436703564, 32653.673463265062, 32676.50985235176, 33202.33595328128, 33692.0, 34221.14447138841, 35672.64327356693, 35675.82162089277, 40590.39114413227, 40773.38839917344, 41499.1700166001, 6446.67766611677, 6470.5147113965695, 6556.901646475211, 6706.8993965089585, 6723.361280678328, 9924.950375248078, 10077.500012491755, 10159.390436573829, 10492.790144197226, 10611.363318200623, 8388.748337549883, 8814.559272036244, 9236.538173091185, 9238.0, 9371.812563748823, 9119.452832830051, 9296.116868897443, 9367.531623418665, 9381.452554089421, 9711.465869377253, 8817.206451419403, 9019.0, 9135.04082071373, 9185.862212066691, 9411.247100232102, 7916.920830791619, 7956.2043795619975, 8103.594820258845, 8167.387445941459, 8309.964058805632, 7960.283574478325, 7994.2805147537, 7997.320227780471, 8098.756102653912, 8135.0]}, "summary": {"suite": 5740.604628446802, "subtests": {"jquery.html": {"filtered": 5886.9611178148025, "value": 5886.9611178148025}, "dojo.html": {"filtered": 4661.332184174805, "value": 4661.332184174805}, "mootools.html": {"filtered": 3905.823665825557, "value": 3905.823665825557}, "ext.html": {"filtered": 15957.238035371442, "value": 15957.238035371442}, "prototype.html": {"filtered": 4213.23823768585, "value": 4213.23823768585}, "yui.html": {"filtered": 4966.109355145479, "value": 4966.109355145479}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0101"}, "testrun": {"date": 1448368882, "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": "20151124031430", "branch": "Mozilla-Aurora", "revision": "124aaf8a8940cf68c741f7185b317c2afd0516b9"}}, {"talos_counters": {}, "results": {"audio-dft": [183.0, 188.0, 190.0, 195.0, 195.0, 188.0, 189.0, 189.0, 189.0, 188.0], "ai-astar": [123.0, 129.0, 123.0, 129.0, 131.0, 135.0, 119.0, 127.0, 126.0, 128.0], "imaging-gaussian-blur": [139.0, 143.0, 141.0, 136.0, 141.0, 134.0, 148.0, 145.0, 135.0, 141.0], "audio-beat-detection": [175.0, 154.0, 194.0, 181.0, 152.0, 171.0, 147.0, 191.0, 181.0, 153.0], "json-stringify-tinderbox": [73.0, 78.0, 77.0, 81.0, 78.0, 79.0, 85.0, 82.0, 83.0, 79.0], "stanford-crypto-pbkdf2": [155.0, 170.0, 172.0, 181.0, 181.0, 174.0, 171.0, 169.0, 159.0, 159.0], "json-parse-financial": [61.0, 71.0, 71.0, 73.0, 72.0, 73.0, 73.0, 84.0, 70.0, 72.0], "stanford-crypto-sha256-iterative": [76.0, 77.0, 81.0, 80.0, 83.0, 84.0, 85.0, 85.0, 83.0, 80.0], "audio-fft": [84.0, 95.0, 91.0, 142.0, 80.0, 86.0, 86.0, 86.0, 144.0, 78.0], "imaging-darkroom": [147.0, 147.0, 153.0, 151.0, 147.0, 146.0, 153.0, 153.0, 147.0, 146.0], "stanford-crypto-ccm": [155.0, 146.0, 144.0, 144.0, 153.0, 145.0, 155.0, 156.0, 146.0, 149.0], "audio-oscillator": [112.0, 114.0, 164.0, 108.0, 112.0, 105.0, 150.0, 103.0, 103.0, 153.0], "stanford-crypto-aes": [91.0, 95.0, 98.0, 103.0, 100.0, 100.0, 99.0, 97.0, 97.0, 102.0], "imaging-desaturate": [119.0, 124.0, 125.0, 124.0, 122.0, 119.0, 124.0, 126.0, 136.0, 129.0]}, "summary": {"suite": 1769.5, "subtests": {"audio-fft": {"filtered": 97.2, "value": 97.2}, "stanford-crypto-pbkdf2": {"filtered": 169.1, "value": 169.1}, "audio-beat-detection": {"filtered": 169.9, "value": 169.9}, "stanford-crypto-ccm": {"filtered": 149.3, "value": 149.3}, "imaging-darkroom": {"filtered": 149.0, "value": 149.0}, "json-parse-financial": {"filtered": 72.0, "value": 72.0}, "audio-oscillator": {"filtered": 122.4, "value": 122.4}, "ai-astar": {"filtered": 127.0, "value": 127.0}, "audio-dft": {"filtered": 189.4, "value": 189.4}, "stanford-crypto-sha256-iterative": {"filtered": 81.4, "value": 81.4}, "json-stringify-tinderbox": {"filtered": 79.5, "value": 79.5}, "imaging-gaussian-blur": {"filtered": 140.3, "value": 140.3}, "stanford-crypto-aes": {"filtered": 98.2, "value": 98.2}, "imaging-desaturate": {"filtered": 124.8, "value": 124.8}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0101"}, "testrun": {"date": 1448368882, "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": "20151124031430", "branch": "Mozilla-Aurora", "revision": "124aaf8a8940cf68c741f7185b317c2afd0516b9"}}, {"talos_counters": {}, "results": {"DeltaBlue": [221.14108801415304], "Encrypt": [370.78235076010384], "NavierStokes": [6738.255033557047], "Decrypt": [6532.467532467533], "Splay": [668.4491978609626], "Richards": [194.51468585878234], "RegExp": [36280.70175438596], "Earley": [823.0452674897119], "Boyer": [14735.29411764706], "RayTrace": [1226.993865030675]}, "summary": {"suite": 17365.339153329816, "subtests": {"DeltaBlue": {"filtered": 298.98559600000004, "value": 298.98559600000004}, "Encrypt": {"filtered": 717.8901570000002, "value": 717.8901570000002}, "NavierStokes": {"filtered": 220.23505976095626, "value": 220.23505976095626}, "Decrypt": {"filtered": 40.747389662027814, "value": 40.747389662027814}, "Splay": {"filtered": 121.910536, "value": 121.910536}, "RegExp": {"filtered": 25.109354448742753, "value": 25.109354448742753}, "Richards": {"filtered": 181.48758199999995, "value": 181.48758199999995}, "Earley": {"filtered": 809.7525450000003, "value": 809.7525450000003}, "Boyer": {"filtered": 45.229025948103796, "value": 45.229025948103796}, "RayTrace": {"filtered": 603.0910349999999, "value": 603.0910349999999}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0101"}, "testrun": {"date": 1448368882, "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": "20151124031430", "branch": "Mozilla-Aurora", "revision": "124aaf8a8940cf68c741f7185b317c2afd0516b9"}}] 05:01:38 INFO - RETURN: dromaeo_css: 5740.60 05:01:38 INFO - RETURN: kraken: 1769.50 05:01:38 INFO - RETURN: v8_7: 17365.34 05:01:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "17365.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1769.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5740.60"}}} 05:01:38 INFO - Return code: 0 05:01:38 INFO - # TBPL SUCCESS # 05:01:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:01:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:01:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:01:38 INFO - 2015-11-24 05:01:38.487 screenresolution[2292:21759] starting screenresolution argv=screenresolution get 05:01:38 INFO - 2015-11-24 05:01:38.490 screenresolution[2292:21759] Display 0: 1600x1200x32@60 05:01:38 INFO - 2015-11-24 05:01:38.497 screenresolution[2293:21762] starting screenresolution argv=screenresolution list 05:01:38 INFO - Available Modes on Display 0 05:01:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:01:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:01:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:01:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:01:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:01:38 INFO - Intel HD Graphics 3000: 05:01:38 INFO - Chipset Model: Intel HD Graphics 3000 05:01:38 INFO - Type: GPU 05:01:38 INFO - Bus: Built-In 05:01:38 INFO - VRAM (Total): 512 MB 05:01:38 INFO - VRAM (Dynamic, Max): 10 05:01:38 INFO - Vendor: Intel (0x8086) 05:01:38 INFO - Device ID: 0x0116 05:01:38 INFO - Revision ID: 0x0009 05:01:38 INFO - Displays: 05:01:38 INFO - Display: 05:01:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:01:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:01:38 INFO - Display Serial Number: 1600x1200 60 05:01:38 INFO - Main Display: Yes 05:01:38 INFO - Mirror: Off 05:01:38 INFO - Online: Yes 05:01:38 INFO - Rotation: Supported 05:01:38 INFO - Return code: 0 05:01:38 INFO - Running post-action listener: _resource_record_post_action 05:01:38 INFO - Running post-run listener: _resource_record_post_run 05:01:39 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 208896; Write bytes: 685316096; Read time: 82; Write time: 60905 05:01:39 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 339759616; Write bytes: 334747648; Read time: 36583; Write time: 7140 05:01:39 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 208896; Write bytes: 340279296; Read time: 82; Write time: 52960 05:01:39 INFO - Running post-run listener: _upload_blobber_files 05:01:39 INFO - Blob upload gear active. 05:01:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:01:39 INFO - Copying logs to upload dir... 05:01:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1322.502965 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2015-11-24 05:01:39.944738) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 05:01:39.949711) ========= 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.3JMVxMZiHY/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.Wi31xM56Xt/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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/eu1qtpcoQPiDZ3qREXMynw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009961 build_url: 'https://queue.taskcluster.net/v1/task/eu1qtpcoQPiDZ3qREXMynw/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-24 05:01:39.976316) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:01:39.976692) ========= 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.3JMVxMZiHY/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.Wi31xM56Xt/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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.005335 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:01:40.028717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 05:01:40.029098) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 05:01:40.030006) ========= ========= Total master_lag: 0.23 =========