builder: alder_yosemite_test-dromaeojs slave: t-yosemite-r5-0016 starttime: 1447733260.89 results: success (0) buildid: 20151116150236 builduid: c5dd9af93c4643e892e2f22bf083ab1f revision: 5cec55768069f26a9d88569102081aa48c041309 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:40.890971) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:40.891499) ========= ========= Started set props: basedir (results: 0, elapsed: 4 secs) (at 2015-11-16 20:07:40.891832) ========= 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.1TD8bnSeCO/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.9uoGquWrju/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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.006223 basedir: '/builds/slave/test' ========= master_lag: 4.96 ========= ========= Finished set props: basedir (results: 0, elapsed: 4 secs) (at 2015-11-16 20:07:45.862023) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:45.862407) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:45.998981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2015-11-16 20:07:45.999555) ========= 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.1TD8bnSeCO/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.9uoGquWrju/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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.005392 ========= master_lag: 4.50 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2015-11-16 20:07:50.501617) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:50.501994) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:50.505432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2015-11-16 20:07:50.505755) ========= 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.1TD8bnSeCO/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.9uoGquWrju/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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-16 20:07:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102, :: Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 7.66M=0.002s 2015-11-16 20:07:52 (7.66 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143854 ========= master_lag: 7.42 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2015-11-16 20:07:58.069643) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:58.070016) ========= 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.1TD8bnSeCO/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.9uoGquWrju/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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.019743 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:58.139316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:58.139731) ========= bash -c 'python archiver_client.py mozharness --repo projects/alder --rev 5cec55768069f26a9d88569102081aa48c041309 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/alder --rev 5cec55768069f26a9d88569102081aa48c041309 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1TD8bnSeCO/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.9uoGquWrju/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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-16 20:07:58,209 truncating revision to first 12 chars 2015-11-16 20:07:58,209 Setting DEBUG logging. 2015-11-16 20:07:58,209 attempt 1/10 2015-11-16 20:07:58,210 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/alder/5cec55768069?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 20:07:58,499 unpacking tar archive at: alder-5cec55768069/testing/mozharness/ program finished with exit code 0 elapsedTime=0.705024 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:58.988600) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:58.988951) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:59.351020) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:59.351359) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:59.351762) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2015-11-16 20:07:59.352076) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Alder --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Alder 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', 'Alder', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Alder'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1TD8bnSeCO/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.9uoGquWrju/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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 20:07:59 INFO - MultiFileLogger online at 20151116 20:07:59 in /builds/slave/test 20:07:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Alder --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Alder 20:07:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:07:59 INFO - {'append_to_log': False, 20:07:59 INFO - 'base_work_dir': '/builds/slave/test', 20:07:59 INFO - 'blob_upload_branch': 'Alder', 20:07:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:07:59 INFO - 'branch': 'Alder', 20:07:59 INFO - 'buildbot_json_path': 'buildprops.json', 20:07:59 INFO - 'config_files': ('talos/mac_config.py',), 20:07:59 INFO - 'default_actions': ('clobber', 20:07:59 INFO - 'read-buildbot-config', 20:07:59 INFO - 'download-and-extract', 20:07:59 INFO - 'populate-webroot', 20:07:59 INFO - 'create-virtualenv', 20:07:59 INFO - 'install', 20:07:59 INFO - 'run-tests'), 20:07:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:07:59 INFO - 'download_minidump_stackwalk': True, 20:07:59 INFO - 'download_symbols': 'ondemand', 20:07:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:07:59 INFO - 'tooltool.py': '/tools/tooltool.py', 20:07:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:07:59 INFO - '/tools/misc-python/virtualenv.py')}, 20:07:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:07:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:07:59 INFO - 'installer_path': 'installer.exe', 20:07:59 INFO - 'log_level': 'info', 20:07:59 INFO - 'log_name': 'talos', 20:07:59 INFO - 'log_to_console': True, 20:07:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:07:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:07:59 INFO - 'opt_config_files': (), 20:07:59 INFO - 'pip_index': False, 20:07:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:07:59 INFO - 'cmd': ('bash', 20:07:59 INFO - '-c', 20:07:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:07:59 INFO - 'enabled': True, 20:07:59 INFO - 'halt_on_failure': False, 20:07:59 INFO - 'name': 'check_screen_resolution'},), 20:07:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:07:59 INFO - 'cmd': ('bash', 20:07:59 INFO - '-c', 20:07:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:07:59 INFO - 'enabled': True, 20:07:59 INFO - 'halt_on_failure': False, 20:07:59 INFO - 'name': 'check_screen_resolution'},), 20:07:59 INFO - 'run_cmd_checks_enabled': True, 20:07:59 INFO - 'sps_profile': False, 20:07:59 INFO - 'sps_profile_interval': 0, 20:07:59 INFO - 'suite': 'dromaeojs', 20:07:59 INFO - 'system_bits': '64', 20:07:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:07:59 INFO - 'title': 't-yosemite-r5-0016', 20:07:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:07:59 INFO - 'use_talos_json': True, 20:07:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:07:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:07:59 INFO - 'work_dir': 'build'} 20:07:59 INFO - ##### 20:07:59 INFO - ##### Running clobber step. 20:07:59 INFO - ##### 20:07:59 INFO - Running pre-action listener: _resource_record_pre_action 20:07:59 INFO - Running main action method: clobber 20:07:59 INFO - rmtree: /builds/slave/test/build 20:07:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:08:01 INFO - Running post-action listener: _resource_record_post_action 20:08:01 INFO - ##### 20:08:01 INFO - ##### Running read-buildbot-config step. 20:08:01 INFO - ##### 20:08:01 INFO - Running pre-action listener: _resource_record_pre_action 20:08:01 INFO - Running main action method: read_buildbot_config 20:08:01 INFO - Using buildbot properties: 20:08:01 INFO - { 20:08:01 INFO - "properties": { 20:08:01 INFO - "buildnumber": 0, 20:08:01 INFO - "product": "firefox", 20:08:01 INFO - "script_repo_revision": "production", 20:08:01 INFO - "builddir": "alder_yosemite_test-dromaeojs", 20:08:01 INFO - "repository": "", 20:08:01 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 alder talos dromaeojs", 20:08:01 INFO - "buildid": "20151116150236", 20:08:01 INFO - "slavename": "t-yosemite-r5-0016", 20:08:01 INFO - "pgo_build": "False", 20:08:01 INFO - "basedir": "/builds/slave/test", 20:08:01 INFO - "project": "", 20:08:01 INFO - "platform": "yosemite", 20:08:01 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 20:08:01 INFO - "slavebuilddir": "test", 20:08:01 INFO - "scheduler": "tests-alder-macosx64-talos", 20:08:01 INFO - "branch": "alder", 20:08:01 INFO - "repo_path": "projects/alder", 20:08:01 INFO - "stage_platform": "macosx64", 20:08:01 INFO - "builduid": "c5dd9af93c4643e892e2f22bf083ab1f", 20:08:01 INFO - "revision": "5cec55768069f26a9d88569102081aa48c041309" 20:08:01 INFO - }, 20:08:01 INFO - "sourcestamp": { 20:08:01 INFO - "repository": "", 20:08:01 INFO - "hasPatch": false, 20:08:01 INFO - "project": "", 20:08:01 INFO - "branch": "alder-macosx64-talos", 20:08:01 INFO - "changes": [ 20:08:01 INFO - { 20:08:01 INFO - "category": null, 20:08:01 INFO - "files": [ 20:08:01 INFO - { 20:08:01 INFO - "url": null, 20:08:01 INFO - "name": "https://queue.taskcluster.net/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 20:08:01 INFO - } 20:08:01 INFO - ], 20:08:01 INFO - "repository": "", 20:08:01 INFO - "rev": "5cec55768069f26a9d88569102081aa48c041309", 20:08:01 INFO - "who": "sendchange", 20:08:01 INFO - "when": 1447721600, 20:08:01 INFO - "number": 6669142, 20:08:01 INFO - "comments": "", 20:08:01 INFO - "project": "", 20:08:01 INFO - "at": "Mon 16 Nov 2015 16:53:20", 20:08:01 INFO - "branch": "alder-macosx64-talos", 20:08:01 INFO - "revlink": "", 20:08:01 INFO - "properties": [ 20:08:01 INFO - [ 20:08:01 INFO - "buildid", 20:08:01 INFO - "20151116150236", 20:08:01 INFO - "Change" 20:08:01 INFO - ], 20:08:01 INFO - [ 20:08:01 INFO - "builduid", 20:08:01 INFO - "c5dd9af93c4643e892e2f22bf083ab1f", 20:08:01 INFO - "Change" 20:08:01 INFO - ], 20:08:01 INFO - [ 20:08:01 INFO - "pgo_build", 20:08:01 INFO - "False", 20:08:01 INFO - "Change" 20:08:01 INFO - ] 20:08:01 INFO - ], 20:08:01 INFO - "revision": "5cec55768069f26a9d88569102081aa48c041309" 20:08:01 INFO - } 20:08:01 INFO - ], 20:08:01 INFO - "revision": "5cec55768069f26a9d88569102081aa48c041309" 20:08:01 INFO - } 20:08:01 INFO - } 20:08:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 20:08:01 INFO - Running post-action listener: _resource_record_post_action 20:08:01 INFO - ##### 20:08:01 INFO - ##### Running download-and-extract step. 20:08:01 INFO - ##### 20:08:01 INFO - Running pre-action listener: _resource_record_pre_action 20:08:01 INFO - Running main action method: download_and_extract 20:08:01 INFO - mkdir: /builds/slave/test/build/tests 20:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:01 INFO - https://queue.taskcluster.net/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:08:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/test_packages.json 20:08:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/test_packages.json 20:08:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:08:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:08:02 INFO - Downloaded 1149 bytes. 20:08:02 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:08:02 INFO - Using the following test package requirements: 20:08:02 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 20:08:02 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 20:08:02 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 20:08:02 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 20:08:02 INFO - u'jsshell-mac.zip'], 20:08:02 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 20:08:02 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 20:08:02 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 20:08:02 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 20:08:02 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 20:08:02 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 20:08:02 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 20:08:02 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 20:08:02 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 20:08:02 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 20:08:02 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 20:08:02 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 20:08:02 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:08:02 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')]} 20:08:02 INFO - https://queue.taskcluster.net/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:08:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 20:08:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 20:08:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 20:08:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:08:03 INFO - Downloaded 17452431 bytes. 20:08:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 20:08:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 20:08:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 20:08:09 INFO - Return code: 0 20:08:09 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:08:09 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')]} 20:08:09 INFO - https://queue.taskcluster.net/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:08:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 20:08:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 20:08:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 20:08:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:08:11 INFO - Downloaded 17452431 bytes. 20:08:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 20:08:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 20:08:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 20:08:16 INFO - Return code: 0 20:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:16 INFO - https://queue.taskcluster.net/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 20:08:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 20:08:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 20:08:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 20:08:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:08:17 INFO - Downloaded 11131307 bytes. 20:08:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 20:08:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 20:08:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 20:08:17 INFO - Return code: 0 20:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:17 INFO - https://queue.taskcluster.net/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 20:08:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 20:08:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 20:08:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 20:08:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 20:08:21 INFO - Downloaded 108565914 bytes. 20:08:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 20:08:21 INFO - mkdir: /builds/slave/test/properties 20:08:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:08:21 INFO - Writing to file /builds/slave/test/properties/build_url 20:08:21 INFO - Contents: 20:08:21 INFO - build_url:https://queue.taskcluster.net/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 20:08:21 INFO - Running post-action listener: _resource_record_post_action 20:08:21 INFO - Running post-action listener: set_extra_try_arguments 20:08:21 INFO - ##### 20:08:21 INFO - ##### Running populate-webroot step. 20:08:21 INFO - ##### 20:08:21 INFO - Running pre-action listener: _resource_record_pre_action 20:08:21 INFO - Running main action method: populate_webroot 20:08:21 INFO - Guessing talos json url... 20:08: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')]} 20:08:21 INFO - https://queue.taskcluster.net/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 20:08:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 20:08:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 20:08:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 20:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 20:08:22 INFO - Downloaded 98 bytes. 20:08:22 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 20:08:22 INFO - Contents: 20:08:22 INFO - 20151116150236 20:08:22 INFO - https://hg.mozilla.org/projects/alder/rev/5cec55768069f26a9d88569102081aa48c041309 20:08: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')]} 20:08:22 INFO - trying https://hg.mozilla.org/projects/alder/raw-file/5cec557680/testing/talos/talos.json 20:08:22 INFO - Downloading https://hg.mozilla.org/projects/alder/raw-file/5cec557680/testing/talos/talos.json to /builds/slave/test/build/talos.json 20:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/projects/alder/raw-file/5cec557680/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 20:08:22 INFO - Downloaded 4264 bytes. 20:08:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:08:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:08:22 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 20:08:22 INFO - '../fennec_ids.txt'], 20:08:22 INFO - 'tests': ['tcheck2']}, 20:08:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:08:22 INFO - '--tppagecycles', 20:08:22 INFO - '7'], 20:08:22 INFO - 'tests': ['tsvgm']}}, 20:08:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:08:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:08:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:08:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:08:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:08:22 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:08:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:22 INFO - 'talos_options': ['--e10s'], 20:08:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:22 INFO - 'tests': ['damp', 'tps']}, 20:08:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:22 INFO - 'talos_options': ['--e10s'], 20:08:22 INFO - 'tests': ['damp', 'tps']}, 20:08:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:08:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:08:22 INFO - 'other': {'tests': ['a11yr', 20:08:22 INFO - 'ts_paint', 20:08:22 INFO - 'tpaint', 20:08:22 INFO - 'sessionrestore', 20:08:22 INFO - 'sessionrestore_no_auto_restore']}, 20:08:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:08:22 INFO - 'tests': ['a11yr', 20:08:22 INFO - 'ts_paint', 20:08:22 INFO - 'tpaint', 20:08:22 INFO - 'sessionrestore', 20:08:22 INFO - 'sessionrestore_no_auto_restore']}, 20:08:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:08:22 INFO - 'tests': ['a11yr', 20:08:22 INFO - 'ts_paint', 20:08:22 INFO - 'tpaint', 20:08:22 INFO - 'sessionrestore', 20:08:22 INFO - 'sessionrestore_no_auto_restore']}, 20:08:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:08:22 INFO - 'tests': ['a11yr', 20:08:22 INFO - 'ts_paint', 20:08:22 INFO - 'tpaint', 20:08:22 INFO - 'sessionrestore', 20:08:22 INFO - 'sessionrestore_no_auto_restore']}, 20:08:22 INFO - 'other_l64': {'tests': ['a11yr', 20:08:22 INFO - 'ts_paint', 20:08:22 INFO - 'tpaint', 20:08:22 INFO - 'sessionrestore', 20:08:22 INFO - 'sessionrestore_no_auto_restore']}, 20:08:22 INFO - 'other_nol64': {'tests': ['a11yr', 20:08:22 INFO - 'ts_paint', 20:08:22 INFO - 'tpaint', 20:08:22 INFO - 'sessionrestore', 20:08:22 INFO - 'sessionrestore_no_auto_restore']}, 20:08:22 INFO - 'svgr': {'tests': ['tsvgx', 20:08:22 INFO - 'tsvgr_opacity', 20:08:22 INFO - 'tart', 20:08:22 INFO - 'tscrollx', 20:08:22 INFO - 'cart']}, 20:08:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:08:22 INFO - 'tests': ['tsvgx', 20:08:22 INFO - 'tsvgr_opacity', 20:08:22 INFO - 'tart', 20:08:22 INFO - 'tscrollx', 20:08:22 INFO - 'cart']}, 20:08:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:22 INFO - 'tests': ['tp5o']}, 20:08:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:22 INFO - 'talos_options': ['--e10s'], 20:08:22 INFO - 'tests': ['tp5o']}, 20:08:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:22 INFO - 'talos_options': ['--xperf_path', 20:08:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:22 INFO - 'tests': ['tp5n']}, 20:08:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:22 INFO - 'talos_options': ['--e10s', 20:08:22 INFO - '--xperf_path', 20:08:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 20:08:22 INFO - 'C:/slave/talos-data/talos/xperf.config'], 20:08:22 INFO - 'tests': ['tp5n']}}, 20:08:22 INFO - 'talos.zip': {'path': '', 20:08:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:08:22 INFO - Running post-action listener: _resource_record_post_action 20:08:22 INFO - ##### 20:08:22 INFO - ##### Running create-virtualenv step. 20:08:22 INFO - ##### 20:08:22 INFO - Running pre-action listener: _resource_record_pre_action 20:08:22 INFO - Running main action method: create_virtualenv 20:08:22 INFO - Creating virtualenv /builds/slave/test/build/venv 20:08:22 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 20:08:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:08:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:08:23 INFO - Using real prefix '/tools/python27' 20:08:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:08:24 INFO - Installing distribute.............................................................................................................................................................................................done. 20:08:27 INFO - Installing pip.................done. 20:08:27 INFO - Return code: 0 20:08:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:08: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')]} 20:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:27 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 0x103c7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f8e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c319f0>, '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 0x103990cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bfb990>, '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.1TD8bnSeCO/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.9uoGquWrju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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 20:08:27 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 20:08:27 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 20:08:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1TD8bnSeCO/Render', 20:08:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:27 INFO - 'HOME': '/Users/cltbld', 20:08:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:27 INFO - 'LOGNAME': 'cltbld', 20:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:27 INFO - 'MOZ_NO_REMOTE': '1', 20:08:27 INFO - 'NO_EM_RESTART': '1', 20:08:27 INFO - 'PAGER': '/bin/cat', 20:08:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:27 INFO - 'PWD': '/builds/slave/test', 20:08:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:27 INFO - 'SHELL': '/bin/bash', 20:08:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9uoGquWrju/Listeners', 20:08:27 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 20:08:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:27 INFO - 'USER': 'cltbld', 20:08:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:27 INFO - 'XPC_FLAGS': '0x0', 20:08:27 INFO - 'XPC_SERVICE_NAME': '0', 20:08:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 20:08:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:27 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 20:08:27 INFO - Cleaning up... 20:08:27 INFO - Return code: 0 20:08:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:08: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')]} 20:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:27 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 0x103c7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f8e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c319f0>, '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 0x103990cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bfb990>, '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.1TD8bnSeCO/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.9uoGquWrju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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 20:08:27 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 20:08:27 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 20:08:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1TD8bnSeCO/Render', 20:08:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:27 INFO - 'HOME': '/Users/cltbld', 20:08:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:27 INFO - 'LOGNAME': 'cltbld', 20:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:27 INFO - 'MOZ_NO_REMOTE': '1', 20:08:27 INFO - 'NO_EM_RESTART': '1', 20:08:27 INFO - 'PAGER': '/bin/cat', 20:08:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:27 INFO - 'PWD': '/builds/slave/test', 20:08:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:27 INFO - 'SHELL': '/bin/bash', 20:08:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9uoGquWrju/Listeners', 20:08:27 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 20:08:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:27 INFO - 'USER': 'cltbld', 20:08:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:27 INFO - 'XPC_FLAGS': '0x0', 20:08:27 INFO - 'XPC_SERVICE_NAME': '0', 20:08:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 20:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:28 INFO - Downloading/unpacking psutil>=0.7.1 20:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:30 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 20:08:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:08:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:30 INFO - Installing collected packages: psutil 20:08:30 INFO - Running setup.py install for psutil 20:08:30 INFO - building 'psutil._psutil_osx' extension 20:08:30 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 20:08:31 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 20:08:31 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 20:08:31 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 20:08:31 INFO - building 'psutil._psutil_posix' extension 20:08:31 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 20:08:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:08:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:08:31 INFO - ^ 20:08:31 INFO - 1 warning generated. 20:08:31 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 20:08:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:31 INFO - Successfully installed psutil 20:08:31 INFO - Cleaning up... 20:08:31 INFO - Return code: 0 20:08:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103c7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f8e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c319f0>, '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 0x103990cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bfb990>, '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.1TD8bnSeCO/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.9uoGquWrju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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 20:08:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:08:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1TD8bnSeCO/Render', 20:08:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:31 INFO - 'HOME': '/Users/cltbld', 20:08:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:31 INFO - 'LOGNAME': 'cltbld', 20:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:31 INFO - 'MOZ_NO_REMOTE': '1', 20:08:31 INFO - 'NO_EM_RESTART': '1', 20:08:31 INFO - 'PAGER': '/bin/cat', 20:08:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:31 INFO - 'PWD': '/builds/slave/test', 20:08:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:31 INFO - 'SHELL': '/bin/bash', 20:08:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9uoGquWrju/Listeners', 20:08:31 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 20:08:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:31 INFO - 'USER': 'cltbld', 20:08:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:31 INFO - 'XPC_FLAGS': '0x0', 20:08:31 INFO - 'XPC_SERVICE_NAME': '0', 20:08:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 20:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:08:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:08:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:08:34 INFO - Installing collected packages: mozsystemmonitor 20:08:34 INFO - Running setup.py install for mozsystemmonitor 20:08:34 INFO - Successfully installed mozsystemmonitor 20:08:34 INFO - Cleaning up... 20:08:34 INFO - Return code: 0 20:08:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:34 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 0x103c7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f8e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c319f0>, '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 0x103990cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bfb990>, '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.1TD8bnSeCO/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.9uoGquWrju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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 20:08:34 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 20:08:34 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 20:08:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1TD8bnSeCO/Render', 20:08:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:34 INFO - 'HOME': '/Users/cltbld', 20:08:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:34 INFO - 'LOGNAME': 'cltbld', 20:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:34 INFO - 'MOZ_NO_REMOTE': '1', 20:08:34 INFO - 'NO_EM_RESTART': '1', 20:08:34 INFO - 'PAGER': '/bin/cat', 20:08:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:34 INFO - 'PWD': '/builds/slave/test', 20:08:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:34 INFO - 'SHELL': '/bin/bash', 20:08:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9uoGquWrju/Listeners', 20:08:34 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 20:08:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:34 INFO - 'USER': 'cltbld', 20:08:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:34 INFO - 'XPC_FLAGS': '0x0', 20:08:34 INFO - 'XPC_SERVICE_NAME': '0', 20:08:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 20:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:34 INFO - Downloading/unpacking blobuploader==1.2.4 20:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:37 INFO - Downloading blobuploader-1.2.4.tar.gz 20:08:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:08:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:08:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:08:37 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 20:08:37 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 20:08:37 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 20:08:37 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 20:08:37 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 20:08:37 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 20:08:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:08:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:08:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:08:38 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 20:08:38 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 20:08:38 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 20:08:38 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 20:08:38 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 20:08:38 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 20:08:38 INFO - Downloading docopt-0.6.1.tar.gz 20:08:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:08:38 INFO - Installing collected packages: blobuploader, requests, docopt 20:08:38 INFO - Running setup.py install for blobuploader 20:08:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:08:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:08:39 INFO - Running setup.py install for requests 20:08:39 INFO - Running setup.py install for docopt 20:08:39 INFO - Successfully installed blobuploader requests docopt 20:08:39 INFO - Cleaning up... 20:08:39 INFO - Return code: 0 20:08:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08: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')]} 20:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:39 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 0x103c7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f8e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c319f0>, '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 0x103990cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bfb990>, '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.1TD8bnSeCO/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.9uoGquWrju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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 20:08:39 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 20:08:39 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 20:08:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1TD8bnSeCO/Render', 20:08:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:39 INFO - 'HOME': '/Users/cltbld', 20:08:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:39 INFO - 'LOGNAME': 'cltbld', 20:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:39 INFO - 'MOZ_NO_REMOTE': '1', 20:08:39 INFO - 'NO_EM_RESTART': '1', 20:08:39 INFO - 'PAGER': '/bin/cat', 20:08:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:39 INFO - 'PWD': '/builds/slave/test', 20:08:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:39 INFO - 'SHELL': '/bin/bash', 20:08:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9uoGquWrju/Listeners', 20:08:39 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 20:08:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:39 INFO - 'USER': 'cltbld', 20:08:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:39 INFO - 'XPC_FLAGS': '0x0', 20:08:39 INFO - 'XPC_SERVICE_NAME': '0', 20:08:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 20:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:40 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-B4Saif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:40 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-NdFODM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:40 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-J6qFzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:40 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-j_7IMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:40 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-FEbrbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:40 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-4Qha4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:40 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-hKzrA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:40 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-39YXFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:41 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-DVy_Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:41 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-W2Gz_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:41 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-OmNE08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:41 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-KdTm9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:41 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-3HPf1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:41 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-K2R2pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:41 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-63AuH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:41 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-flUcUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:42 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-00ufhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:08:42 INFO - Running setup.py install for manifestparser 20:08:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:08:42 INFO - Running setup.py install for mozcrash 20:08:42 INFO - Running setup.py install for mozdebug 20:08:42 INFO - Running setup.py install for mozdevice 20:08:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:08:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:08:42 INFO - Running setup.py install for mozfile 20:08:43 INFO - Running setup.py install for mozhttpd 20:08:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:08:43 INFO - Running setup.py install for mozinfo 20:08:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:08:43 INFO - Running setup.py install for mozInstall 20:08:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:08:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:08:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:08:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:08:43 INFO - Running setup.py install for mozleak 20:08:43 INFO - Running setup.py install for mozlog 20:08:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:08:44 INFO - Running setup.py install for moznetwork 20:08:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:08:44 INFO - Running setup.py install for mozprocess 20:08:44 INFO - Running setup.py install for mozprofile 20:08:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:08:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:08:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:08:44 INFO - Running setup.py install for mozrunner 20:08:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:08:44 INFO - Running setup.py install for mozscreenshot 20:08:44 INFO - Running setup.py install for moztest 20:08:45 INFO - Running setup.py install for mozversion 20:08:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:08:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:08:45 INFO - Cleaning up... 20:08:45 INFO - Return code: 0 20:08:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:45 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')]} 20:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:45 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')]} 20:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:45 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 0x103c7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f8e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c319f0>, '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 0x103990cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bfb990>, '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.1TD8bnSeCO/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.9uoGquWrju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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 20:08:45 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 20:08:45 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 20:08:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1TD8bnSeCO/Render', 20:08:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:45 INFO - 'HOME': '/Users/cltbld', 20:08:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:45 INFO - 'LOGNAME': 'cltbld', 20:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:45 INFO - 'MOZ_NO_REMOTE': '1', 20:08:45 INFO - 'NO_EM_RESTART': '1', 20:08:45 INFO - 'PAGER': '/bin/cat', 20:08:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:45 INFO - 'PWD': '/builds/slave/test', 20:08:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:45 INFO - 'SHELL': '/bin/bash', 20:08:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9uoGquWrju/Listeners', 20:08:45 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 20:08:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:45 INFO - 'USER': 'cltbld', 20:08:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:45 INFO - 'XPC_FLAGS': '0x0', 20:08:45 INFO - 'XPC_SERVICE_NAME': '0', 20:08:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 20:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:45 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-sUxPwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:45 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)) 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:45 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-jVkIf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:45 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)) 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:45 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-CxUq0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:46 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)) 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:46 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-IoBqHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:46 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-5T53Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:46 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)) 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:46 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-6N286w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:46 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)) 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:46 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-iTbYsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:46 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-IFnoEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:46 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)) 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:46 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-KfSEUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:46 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)) 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:46 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-mdmCAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:46 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)) 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:46 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-AXeSbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:47 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)) 20:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:47 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-IV6awf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:47 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)) 20:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:47 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-5xyaSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:47 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)) 20:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:47 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-KIiGg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:47 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)) 20:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:47 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-tvGe62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:47 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)) 20:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:47 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-mL0xh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:47 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)) 20:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:47 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-U87xAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:47 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)) 20:08:47 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)) 20:08:47 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)) 20:08:47 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)) 20:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:08:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:08:47 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 20:08:47 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 20:08:47 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 20:08:47 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 20:08:47 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 20:08:47 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 20:08:50 INFO - Downloading blessings-1.5.1.tar.gz 20:08:50 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 20:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:08:50 INFO - Installing collected packages: blessings 20:08:50 INFO - Running setup.py install for blessings 20:08:50 INFO - Successfully installed blessings 20:08:50 INFO - Cleaning up... 20:08:50 INFO - Return code: 0 20:08:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:08:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:08:50 INFO - Reading from file tmpfile_stdout 20:08:50 INFO - Current package versions: 20:08:50 INFO - blessings == 1.5.1 20:08:50 INFO - blobuploader == 1.2.4 20:08:50 INFO - docopt == 0.6.1 20:08:50 INFO - manifestparser == 1.1 20:08:50 INFO - mozInstall == 1.12 20:08:50 INFO - mozcrash == 0.16 20:08:50 INFO - mozdebug == 0.1 20:08:50 INFO - mozdevice == 0.47 20:08:50 INFO - mozfile == 1.2 20:08:50 INFO - mozhttpd == 0.7 20:08:50 INFO - mozinfo == 0.9 20:08:50 INFO - mozleak == 0.1 20:08:50 INFO - mozlog == 3.0 20:08:50 INFO - moznetwork == 0.27 20:08:50 INFO - mozprocess == 0.22 20:08:50 INFO - mozprofile == 0.27 20:08:50 INFO - mozrunner == 6.11 20:08:50 INFO - mozscreenshot == 0.1 20:08:50 INFO - mozsystemmonitor == 0.0 20:08:50 INFO - moztest == 0.7 20:08:50 INFO - mozversion == 1.4 20:08:50 INFO - psutil == 3.1.1 20:08:50 INFO - requests == 1.2.3 20:08:50 INFO - wsgiref == 0.1.2 20:08:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x103c7ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ce9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f8e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c319f0>, '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 0x103990cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bfb990>, '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.1TD8bnSeCO/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.9uoGquWrju/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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 20:08:50 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 20:08:50 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 20:08:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1TD8bnSeCO/Render', 20:08:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:50 INFO - 'HOME': '/Users/cltbld', 20:08:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:50 INFO - 'LOGNAME': 'cltbld', 20:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:50 INFO - 'MOZ_NO_REMOTE': '1', 20:08:50 INFO - 'NO_EM_RESTART': '1', 20:08:50 INFO - 'PAGER': '/bin/cat', 20:08:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:50 INFO - 'PWD': '/builds/slave/test', 20:08:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:50 INFO - 'SHELL': '/bin/bash', 20:08:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9uoGquWrju/Listeners', 20:08:50 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 20:08:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:50 INFO - 'USER': 'cltbld', 20:08:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:50 INFO - 'XPC_FLAGS': '0x0', 20:08:50 INFO - 'XPC_SERVICE_NAME': '0', 20:08:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 20:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:51 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)) 20:08:51 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)) 20:08:51 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)) 20:08:51 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)) 20:08:51 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)) 20:08:51 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)) 20:08:51 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)) 20:08:51 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)) 20:08:51 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)) 20:08:51 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)) 20:08:51 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)) 20:08:51 INFO - Cleaning up... 20:08:51 INFO - Return code: 0 20:08:51 INFO - Running post-action listener: _resource_record_post_action 20:08:51 INFO - Running post-action listener: _start_resource_monitoring 20:08:51 INFO - Starting resource monitoring. 20:08:51 INFO - ##### 20:08:51 INFO - ##### Running install step. 20:08:51 INFO - ##### 20:08:51 INFO - Running pre-action listener: _resource_record_pre_action 20:08:51 INFO - Running main action method: install 20:08:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:08:51 INFO - Reading from file tmpfile_stdout 20:08:51 INFO - Detecting whether we're running mozinstall >=1.0... 20:08:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:08:51 INFO - Reading from file tmpfile_stdout 20:08:51 INFO - Output received: 20:08:51 INFO - Usage: mozinstall [options] installer 20:08:51 INFO - Options: 20:08:51 INFO - -h, --help show this help message and exit 20:08:51 INFO - -d DEST, --destination=DEST 20:08:51 INFO - Directory to install application into. [default: 20:08:51 INFO - "/builds/slave/test"] 20:08:51 INFO - --app=APP Application being installed. [default: firefox] 20:08:51 INFO - mkdir: /builds/slave/test/build/application 20:08:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:09:29 INFO - Reading from file tmpfile_stdout 20:09:29 INFO - Output received: 20:09:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:09:29 INFO - Running post-action listener: _resource_record_post_action 20:09:29 INFO - ##### 20:09:29 INFO - ##### Running run-tests step. 20:09:29 INFO - ##### 20:09:29 INFO - Running pre-action listener: _resource_record_pre_action 20:09:29 INFO - Running main action method: run_tests 20:09:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:09:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:09:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:09:29 INFO - 2015-11-16 20:09:29.201 screenresolution[2214:17194] starting screenresolution argv=screenresolution get 20:09:29 INFO - 2015-11-16 20:09:29.205 screenresolution[2214:17194] Display 0: 1600x1200x32@60 20:09:29 INFO - 2015-11-16 20:09:29.211 screenresolution[2215:17196] starting screenresolution argv=screenresolution list 20:09:29 INFO - Available Modes on Display 0 20:09:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:09:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:09:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:09:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:09:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:09:29 INFO - Intel HD Graphics 3000: 20:09:29 INFO - Chipset Model: Intel HD Graphics 3000 20:09:29 INFO - Type: GPU 20:09:29 INFO - Bus: Built-In 20:09:29 INFO - VRAM (Total): 512 MB 20:09:29 INFO - VRAM (Dynamic, Max): 10 20:09:29 INFO - Vendor: Intel (0x8086) 20:09:29 INFO - Device ID: 0x0116 20:09:29 INFO - Revision ID: 0x0009 20:09:29 INFO - Displays: 20:09:29 INFO - Display: 20:09:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:09:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:09:29 INFO - Display Serial Number: 1600x1200 60 20:09:29 INFO - Main Display: Yes 20:09:29 INFO - Mirror: Off 20:09:29 INFO - Online: Yes 20:09:29 INFO - Rotation: Supported 20:09:29 INFO - Return code: 0 20:09:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:09:29 INFO - Python 2.7.3 20:09:29 INFO - Return code: 0 20:09:29 INFO - grabbing minidump binary from tooltool 20:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:29 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 0x103c319f0>, '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 0x103990cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103bfb990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:09:29 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 20:09:29 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 20:09:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:09:29 INFO - Return code: 0 20:09:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:09:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:09:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:09:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:09:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:09:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Alder', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0016', '--webServer', 'localhost'] in /builds/slave/test/build 20:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Alder --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0016 --webServer localhost 20:09:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1TD8bnSeCO/Render', 20:09:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:29 INFO - 'HOME': '/Users/cltbld', 20:09:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:29 INFO - 'LOGNAME': 'cltbld', 20:09:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:09:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:29 INFO - 'MOZ_NO_REMOTE': '1', 20:09:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:09:29 INFO - 'NO_EM_RESTART': '1', 20:09:29 INFO - 'PAGER': '/bin/cat', 20:09:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:29 INFO - 'PWD': '/builds/slave/test', 20:09:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:09:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:29 INFO - 'SHELL': '/bin/bash', 20:09:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9uoGquWrju/Listeners', 20:09:29 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 20:09:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:29 INFO - 'USER': 'cltbld', 20:09:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:29 INFO - 'XPC_FLAGS': '0x0', 20:09:29 INFO - 'XPC_SERVICE_NAME': '0', 20:09:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 20:09:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Alder', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0016', '--webServer', 'localhost'] with output_timeout 3600 20:09:29 INFO - mozversion INFO | application_buildid: 20151116150236 20:09:29 INFO - mozversion INFO | application_changeset: 5cec55768069f26a9d88569102081aa48c041309 20:09:29 INFO - mozversion INFO | application_display_name: Nightly 20:09:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:09:29 INFO - mozversion INFO | application_name: Firefox 20:09:29 INFO - mozversion INFO | application_remotingname: firefox 20:09:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/projects/alder 20:09:29 INFO - mozversion INFO | application_vendor: Mozilla 20:09:29 INFO - mozversion INFO | application_version: 45.0a1 20:09:29 INFO - mozversion INFO | platform_buildid: 20151116150236 20:09:29 INFO - mozversion INFO | platform_changeset: 5cec55768069f26a9d88569102081aa48c041309 20:09:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/projects/alder 20:09:29 INFO - mozversion INFO | platform_version: 45.0a1 20:09:29 INFO - 2015-11-16 20:09:29,830 DEBUG : using testdate: 1447733369 20:09:29 INFO - 2015-11-16 20:09:29,830 DEBUG : actual date: 1447733369 20:09:29 INFO - 2015-11-16 20:09:29,839 INFO : starting webserver on 'localhost:50597' 20:09:29 INFO - 2015-11-16 20:09:29,840 INFO : Starting test suite t-yosemite-r5-0016 20:09:29 INFO - 2015-11-16 20:09:29,840 INFO : Starting test dromaeo_css 20:09:29 INFO - 2015-11-16 20:09:29,840 DEBUG : operating with platform_type : mac_ 20:09:29 INFO - 2015-11-16 20:09:29,841 INFO : Initialising browser for dromaeo_css test... 20:09:29 INFO - 2015-11-16 20:09:29,869 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmp5jmpU8/profile http://localhost:50597/getInfo.html 20:09:32 INFO - 2015-11-16 20:09:32,126 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:09:32 INFO - 2015-11-16 20:09:32,126 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:09:32 INFO - 2015-11-16 20:09:32,126 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 20:09:32 INFO - 2015-11-16 20:09:32,126 DEBUG : BROWSER_OUTPUT: __metrics 20:09:32 INFO - 2015-11-16 20:09:32,134 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:09:32 INFO - 2015-11-16 20:09:32,864 INFO : Browser initialized. 20:09:32 INFO - 2015-11-16 20:09:32,865 INFO : Running cycle 1/1 for dromaeo_css test... 20:09:32 INFO - 2015-11-16 20:09:32,865 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmp5jmpU8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:09:44 INFO - 2015-11-16 20:09:44,804 DEBUG : BROWSER_OUTPUT: RSS: Main: 222978048 20:09:44 INFO - 2015-11-16 20:09:44,804 DEBUG : BROWSER_OUTPUT: 20:10:35 INFO - 2015-11-16 20:10:35,809 DEBUG : BROWSER_OUTPUT: 1447733435804 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] 20:12:46 INFO - 2015-11-16 20:12:46,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50597/tests/dromaeo/cssquery-ext.html) 20:12:48 INFO - 2015-11-16 20:12:48,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 344600576 20:12:48 INFO - 2015-11-16 20:12:48,093 DEBUG : BROWSER_OUTPUT: 20:15:50 INFO - 2015-11-16 20:15:50,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/dromaeo/cssquery-ext.html (next: http://localhost:50597/tests/dromaeo/cssquery-jquery.html) 20:15:51 INFO - 2015-11-16 20:15:51,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 357076992 20:15:51 INFO - 2015-11-16 20:15:51,305 DEBUG : BROWSER_OUTPUT: 20:18:53 INFO - 2015-11-16 20:18:53,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50597/tests/dromaeo/cssquery-mootools.html) 20:18:54 INFO - 2015-11-16 20:18:54,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 324751360 20:18:54 INFO - 2015-11-16 20:18:54,194 DEBUG : BROWSER_OUTPUT: 20:21:56 INFO - 2015-11-16 20:21:56,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50597/tests/dromaeo/cssquery-prototype.html) 20:21:56 INFO - 2015-11-16 20:21:56,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 341626880 20:21:56 INFO - 2015-11-16 20:21:56,811 DEBUG : BROWSER_OUTPUT: 20:24:59 INFO - 2015-11-16 20:24:59,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50597/tests/dromaeo/cssquery-yui.html) 20:25:00 INFO - 2015-11-16 20:25:00,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 320888832 20:25:00 INFO - 2015-11-16 20:25:00,454 DEBUG : BROWSER_OUTPUT: 20:28:03 INFO - 2015-11-16 20:28:03,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/dromaeo/cssquery-yui.html (next: http://localhost:50597/tests/dromaeo/cssquery-dojo.html) 20:28:03 INFO - 2015-11-16 20:28:03,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 384937984 20:28:03 INFO - 2015-11-16 20:28:03,594 DEBUG : BROWSER_OUTPUT: 20:28:03 INFO - 2015-11-16 20:28:03,596 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:28:03 INFO - 2015-11-16 20:28:03,596 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:28:03 INFO - 2015-11-16 20:28:03,596 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:28:03 INFO - 2015-11-16 20:28:03,596 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:28:03 INFO - 2015-11-16 20:28:03,598 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3154.1483799374155;3163.003653849039;3182.777205595608;3241.0438920518445;3280.885169019084;5138.665986710861;5166.922496162551;5241.921371179431;5328.12086005809;5346.251524786533;5163.922541161885;5193.091209038413;5257.658252213603;5282.762275697593;5367.838964831051;4799.496052914446;4820.325154478376;4857.854264372057;4899.461059283476;4991.625628077891;4852.126617208901;4912.410510738699;4932.704037757746;4948.1093403187415;5060.39275286966;4362.47650281965;4660.347551342815;4744.4069491313585;4771.618270538349;4816.87957801056;4747.45404278509;4755.310479980418;4764.428268607755;4789.353437285957;4831.033793241366;4699.060187962421;4744.786484608201;4786.401699787527;4817.831375901862;4892.633052521075;4895.437024742165;5020.623453241022;5032.220005899091;5073.898522029539;5085.644004919657;5458.0721277382545;5492.066348720727;5497.945020549823;5514.972425137888;5532.197831314477;5534.75093620788;5549.445055494418;5611.887762244733;5614.410486898858;5693.060644993571;5101.489851014906;5145.3568303962;5194.506521880453;5215.426303106655;5260.316158899319;5651.406602306781;5668.093105103246;5712.200291959129;5734.913976290359;5781.392953739797;5442.809501667422;5445;5469.234307196995;5490.780368785284;5530.695811730313;5488.396276409591;5561.082421400423;5589.80435684749;5611.7474713637985;5696.060150075274;5448.182772584065;5570.220169176318;5576.749046292926;5592.524635406036;5592.748326325325;5501.477359650827;5508.504234618904;5539.14143307788;5549.667019978814;5561.916571251434;4139.379093136054;4209.305464598368;4267.615914567704;4278.122984788111;4412.867613971586;3921.235359105004;3921.8235179416993;3934.5868683788362;3936.724429289922;3971.1065010372436;5141.665791723526;5203.297554830126;5205.167173252262;5210.53105220532;5212.087884620177;5289.920651190235;5389.83830485086;5464.153056276284;5468.7265636718;5571.860703482445;5157.716325602128;5158.690478571298;5221.034108689904;5244.501772331622;5247.02929957959;4927.802887884444;4947.282644016669;4949.356583644103;4949.48030456804;5042.873928151752;5251.054810134213;5446.455354464681;5492.203630473559;5569.10894256917;5720.199172115824;5606.579506536945;5607.3551541571605;5644.238027866186;5662.377138514677;5697.601167918372;5602.887942241214;5646.802361917313;5670.829875103754;5687.090065589486;5716.456936591017;5477;5486.341639003345;5542.722863856871;5553.139263414178;5628.831135065954;5563.332400112013;5564.888702226014;5618.2415373924;5630.60585758993;5675.205471233948;5318.547923426552;5377.973110134424;5507.504324610804;5507.807226747044;5564.91652625219;5332.33345831771;5338.3060202173465;5441.918371224514;5446.782128714965;5460.290162278879;5298.682079075268;5335.039692855168;5367.919481207707;5394.703291319015;5451.264079349237;5457.103231611226;5461.208124821799;5466.562674986071;5474.671519708831;5532.889342213214;5233.869153271199;5288.101022826206;5330.893382132258;5348.893022139613;5358.758855851574 20:28:03 INFO - 2015-11-16 20:28:03,599 DEBUG : BROWSER_OUTPUT: |1;ext.html;539.9676019438834;540.4703390677137;546.4726538889971;546.4890327543746;560.8709996700757;30809.22976925578;31150.688493115063;35998.46002309967;36301.63698363015;36498;40940.59059409405;41215;41549.37675934856;41592.16815663685;41681.37477937833;8016.478928869634;8959.507227102524;9043.14090161437;9081.091890810932;9167.816643667156;8103;10886.4012479314;11054.723631909226;11085.83371249432;11152.386618735965;10684.572617095308;10778.730531736692;10807.783844323108;10885.564577416893;10908.945455272753;8198.303144232746;8448.619812108469;10751.62369317074;10806.29759065666;10974.286671366335;10484.842727359095;10531.73670658232;10625.73435664107;10659.520321585547;10697.625583104631;39970.20059598821;40213;40288.395674064916;40537.59462405368;40607.39088913669;3018.1850900257027;3098.101550550338;3429.416999110157;3479.6172421033666;3507.5440192774777;26898.865505672347;27133.151019142904;27519.31201719953;27727.445451090865;28035.29911752202;2276.226083131743;2360.799332056777;2421.418859473731;2450.215930902112;2460.90156393744;279764;282190.5890470555;282378;283147;283287;55792.442075579536;56365.71817140888;60308.39691603115;60400.39599604036;61020.38979610236;62985.37014629795;64786.35213647898;64852;64896;65164.34835651678;16350.672986540203;16451.25969331383;16536.586585335463;16698.332066717194;16720.498385048468;12577.119601627981;12592.622221333191;12686.238825670489;12803.935980320039;12840.871591283967;19603.705944410845;19811.504712382306;19843.30548430798;19865.801341986684;20078.397648070582;7501.699932002768;7750.573718445539;7803.882941755878;7804.726834560764;7857.528548287121;802.4583406200791;825.9669613215405;916.6562539047857;971.7327734872825;1108.152263518393;27290.181294561196;27673.72326276752;27696.723032769816;27873.442531149263;28061.43877122446;966.79213968997;1022.8874823769379;1030.160419258302;1042.8852826189113;1163.168334640719;9854.802903941882;10043.69868903934;10217.489125543692;10261;10267.94866025665;308288;312544;312679;313527;313800;54026.72986635042;54052.45947540474;54098.72950635222;54442.18336724952;54577.45422545803;1331.8202042724301;1340.7720687483152;1360.9860653812973;1363.3932899859467;1374.9381277842522;19159;19241.326553570558;19501.51246218799;19665.311714089938;19706.014699265266;46880.53119468898;47111;47268.7636561815;47333.52666473291;47388.52611473979;257524;260410;281235;287337;293528;28683.71316286894;28790.568141477477;28885.133445996653;29013.56479652849;29071.7092829069;39059.41410878782;39570.40644390394;39725;40546;40652.59347406607;32302.19244518906;33581.83209083939;34201.48697769585;35823.46264806082;35967.460488093224;34808.47787283243;34977.475337869444;35135.47296790499;35390.292194156485;35661.821690892415;35011.47482787709;35609.64390356063;35932.28135437329;36052.27895442129;36138;30081.398372032;31182;31224.21939451441;31239.375212496077;31240;22887.54224915459;22887.542249155256;23177.188798391977;23295.883520582287;23469.647955281027 20:28:03 INFO - 2015-11-16 20:28:03,603 DEBUG : BROWSER_OUTPUT: |2;jquery.html;327.72307400246785;332.0553026639212;332.22591362126246;335.6106915977464;341.3548393536216;13685.589432317047;14344.28278586069;16286.42997495088;16446.506604801845;17428.215730292137;13736.313184340794;14749.926250368733;16812.41156559521;17549.29802807886;17575.560610984732;5028.647994640386;5175.715335656538;5239.056969745444;5242.449542798008;5277.683338999653;3708.42519409492;5069.214271787879;5131.820386286481;5214.322138122039;5233.136532472156;3807.7524960877595;5435.347758269013;5645.379008309083;5651.802186923438;5661.433856614326;5491.86086488587;5557.888842223153;5564.360098588633;5671.8014869479575;5676.716164191774;4932.605391568702;4934.5312195341385;4978.203487442028;4992.126377883892;4992.650514463989;20656.896715516476;20773.16907323705;20810.583788324147;20855;21120.683189752013;1703.7529558214114;1712.8287171282896;1713.8200488948605;1964.1946801811332;1978.436145698469;8989.640414383482;9285.210757085588;9295.814083718355;9356.485393303366;9460.053994600554;1481.8962672612922;1484.7104814561164;1495.4915328788263;1535.4625880941692;1543.2592355669342;53851.461485385036;57078.143827842614;57710;57773.99999999958;58300;6338.746450141943;6352.428281454599;6382.776602818879;6426.839329016812;6464.870702585922;7323.523970941872;7337.376323012603;7408.814779630445;7409.851802964018;7514.248575142551;5288.550473209821;5292.311999440049;5293.973530132324;5348.438413966477;5547.667139971614;5417.674939503642;5428.972855135699;5472.7263636818;5577.386487486373;5596.048671725816;2874.6981566935588;2884.7259510346485;2898.6086878271585;2915.883364665432;2919.489089409345;1000.3297790480395;1003.603576587244;1018.9439580823126;1019.0421004256124;1063.505469956474;400.2235662814131;422.84566133361716;425.69350067951024;429.6090557592638;439.2291528367694;10838.67483975482;11123.332600044023;11171.944140279247;11279.887201127884;11295.209335346612;406.17343705559045;433.0948318015363;455.10571726557475;460.62919349922964;481.5641844131067;5985;6200.224971878515;6209.5032397408095;6229.504918819542;6258.186435763321;368719;380136;382531;385095;438185;73818.26181738114;74008.62995684987;74324;74521;76737.61631191809;471.1166562694947;477.5248627615475;486.8296096366314;491.11108892903957;491.87948952506866;10410.68767936963;10565.577376904837;10627.09669678086;10674.8932510677;10876.564937402416;33670.30637548941;33889;34025.149371265914;34051;34125.65874341324;44567.55432445634;45393;45655.08689826251;45955;46057.539424605326;6059.787907423395;6089.056196289582;6118.47992920589;6123.173371594956;6134.325224225242;11083.94458027737;11467.082633389142;11557.133215009077;11646.76706465849;11820.054395648156;9876.802463950824;9913.355631883904;10040.64857729976;10088.596456141966;10109.64616238428;9584.233261339215;9691.418514889128;9799.265055120752;9883.456409897524;10084.042016008761;8725.171108744658;9863.309568330147;9999.800003999733;10219.897801022193;10264.281500294908;5593.384727679871;5717.285339332583;5936.614120082181;6195.132681424694;6252.5935814171935;9811.313208075366;10069.093781559695;10192.592296308065;10212;10316.019978102067 20:28:03 INFO - 2015-11-16 20:28:03,603 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1478.2017710436364;1673.4895856763685;1760.155125539741;1764.7441121037446;1808.448423230914;7025.367716905477;7561.054868141482;7734.8453030939345;7775.961120194391;7817.3355264802485;7571.469997100206;7665.271799179083;7694.422918281138;7752.108507521622;7766.495177813452;2017.062066139245;2022.828059614927;2177.8911054447294;2180.324099529147;2216.1910902520544;2225.1766846266905;2240.7759224077545;2249.3701763506247;2256.4133325335365;2256.638937769957;2092.048118106258;2117.76704562498;2141.957160856782;2167.9566408671817;2176.847620666546;1964.3812199157219;2005.7292265544183;2180;2235.7093577834776;2238.3061251012236;2168.414528077426;2181.2692747929464;2213.3581261434165;2227.922022729213;2232.720909886264;7515.323620874147;7669.271419215222;7696.538207707499;7714.267144621252;7717.65270562826;4625.190591646482;4769;4778.04439112179;4855.927161092586;4870.391201099863;2764.060219525351;2790.065328115084;2826.1239015905135;2839.971600284012;2869.856507174633;871.0723079919865;875.8729984152262;876.0407353947418;880.8634661627458;905.8777065096193;10016.94991525045;10057.69826905194;10058.446785426799;10058.547365368502;10135.391876487434;4293.957060429419;4319.827206911751;4357.433533640607;4365.541618130114;4430.091831174666;8847.203751662253;8900.287976961827;8943.821123577492;8948.73153805387;8993.190612844875;4860.586850117709;4864.148773964542;4917.852464426073;4933.432655244621;4936.938558210002;4412.4705035395955;4445.82216711328;4449.555044495589;4458.71018383804;4500.482444518857;3521.4033901338967;3550.201204728967;3557.768745031565;3563.3051554947056;3584.7311451640708;1151.8502594662807;1181.5214837990627;1187.893089621938;1193.176708071428;1195.1693572966878;997.8054279415444;1220.5850010996126;1291.3026965438746;1296.714722760991;1297.3124244150615;6847.828804279933;7158.2483839197175;7167.4266058715175;7198.892016619755;7229.8554028919125;460.3761902621966;466.4915242385816;1169.9941500292443;1203.3742453924085;1220.7436438348047;5730.140478928194;5795.13073039039;5795.7971470999155;5830.970845145832;5835.153902684087;8407.327413806881;8432.072472028072;8485.406021578554;8541.273991710774;8866.911330886609;8919.420237684659;8947.3736838422;8954.910450895408;8966.372353935161;9013.369064165576;7070.36366726997;7098.432125429953;7203.495755297079;7269.527480713737;7273.89089163663;7101.396381307647;7136;7159.427245820218;7178.928210718035;7213.927860721536;8024.478408903403;8029.317508011651;8073.35413166957;8135.959320203361;8176.345892328718;8170.714025009096;8278.420510564203;8280.627371768165;8300;8307.003159620885;6690.83272918181;6805.829854253683;6858.828529286808;6868.381845633917;6874.037634731041;7355.374793142642;7391;7403.888941665771;7419.629018549159;7422.70309187648;6789.355011273921;6842.7605033823575;6920.757773477904;7004.7198112076985;7043;6123.08153776937;6323.715432805443;6695.0626912231355;6749.662516874235;6907.274736152833;6947.340002699735;6956.991236270611;6960.825979350354;7004.124484439445;7010.75462358815;6322.810315690536;6329.936700632935;6346.111544383883;6378;6380.074889141141;6387.425131738166;6415.166028416463;6457.483401327976;6462.321456247027;6470.191226096738 20:28:03 INFO - 2015-11-16 20:28:03,607 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.78053252989184;320.9486482162854;323.3323187617571;323.64884100750686;323.7846831856817;5859.296884373875;5973.88052238955;5978.58149929504;5978.581499295051;6001.369856165105;5779.884402311962;5876.853078673035;5881.117832325153;5892.528597712183;5912.083627037805;4258.446401967755;4404.427424434819;4435.689501734863;4517.435320584927;4555.407796986387;4466.57567531084;4473.351364052211;4494.8202071917085;4500.099980003996;4521.457425108992;4231.428757117796;4413.9117217655785;4455.1535208310315;4473.530279320673;4487.304467807478;4323.200207961521;4383.890402739925;4402.537733537996;4462.531434199394;4529.977350113261;3875.186210895687;3881.4177873319227;3890.0663840678317;3890.144168282973;3906.5507466641416;5623.240862483594;5676.233708449389;5682.318121825366;5688.800891968761;5724.713764311809;5055.747212639353;5067.113255180366;5070.239464080418;5117.2068329409;5119.385673719177;6049.183360246355;6089.634621922699;6092.360302168253;6100.389961003909;6110.419510146573;4120.938185927213;4122.958770412288;4145.108801607669;4145.709800313979;4170.9582904170875;6276.937230627681;6346.936530634727;6361.300256971729;6397.424231819158;6413.262474815409;4041.6766658667234;4180.268453020709;4207.642350400189;4219.78901054946;4232.534421213664;4361.323994780814;4362.1493808707;4371.912561748747;4384.978075109604;4388.166248412791;5053.797848086036;5059.089363914531;5065.164247899129;5075.56857667095;5098.031374038921;6216.222972128484;6253;6269.811905642838;6272.843178920563;6287.2140982377205;1504.3982407037272;1536.9769453458207;1539.853713897178;1545.9845401546065;1556.5486009057247;986.6793292180071;994;1007.773251018515;1011.8279892418307;1020.0666390252835;5843.5909486336395;5869.706514674334;5895.616784908967;5898.764049437975;5934.584579079423;6355.713992870239;6390.297067322591;6411.51913606472;6427.710753016126;6472.385123413268;5892.1161825726485;5920.79277225295;5936.1392598073035;5944.197533332945;5951;3102.1779228504465;3358.6809253120914;3434.6050204226335;3536.734744894143;3571.8392672329287;6451.677416129175;6461.160049193575;6526.869462610816;6571.769988050491;6573.638449885207;6546.18172728409;6549.083128362033;6558.278589355167;6562.310957349505;6588.308227636125;6456.128422662974;6538.084668146464;6546.967265163644;6576.0464732612545;6585.407313341726;6423.839404014937;6448.419642232222;6450.290468048604;6461.8061458156335;6483.708233129615;6146.8321019008035;6188.752449901954;6239.06414037898;6256.249250090018;6306.716197771019;6471.902921456088;6477.935220647922;6482.157319548429;6516.609003459807;6528.445082168069;4086.530049044398;4150.52268989058;4232.661387088964;4248.426462427533;4263.701540892108;6271.153394291712;6327.841803954938;6357.841053973688;6417.0695249187675;6428.035794630843;6188.0717892314715;6216.7824126155365;6229.813105606839;6244.968775156277;6284;6000.21997140369;6159.476444502267;6234.750609975732;6243.875122497616;6252.812415627538;6093.329733729375;6099.054646529795;6112.144299797943;6135.049067394561;6238.376162383907;6285.717142728679;6315.778947736807;6328.841778955563;6352.047192921099;6364.07720880479;6010.759569617167;6097.908531371944;6108.969455152695;6180.289266734383;6204.3795620437595 20:28:03 INFO - 2015-11-16 20:28:03,608 DEBUG : BROWSER_OUTPUT: |5;yui.html;680.1635583923405;719.8416348403352;756.8524137793131;757.7650928212252;776.119104816034;12585.559505417312;13024;13213.999999999987;13276.137051091684;13353.799693004612;11667.591634292801;12365.938170309137;12394.566190183345;12462.252264864115;12555.309457979807;655.7672026430608;822.8560001999656;832.7418500264907;847.0936098374741;857.6440777077505;850.783050322167;854.3208149521115;862.0173002776808;862.8576284912982;865.0484467086186;690.4545409126808;717.8707832590158;899.8470260055774;918.1323649151554;918.4397517514311;868.8870446841902;902.1700035966926;902.309733054214;902.7607683963755;903.0788595632483;659.446065305146;665.1785045468843;665.7004348043351;666.516775337881;671.4225765841372;13109.672258193526;13115.47538098475;13118.672033199151;13144.737105257842;13262;10944.507497162647;11076.169287303484;11299.49152288149;11358.43207839613;11493.367864767435;9025.864612030824;9149.54252287383;9156.404833685856;9351.906480935171;9368.85946710793;3183.363327334519;3244.23760416302;3282.458394364927;3284.4744840825592;3424.8630054797777;43961.34057989133;44275;44275.33586996198;44336.55663443357;44357.778211109064;8386.161383861565;8608.139186081342;8618.827623447496;8628.654853805903;8752.168543988439;17925;18039.909800450914;18125.637487250446;18182.818171818377;18236.36172733948;6186.1648677427975;6234.750609975641;6260.655663938527;6287.968560157261;6527.281998980204;3744.64425879541;3833.1375440526217;3854.5759966403675;3854.9807250963568;3866.8066596670055;2711.986440067787;2715.4433341165013;2731.399092199713;2739.2877851758685;2745.5881617757095;388.8075402675694;390.6581740976645;396.95633480317144;397.4554859842035;403.3969216022066;510.8646208754683;561.6489693941287;580.8141394753638;587.8595524682103;593.3680630128899;7715.112762032438;7753.147153813076;7909.406794490321;7918.089419716691;8045.235702608243;489.889774800667;565.2058857305492;575.2320651929721;584.7836300568816;592.2301008688773;3908.6677632401565;3960.960390396117;3970.285348637215;3991.2815693174925;4132.752034877917;58053.419465805644;59561;60009.399906000384;60132.699336503036;60738.696306519065;49450;51182;52358.47641523536;52380.214296785576;52667.47332526703;47670.761646192244;48040.519594803605;48607;49137.262941055196;49386.753066234436;7956.9602151988865;7960.761177164694;8186.713465028695;8358.87461688063;8409.327253819802;32918.177045574055;33171.33657326888;34111.829440852634;35624;36149.27701446009;42613.36079958865;42671.57328426676;42724.5727542733;44666;45296.773516132205;10171.7457063574;10365.9481702591;10632.043116119587;10741.140708743438;10886.727831803952;10848.233700406347;10851.511681974487;11327.207095503565;11466.484008219817;11668.941655292008;10206.6427675034;10279;10301.690949271533;10321.793564128826;11204.719882003015;10521.73695657584;10541.20940929418;10663.093637040938;10699.679009629723;11050.171237157085;7030.790889988884;9367.250619950251;10012.649557265751;10092.84860727075;10179.38923664553;8784.868226976729;8785.121487851164;8959.283257339528;9047.054883200144;9211;7558.546487210785;8789.296856251356;8853.29173666118;8999.697464154555;9041.32190085733 20:28:03 INFO - 2015-11-16 20:28:03,608 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:28:03 INFO - 2015-11-16 20:28:03,609 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:28:03 INFO - 2015-11-16 20:28:03,609 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1018 20:28:03 INFO - 2015-11-16 20:28:03,609 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:28:03 INFO - 2015-11-16 20:28:03,609 DEBUG : BROWSER_OUTPUT: __startTimestamp1447734483594__endTimestamp 20:28:03 INFO - 2015-11-16 20:28:03,609 DEBUG : BROWSER_OUTPUT: 20:28:03 INFO - 2015-11-16 20:28:03,609 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:28:03 INFO - 2015-11-16 20:28:03,609 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:28:03 INFO - 2015-11-16 20:28:03,610 DEBUG : BROWSER_OUTPUT: 20:28:03 INFO - 2015-11-16 20:28:03,610 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5178.55 Median:5338.31 stddev:538.85 (10.1%) stddev-sans-first:516.58 20:28:03 INFO - 2015-11-16 20:28:03,610 DEBUG : BROWSER_OUTPUT: Values: 3154.1 3163.0 3182.8 3241.0 3280.9 5138.7 5166.9 5241.9 5328.1 5346.3 5163.9 5193.1 5257.7 5282.8 5367.8 4799.5 4820.3 4857.9 4899.5 4991.6 4852.1 4912.4 4932.7 4948.1 5060.4 4362.5 4660.3 4744.4 4771.6 4816.9 4747.5 4755.3 4764.4 4789.4 4831.0 4699.1 4744.8 4786.4 4817.8 4892.6 4895.4 5020.6 5032.2 5073.9 5085.6 5458.1 5492.1 5497.9 5515.0 5532.2 5534.8 5549.4 5611.9 5614.4 5693.1 5101.5 5145.4 5194.5 5215.4 5260.3 5651.4 5668.1 5712.2 5734.9 5781.4 5442.8 5445.0 5469.2 5490.8 5530.7 5488.4 5561.1 5589.8 5611.7 5696.1 5448.2 5570.2 5576.7 5592.5 5592.7 5501.5 5508.5 5539.1 5549.7 5561.9 4139.4 4209.3 4267.6 4278.1 4412.9 3921.2 3921.8 3934.6 3936.7 3971.1 5141.7 5203.3 5205.2 5210.5 5212.1 5289.9 5389.8 5464.2 5468.7 5571.9 5157.7 5158.7 5221.0 5244.5 5247.0 4927.8 4947.3 4949.4 4949.5 5042.9 5251.1 5446.5 5492.2 5569.1 5720.2 5606.6 5607.4 5644.2 5662.4 5697.6 5602.9 5646.8 5670.8 5687.1 5716.5 5477.0 5486.3 5542.7 5553.1 5628.8 5563.3 5564.9 5618.2 5630.6 5675.2 5318.5 5378.0 5507.5 5507.8 5564.9 5332.3 5338.3 5441.9 5446.8 5460.3 5298.7 5335.0 5367.9 5394.7 5451.3 5457.1 5461.2 5466.6 5474.7 5532.9 5233.9 5288.1 5330.9 5348.9 5358.8 20:28:03 INFO - 2015-11-16 20:28:03,610 DEBUG : BROWSER_OUTPUT: 20:28:03 INFO - 2015-11-16 20:28:03,610 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45581.56 Median:17124.40 stddev:76044.04 (444.1%) stddev-sans-first:76182.16 20:28:03 INFO - 2015-11-16 20:28:03,611 DEBUG : BROWSER_OUTPUT: Values: 540.0 540.5 546.5 546.5 560.9 30809.2 31150.7 35998.5 36301.6 36498.0 40940.6 41215.0 41549.4 41592.2 41681.4 8016.5 8959.5 9043.1 9081.1 9167.8 8103.0 10886.4 11054.7 11085.8 11152.4 10684.6 10778.7 10807.8 10885.6 10908.9 8198.3 8448.6 10751.6 10806.3 10974.3 10484.8 10531.7 10625.7 10659.5 10697.6 39970.2 40213.0 40288.4 40537.6 40607.4 3018.2 3098.1 3429.4 3479.6 3507.5 26898.9 27133.2 27519.3 27727.4 28035.3 2276.2 2360.8 2421.4 2450.2 2460.9 279764.0 282190.6 282378.0 283147.0 283287.0 55792.4 56365.7 60308.4 60400.4 61020.4 62985.4 64786.4 64852.0 64896.0 65164.3 16350.7 16451.3 16536.6 16698.3 16720.5 12577.1 12592.6 12686.2 12803.9 12840.9 19603.7 19811.5 19843.3 19865.8 20078.4 7501.7 7750.6 7803.9 7804.7 7857.5 802.5 826.0 916.7 971.7 1108.2 27290.2 27673.7 27696.7 27873.4 28061.4 966.8 1022.9 1030.2 1042.9 1163.2 9854.8 10043.7 10217.5 10261.0 10267.9 308288.0 312544.0 312679.0 313527.0 313800.0 54026.7 54052.5 54098.7 54442.2 54577.5 1331.8 1340.8 1361.0 1363.4 1374.9 19159.0 19241.3 19501.5 19665.3 19706.0 46880.5 47111.0 47268.8 47333.5 47388.5 257524.0 260410.0 281235.0 287337.0 293528.0 28683.7 28790.6 28885.1 29013.6 29071.7 39059.4 39570.4 39725.0 40546.0 40652.6 32302.2 33581.8 34201.5 35823.5 35967.5 34808.5 34977.5 35135.5 35390.3 35661.8 35011.5 35609.6 35932.3 36052.3 36138.0 30081.4 31182.0 31224.2 31239.4 31240.0 22887.5 22887.5 23177.2 23295.9 23469.6 20:28:03 INFO - 2015-11-16 20:28:03,612 DEBUG : BROWSER_OUTPUT: 20:28:03 INFO - 2015-11-16 20:28:03,612 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22627.08 Median:23264.33 stddev:64566.78 (277.5%) stddev-sans-first:64726.20 20:28:03 INFO - 2015-11-16 20:28:03,613 DEBUG : BROWSER_OUTPUT: Values: 327.7 332.1 332.2 335.6 341.4 13685.6 14344.3 16286.4 16446.5 17428.2 13736.3 14749.9 16812.4 17549.3 17575.6 5028.6 5175.7 5239.1 5242.4 5277.7 3708.4 5069.2 5131.8 5214.3 5233.1 3807.8 5435.3 5645.4 5651.8 5661.4 5491.9 5557.9 5564.4 5671.8 5676.7 4932.6 4934.5 4978.2 4992.1 4992.7 20656.9 20773.2 20810.6 20855.0 21120.7 1703.8 1712.8 1713.8 1964.2 1978.4 8989.6 9285.2 9295.8 9356.5 9460.1 1481.9 1484.7 1495.5 1535.5 1543.3 53851.5 57078.1 57710.0 57774.0 58300.0 6338.7 6352.4 6382.8 6426.8 6464.9 7323.5 7337.4 7408.8 7409.9 7514.2 5288.6 5292.3 5294.0 5348.4 5547.7 5417.7 5429.0 5472.7 5577.4 5596.0 2874.7 2884.7 2898.6 2915.9 2919.5 1000.3 1003.6 1018.9 1019.0 1063.5 400.2 422.8 425.7 429.6 439.2 10838.7 11123.3 11171.9 11279.9 11295.2 406.2 433.1 455.1 460.6 481.6 5985.0 6200.2 6209.5 6229.5 6258.2 368719.0 380136.0 382531.0 385095.0 438185.0 73818.3 74008.6 74324.0 74521.0 76737.6 471.1 477.5 486.8 491.1 491.9 10410.7 10565.6 10627.1 10674.9 10876.6 33670.3 33889.0 34025.1 34051.0 34125.7 44567.6 45393.0 45655.1 45955.0 46057.5 6059.8 6089.1 6118.5 6123.2 6134.3 11083.9 11467.1 11557.1 11646.8 11820.1 9876.8 9913.4 10040.6 10088.6 10109.6 9584.2 9691.4 9799.3 9883.5 10084.0 8725.2 9863.3 9999.8 10219.9 10264.3 5593.4 5717.3 5936.6 6195.1 6252.6 9811.3 10069.1 10192.6 10212.0 10316.0 20:28:03 INFO - 2015-11-16 20:28:03,613 DEBUG : BROWSER_OUTPUT: 20:28:03 INFO - 2015-11-16 20:28:03,613 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5336.06 Median:6383.75 stddev:2724.46 (42.7%) stddev-sans-first:2716.67 20:28:03 INFO - 2015-11-16 20:28:03,615 DEBUG : BROWSER_OUTPUT: Values: 1478.2 1673.5 1760.2 1764.7 1808.4 7025.4 7561.1 7734.8 7776.0 7817.3 7571.5 7665.3 7694.4 7752.1 7766.5 2017.1 2022.8 2177.9 2180.3 2216.2 2225.2 2240.8 2249.4 2256.4 2256.6 2092.0 2117.8 2142.0 2168.0 2176.8 1964.4 2005.7 2180.0 2235.7 2238.3 2168.4 2181.3 2213.4 2227.9 2232.7 7515.3 7669.3 7696.5 7714.3 7717.7 4625.2 4769.0 4778.0 4855.9 4870.4 2764.1 2790.1 2826.1 2840.0 2869.9 871.1 875.9 876.0 880.9 905.9 10016.9 10057.7 10058.4 10058.5 10135.4 4294.0 4319.8 4357.4 4365.5 4430.1 8847.2 8900.3 8943.8 8948.7 8993.2 4860.6 4864.1 4917.9 4933.4 4936.9 4412.5 4445.8 4449.6 4458.7 4500.5 3521.4 3550.2 3557.8 3563.3 3584.7 1151.9 1181.5 1187.9 1193.2 1195.2 997.8 1220.6 1291.3 1296.7 1297.3 6847.8 7158.2 7167.4 7198.9 7229.9 460.4 466.5 1170.0 1203.4 1220.7 5730.1 5795.1 5795.8 5831.0 5835.2 8407.3 8432.1 8485.4 8541.3 8866.9 8919.4 8947.4 8954.9 8966.4 9013.4 7070.4 7098.4 7203.5 7269.5 7273.9 7101.4 7136.0 7159.4 7178.9 7213.9 8024.5 8029.3 8073.4 8136.0 8176.3 8170.7 8278.4 8280.6 8300.0 8307.0 6690.8 6805.8 6858.8 6868.4 6874.0 7355.4 7391.0 7403.9 7419.6 7422.7 6789.4 6842.8 6920.8 7004.7 7043.0 6123.1 6323.7 6695.1 6749.7 6907.3 6947.3 6957.0 6960.8 7004.1 7010.8 6322.8 6329.9 6346.1 6378.0 6380.1 6387.4 6415.2 6457.5 6462.3 6470.2 20:28:03 INFO - 2015-11-16 20:28:03,615 DEBUG : BROWSER_OUTPUT: 20:28:03 INFO - 2015-11-16 20:28:03,615 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5154.10 Median:5935.36 stddev:1577.21 (26.6%) stddev-sans-first:1539.26 20:28:03 INFO - 2015-11-16 20:28:03,616 DEBUG : BROWSER_OUTPUT: Values: 315.8 320.9 323.3 323.6 323.8 5859.3 5973.9 5978.6 5978.6 6001.4 5779.9 5876.9 5881.1 5892.5 5912.1 4258.4 4404.4 4435.7 4517.4 4555.4 4466.6 4473.4 4494.8 4500.1 4521.5 4231.4 4413.9 4455.2 4473.5 4487.3 4323.2 4383.9 4402.5 4462.5 4530.0 3875.2 3881.4 3890.1 3890.1 3906.6 5623.2 5676.2 5682.3 5688.8 5724.7 5055.7 5067.1 5070.2 5117.2 5119.4 6049.2 6089.6 6092.4 6100.4 6110.4 4120.9 4123.0 4145.1 4145.7 4171.0 6276.9 6346.9 6361.3 6397.4 6413.3 4041.7 4180.3 4207.6 4219.8 4232.5 4361.3 4362.1 4371.9 4385.0 4388.2 5053.8 5059.1 5065.2 5075.6 5098.0 6216.2 6253.0 6269.8 6272.8 6287.2 1504.4 1537.0 1539.9 1546.0 1556.5 986.7 994.0 1007.8 1011.8 1020.1 5843.6 5869.7 5895.6 5898.8 5934.6 6355.7 6390.3 6411.5 6427.7 6472.4 5892.1 5920.8 5936.1 5944.2 5951.0 3102.2 3358.7 3434.6 3536.7 3571.8 6451.7 6461.2 6526.9 6571.8 6573.6 6546.2 6549.1 6558.3 6562.3 6588.3 6456.1 6538.1 6547.0 6576.0 6585.4 6423.8 6448.4 6450.3 6461.8 6483.7 6146.8 6188.8 6239.1 6256.2 6306.7 6471.9 6477.9 6482.2 6516.6 6528.4 4086.5 4150.5 4232.7 4248.4 4263.7 6271.2 6327.8 6357.8 6417.1 6428.0 6188.1 6216.8 6229.8 6245.0 6284.0 6000.2 6159.5 6234.8 6243.9 6252.8 6093.3 6099.1 6112.1 6135.0 6238.4 6285.7 6315.8 6328.8 6352.0 6364.1 6010.8 6097.9 6109.0 6180.3 6204.4 20:28:03 INFO - 2015-11-16 20:28:03,616 DEBUG : BROWSER_OUTPUT: 20:28:03 INFO - 2015-11-16 20:28:03,616 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13337.96 Median:24548.44 stddev:16086.62 (65.5%) stddev-sans-first:16103.66 20:28:03 INFO - 2015-11-16 20:28:03,617 DEBUG : BROWSER_OUTPUT: Values: 680.2 719.8 756.9 757.8 776.1 12585.6 13024.0 13214.0 13276.1 13353.8 11667.6 12365.9 12394.6 12462.3 12555.3 655.8 822.9 832.7 847.1 857.6 850.8 854.3 862.0 862.9 865.0 690.5 717.9 899.8 918.1 918.4 868.9 902.2 902.3 902.8 903.1 659.4 665.2 665.7 666.5 671.4 13109.7 13115.5 13118.7 13144.7 13262.0 10944.5 11076.2 11299.5 11358.4 11493.4 9025.9 9149.5 9156.4 9351.9 9368.9 3183.4 3244.2 3282.5 3284.5 3424.9 43961.3 44275.0 44275.3 44336.6 44357.8 8386.2 8608.1 8618.8 8628.7 8752.2 17925.0 18039.9 18125.6 18182.8 18236.4 6186.2 6234.8 6260.7 6288.0 6527.3 3744.6 3833.1 3854.6 3855.0 3866.8 2712.0 2715.4 2731.4 2739.3 2745.6 388.8 390.7 397.0 397.5 403.4 510.9 561.6 580.8 587.9 593.4 7715.1 7753.1 7909.4 7918.1 8045.2 489.9 565.2 575.2 584.8 592.2 3908.7 3961.0 3970.3 3991.3 4132.8 58053.4 59561.0 60009.4 60132.7 60738.7 49450.0 51182.0 52358.5 52380.2 52667.5 47670.8 48040.5 48607.0 49137.3 49386.8 7957.0 7960.8 8186.7 8358.9 8409.3 32918.2 33171.3 34111.8 35624.0 36149.3 42613.4 42671.6 42724.6 44666.0 45296.8 10171.7 10365.9 10632.0 10741.1 10886.7 10848.2 10851.5 11327.2 11466.5 11668.9 10206.6 10279.0 10301.7 10321.8 11204.7 10521.7 10541.2 10663.1 10699.7 11050.2 7030.8 9367.3 10012.6 10092.8 10179.4 8784.9 8785.1 8959.3 9047.1 9211.0 7558.5 8789.3 8853.3 8999.7 9041.3 20:28:03 INFO - 2015-11-16 20:28:03,617 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:28:03 INFO - 2015-11-16 20:28:03,617 DEBUG : BROWSER_OUTPUT: 20:28:04 INFO - 2015-11-16 20:28:04,266 INFO : Browser exited with error code: 0 20:28:04 INFO - 2015-11-16 20:28:04,294 INFO : Completed test dromaeo_css (00:18:34) 20:28:04 INFO - 2015-11-16 20:28:04,294 INFO : Starting test kraken 20:28:04 INFO - 2015-11-16 20:28:04,294 DEBUG : operating with platform_type : mac_ 20:28:04 INFO - 2015-11-16 20:28:04,294 INFO : Initialising browser for kraken test... 20:28:04 INFO - 2015-11-16 20:28:04,307 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmpUeRqfm/profile http://localhost:50597/getInfo.html 20:28:06 INFO - 2015-11-16 20:28:06,538 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:28:06 INFO - 2015-11-16 20:28:06,538 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:28:06 INFO - 2015-11-16 20:28:06,538 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 20:28:06 INFO - 2015-11-16 20:28:06,538 DEBUG : BROWSER_OUTPUT: __metrics 20:28:06 INFO - 2015-11-16 20:28:06,555 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:28:06 INFO - 2015-11-16 20:28:06,838 DEBUG : BROWSER_OUTPUT: console.error: 20:28:06 INFO - 2015-11-16 20:28:06,838 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 20:28:06 INFO - 2015-11-16 20:28:06,838 DEBUG : BROWSER_OUTPUT: Stack: 20:28:06 INFO - 2015-11-16 20:28:06,839 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 20:28:06 INFO - 2015-11-16 20:28:06,839 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 20:28:06 INFO - 2015-11-16 20:28:06,839 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 20:28:06 INFO - 2015-11-16 20:28:06,839 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 20:28:06 INFO - 2015-11-16 20:28:06,839 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 20:28:06 INFO - 2015-11-16 20:28:06,839 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 20:28:06 INFO - 2015-11-16 20:28:06,839 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 20:28:06 INFO - 2015-11-16 20:28:06,839 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 20:28:06 INFO - 2015-11-16 20:28:06,840 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 20:28:06 INFO - 2015-11-16 20:28:06,840 DEBUG : BROWSER_OUTPUT: 20:28:07 INFO - 2015-11-16 20:28:07,270 INFO : Browser initialized. 20:28:07 INFO - 2015-11-16 20:28:07,271 INFO : Running cycle 1/1 for kraken test... 20:28:07 INFO - 2015-11-16 20:28:07,271 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmpUeRqfm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:28:19 INFO - 2015-11-16 20:28:19,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 220921856 20:28:19 INFO - 2015-11-16 20:28:19,178 DEBUG : BROWSER_OUTPUT: 20:28:21 INFO - 2015-11-16 20:28:21,687 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50597/tests/kraken/driver.html?testName=audio-beat-detection) 20:28:22 INFO - 2015-11-16 20:28:22,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 278913024 20:28:22 INFO - 2015-11-16 20:28:22,278 DEBUG : BROWSER_OUTPUT: 20:28:24 INFO - 2015-11-16 20:28:24,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50597/tests/kraken/driver.html?testName=audio-dft) 20:28:25 INFO - 2015-11-16 20:28:25,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 292229120 20:28:25 INFO - 2015-11-16 20:28:25,498 DEBUG : BROWSER_OUTPUT: 20:28:28 INFO - 2015-11-16 20:28:28,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50597/tests/kraken/driver.html?testName=audio-fft) 20:28:29 INFO - 2015-11-16 20:28:29,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 272613376 20:28:29 INFO - 2015-11-16 20:28:29,055 DEBUG : BROWSER_OUTPUT: 20:28:31 INFO - 2015-11-16 20:28:31,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50597/tests/kraken/driver.html?testName=audio-oscillator) 20:28:31 INFO - 2015-11-16 20:28:31,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 276520960 20:28:31 INFO - 2015-11-16 20:28:31,631 DEBUG : BROWSER_OUTPUT: 20:28:33 INFO - 2015-11-16 20:28:33,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50597/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:28:34 INFO - 2015-11-16 20:28:34,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 275791872 20:28:34 INFO - 2015-11-16 20:28:34,389 DEBUG : BROWSER_OUTPUT: 20:28:37 INFO - 2015-11-16 20:28:37,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50597/tests/kraken/driver.html?testName=imaging-darkroom) 20:28:38 INFO - 2015-11-16 20:28:38,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 277544960 20:28:38 INFO - 2015-11-16 20:28:38,025 DEBUG : BROWSER_OUTPUT: 20:28:41 INFO - 2015-11-16 20:28:41,156 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50597/tests/kraken/driver.html?testName=imaging-desaturate) 20:28:41 INFO - 2015-11-16 20:28:41,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 276717568 20:28:41 INFO - 2015-11-16 20:28:41,739 DEBUG : BROWSER_OUTPUT: 20:28:44 INFO - 2015-11-16 20:28:44,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50597/tests/kraken/driver.html?testName=json-parse-financial) 20:28:45 INFO - 2015-11-16 20:28:45,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 276516864 20:28:45 INFO - 2015-11-16 20:28:45,215 DEBUG : BROWSER_OUTPUT: 20:28:46 INFO - 2015-11-16 20:28:46,774 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50597/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:28:47 INFO - 2015-11-16 20:28:47,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 312139776 20:28:47 INFO - 2015-11-16 20:28:47,335 DEBUG : BROWSER_OUTPUT: 20:28:49 INFO - 2015-11-16 20:28:49,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50597/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:28:49 INFO - 2015-11-16 20:28:49,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 312729600 20:28:49 INFO - 2015-11-16 20:28:49,770 DEBUG : BROWSER_OUTPUT: 20:28:51 INFO - 2015-11-16 20:28:51,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50597/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:28:52 INFO - 2015-11-16 20:28:52,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 321150976 20:28:52 INFO - 2015-11-16 20:28:52,436 DEBUG : BROWSER_OUTPUT: 20:28:54 INFO - 2015-11-16 20:28:54,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:28:55 INFO - 2015-11-16 20:28:55,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 321183744 20:28:55 INFO - 2015-11-16 20:28:55,558 DEBUG : BROWSER_OUTPUT: 20:28:58 INFO - 2015-11-16 20:28:58,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:28:58 INFO - 2015-11-16 20:28:58,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 322437120 20:28:58 INFO - 2015-11-16 20:28:58,723 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50597/tests/kraken/driver.html?testName=ai-astar) 20:29:00 INFO - 2015-11-16 20:29:00,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 380461056 20:29:00 INFO - 2015-11-16 20:29:00,700 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,700 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:29:00 INFO - 2015-11-16 20:29:00,700 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:29:00 INFO - 2015-11-16 20:29:00,701 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:29:00 INFO - 2015-11-16 20:29:00,701 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:29:00 INFO - 2015-11-16 20:29:00,701 DEBUG : BROWSER_OUTPUT: |0;ai-astar;106;103;108;107;107;106;111;106;107;106 20:29:00 INFO - 2015-11-16 20:29:00,701 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;130;150;164;128;149;146;125;165;125 20:29:00 INFO - 2015-11-16 20:29:00,701 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;161;163;164;162;163;164;163;160 20:29:00 INFO - 2015-11-16 20:29:00,702 DEBUG : BROWSER_OUTPUT: |3;audio-fft;76;80;83;84;67;69;70;78;84;68 20:29:00 INFO - 2015-11-16 20:29:00,702 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;101;98;135;88;89;94;123;89;88;125 20:29:00 INFO - 2015-11-16 20:29:00,702 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;121;121;122;115;118;121;115;118;120;119 20:29:00 INFO - 2015-11-16 20:29:00,702 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;125;125;125;124;125;125;125;125;125 20:29:00 INFO - 2015-11-16 20:29:00,702 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;100;101;100;100;103;106;101;100;101;100 20:29:00 INFO - 2015-11-16 20:29:00,702 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;56;56;56;56;56;56;65;55;56 20:29:00 INFO - 2015-11-16 20:29:00,702 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;66;66;68;68;67;68;68;68;67 20:29:00 INFO - 2015-11-16 20:29:00,703 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;84;90;84;85;84;84;85;88;85 20:29:00 INFO - 2015-11-16 20:29:00,703 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;134;119;125;123;123;124;123;122;124 20:29:00 INFO - 2015-11-16 20:29:00,703 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;151;148;147;152;136;150;147;147;148 20:29:00 INFO - 2015-11-16 20:29:00,703 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;70;69;68;71;69;70;68;69 20:29:00 INFO - 2015-11-16 20:29:00,703 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:29:00 INFO - 2015-11-16 20:29:00,704 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:29:00 INFO - 2015-11-16 20:29:00,704 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,922 20:29:00 INFO - 2015-11-16 20:29:00,704 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:29:00 INFO - 2015-11-16 20:29:00,704 DEBUG : BROWSER_OUTPUT: __startTimestamp1447734540695__endTimestamp 20:29:00 INFO - 2015-11-16 20:29:00,704 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,704 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:29:00 INFO - 2015-11-16 20:29:00,705 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:29:00 INFO - 2015-11-16 20:29:00,705 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,705 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.70 Median:107.00 stddev:2.00 (1.9%) stddev-sans-first:2.11 20:29:00 INFO - 2015-11-16 20:29:00,705 DEBUG : BROWSER_OUTPUT: Values: 106.0 103.0 108.0 107.0 107.0 106.0 111.0 106.0 107.0 106.0 20:29:00 INFO - 2015-11-16 20:29:00,705 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,705 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.80 Median:149.50 stddev:15.72 (10.5%) stddev-sans-first:16.04 20:29:00 INFO - 2015-11-16 20:29:00,706 DEBUG : BROWSER_OUTPUT: Values: 156.0 130.0 150.0 164.0 128.0 149.0 146.0 125.0 165.0 125.0 20:29:00 INFO - 2015-11-16 20:29:00,706 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,706 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 20:29:00 INFO - 2015-11-16 20:29:00,706 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 161.0 163.0 164.0 162.0 163.0 164.0 163.0 160.0 20:29:00 INFO - 2015-11-16 20:29:00,706 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,707 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:75.90 Median:79.00 stddev:6.89 (8.7%) stddev-sans-first:7.30 20:29:00 INFO - 2015-11-16 20:29:00,707 DEBUG : BROWSER_OUTPUT: Values: 76.0 80.0 83.0 84.0 67.0 69.0 70.0 78.0 84.0 68.0 20:29:00 INFO - 2015-11-16 20:29:00,707 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,707 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.00 Median:88.50 stddev:17.83 (20.1%) stddev-sans-first:18.89 20:29:00 INFO - 2015-11-16 20:29:00,707 DEBUG : BROWSER_OUTPUT: Values: 101.0 98.0 135.0 88.0 89.0 94.0 123.0 89.0 88.0 125.0 20:29:00 INFO - 2015-11-16 20:29:00,707 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,708 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:119.00 Median:120.50 stddev:2.49 (2.1%) stddev-sans-first:2.54 20:29:00 INFO - 2015-11-16 20:29:00,708 DEBUG : BROWSER_OUTPUT: Values: 121.0 121.0 122.0 115.0 118.0 121.0 115.0 118.0 120.0 119.0 20:29:00 INFO - 2015-11-16 20:29:00,708 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,708 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:124.90 Median:125.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:29:00 INFO - 2015-11-16 20:29:00,708 DEBUG : BROWSER_OUTPUT: Values: 125.0 125.0 125.0 125.0 124.0 125.0 125.0 125.0 125.0 125.0 20:29:00 INFO - 2015-11-16 20:29:00,708 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,709 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:101.20 Median:101.00 stddev:1.93 (1.9%) stddev-sans-first:2.00 20:29:00 INFO - 2015-11-16 20:29:00,709 DEBUG : BROWSER_OUTPUT: Values: 100.0 101.0 100.0 100.0 103.0 106.0 101.0 100.0 101.0 100.0 20:29:00 INFO - 2015-11-16 20:29:00,709 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,709 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.00 stddev:2.91 (5.2%) stddev-sans-first:3.06 20:29:00 INFO - 2015-11-16 20:29:00,709 DEBUG : BROWSER_OUTPUT: Values: 58.0 56.0 56.0 56.0 56.0 56.0 56.0 65.0 55.0 56.0 20:29:00 INFO - 2015-11-16 20:29:00,709 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,710 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 20:29:00 INFO - 2015-11-16 20:29:00,710 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 66.0 68.0 68.0 67.0 68.0 68.0 68.0 67.0 20:29:00 INFO - 2015-11-16 20:29:00,710 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,710 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:2.01 (2.4%) stddev-sans-first:2.13 20:29:00 INFO - 2015-11-16 20:29:00,711 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 90.0 84.0 85.0 84.0 84.0 85.0 88.0 85.0 20:29:00 INFO - 2015-11-16 20:29:00,711 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,711 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.00 stddev:3.84 (3.1%) stddev-sans-first:4.08 20:29:00 INFO - 2015-11-16 20:29:00,711 DEBUG : BROWSER_OUTPUT: Values: 124.0 134.0 119.0 125.0 123.0 123.0 124.0 123.0 122.0 124.0 20:29:00 INFO - 2015-11-16 20:29:00,712 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,712 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:148.00 stddev:5.46 (3.7%) stddev-sans-first:4.64 20:29:00 INFO - 2015-11-16 20:29:00,712 DEBUG : BROWSER_OUTPUT: Values: 137.0 151.0 148.0 147.0 152.0 136.0 150.0 147.0 147.0 148.0 20:29:00 INFO - 2015-11-16 20:29:00,712 DEBUG : BROWSER_OUTPUT: 20:29:00 INFO - 2015-11-16 20:29:00,712 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.97 20:29:00 INFO - 2015-11-16 20:29:00,713 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 70.0 69.0 68.0 71.0 69.0 70.0 68.0 69.0 20:29:00 INFO - 2015-11-16 20:29:00,714 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:29:00 INFO - 2015-11-16 20:29:00,714 DEBUG : BROWSER_OUTPUT: 20:29:01 INFO - 2015-11-16 20:29:01,373 INFO : Browser exited with error code: 0 20:29:01 INFO - 2015-11-16 20:29:01,422 INFO : Completed test kraken (00:00:57) 20:29:01 INFO - 2015-11-16 20:29:01,422 INFO : Starting test v8_7 20:29:01 INFO - 2015-11-16 20:29:01,422 DEBUG : operating with platform_type : mac_ 20:29:01 INFO - 2015-11-16 20:29:01,423 INFO : Initialising browser for v8_7 test... 20:29:01 INFO - 2015-11-16 20:29:01,436 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmpErw8NV/profile http://localhost:50597/getInfo.html 20:29:03 INFO - 2015-11-16 20:29:03,553 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:29:03 INFO - 2015-11-16 20:29:03,554 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:29:03 INFO - 2015-11-16 20:29:03,554 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 20:29:03 INFO - 2015-11-16 20:29:03,554 DEBUG : BROWSER_OUTPUT: __metrics 20:29:03 INFO - 2015-11-16 20:29:03,564 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:29:04 INFO - 2015-11-16 20:29:04,259 INFO : Browser initialized. 20:29:04 INFO - 2015-11-16 20:29:04,259 INFO : Running cycle 1/1 for v8_7 test... 20:29:04 INFO - 2015-11-16 20:29:04,259 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmpErw8NV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:29:16 INFO - 2015-11-16 20:29:16,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 220901376 20:29:16 INFO - 2015-11-16 20:29:16,148 DEBUG : BROWSER_OUTPUT: 20:29:37 INFO - 2015-11-16 20:29:37,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50597/tests/v8_7/run.html (next: http://localhost:50597/tests/v8_7/run.html) 20:29:37 INFO - 2015-11-16 20:29:37,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 693796864 20:29:37 INFO - 2015-11-16 20:29:37,862 DEBUG : BROWSER_OUTPUT: 20:29:37 INFO - 2015-11-16 20:29:37,863 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:29:37 INFO - 2015-11-16 20:29:37,863 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:29:37 INFO - 2015-11-16 20:29:37,864 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:29:37 INFO - 2015-11-16 20:29:37,864 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:29:37 INFO - 2015-11-16 20:29:37,864 DEBUG : BROWSER_OUTPUT: |0;Richards;168.6056314280897 20:29:37 INFO - 2015-11-16 20:29:37,864 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;198.45207382417146 20:29:37 INFO - 2015-11-16 20:29:37,864 DEBUG : BROWSER_OUTPUT: |2;Encrypt;326.47730982696703 20:29:37 INFO - 2015-11-16 20:29:37,864 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5758.620689655172 20:29:37 INFO - 2015-11-16 20:29:37,865 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2047.034764826176 20:29:37 INFO - 2015-11-16 20:29:37,865 DEBUG : BROWSER_OUTPUT: |5;Earley;940.7337723424271 20:29:37 INFO - 2015-11-16 20:29:37,865 DEBUG : BROWSER_OUTPUT: |6;Boyer;13554.054054054053 20:29:37 INFO - 2015-11-16 20:29:37,865 DEBUG : BROWSER_OUTPUT: |7;RegExp;29764.70588235294 20:29:37 INFO - 2015-11-16 20:29:37,865 DEBUG : BROWSER_OUTPUT: |8;Splay;613.1207847946046 20:29:37 INFO - 2015-11-16 20:29:37,865 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5813.953488372093 20:29:37 INFO - 2015-11-16 20:29:37,866 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:29:37 INFO - 2015-11-16 20:29:37,866 DEBUG : BROWSER_OUTPUT: __startTimestamp1447734577862__endTimestamp 20:29:37 INFO - 2015-11-16 20:29:37,866 DEBUG : BROWSER_OUTPUT: 20:29:37 INFO - 2015-11-16 20:29:37,866 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:29:37 INFO - 2015-11-16 20:29:37,866 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:29:37 INFO - 2015-11-16 20:29:37,866 DEBUG : BROWSER_OUTPUT: 20:29:37 INFO - 2015-11-16 20:29:37,867 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.61 Median:168.61 stddev:0.00 (0.0%) 20:29:37 INFO - 2015-11-16 20:29:37,867 DEBUG : BROWSER_OUTPUT: Values: 168.6 20:29:37 INFO - 2015-11-16 20:29:37,867 DEBUG : BROWSER_OUTPUT: 20:29:37 INFO - 2015-11-16 20:29:37,867 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:198.45 Median:198.45 stddev:0.00 (0.0%) 20:29:37 INFO - 2015-11-16 20:29:37,867 DEBUG : BROWSER_OUTPUT: Values: 198.5 20:29:37 INFO - 2015-11-16 20:29:37,867 DEBUG : BROWSER_OUTPUT: 20:29:37 INFO - 2015-11-16 20:29:37,868 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:326.48 Median:326.48 stddev:0.00 (0.0%) 20:29:37 INFO - 2015-11-16 20:29:37,868 DEBUG : BROWSER_OUTPUT: Values: 326.5 20:29:37 INFO - 2015-11-16 20:29:37,868 DEBUG : BROWSER_OUTPUT: 20:29:37 INFO - 2015-11-16 20:29:37,868 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5758.62 Median:5758.62 stddev:0.00 (0.0%) 20:29:37 INFO - 2015-11-16 20:29:37,868 DEBUG : BROWSER_OUTPUT: Values: 5758.6 20:29:37 INFO - 2015-11-16 20:29:37,868 DEBUG : BROWSER_OUTPUT: 20:29:37 INFO - 2015-11-16 20:29:37,869 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2047.03 Median:2047.03 stddev:0.00 (0.0%) 20:29:37 INFO - 2015-11-16 20:29:37,869 DEBUG : BROWSER_OUTPUT: Values: 2047.0 20:29:37 INFO - 2015-11-16 20:29:37,869 DEBUG : BROWSER_OUTPUT: 20:29:37 INFO - 2015-11-16 20:29:37,869 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:940.73 Median:940.73 stddev:0.00 (0.0%) 20:29:37 INFO - 2015-11-16 20:29:37,869 DEBUG : BROWSER_OUTPUT: Values: 940.7 20:29:37 INFO - 2015-11-16 20:29:37,869 DEBUG : BROWSER_OUTPUT: 20:29:37 INFO - 2015-11-16 20:29:37,869 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13554.05 Median:13554.05 stddev:0.00 (0.0%) 20:29:37 INFO - 2015-11-16 20:29:37,870 DEBUG : BROWSER_OUTPUT: Values: 13554.1 20:29:37 INFO - 2015-11-16 20:29:37,870 DEBUG : BROWSER_OUTPUT: 20:29:37 INFO - 2015-11-16 20:29:37,871 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29764.71 Median:29764.71 stddev:0.00 (0.0%) 20:29:37 INFO - 2015-11-16 20:29:37,871 DEBUG : BROWSER_OUTPUT: Values: 29764.7 20:29:37 INFO - 2015-11-16 20:29:37,871 DEBUG : BROWSER_OUTPUT: 20:29:37 INFO - 2015-11-16 20:29:37,871 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:613.12 Median:613.12 stddev:0.00 (0.0%) 20:29:37 INFO - 2015-11-16 20:29:37,871 DEBUG : BROWSER_OUTPUT: Values: 613.1 20:29:37 INFO - 2015-11-16 20:29:37,871 DEBUG : BROWSER_OUTPUT: 20:29:37 INFO - 2015-11-16 20:29:37,872 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5813.95 Median:5813.95 stddev:0.00 (0.0%) 20:29:37 INFO - 2015-11-16 20:29:37,872 DEBUG : BROWSER_OUTPUT: Values: 5814.0 20:29:37 INFO - 2015-11-16 20:29:37,872 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:29:37 INFO - 2015-11-16 20:29:37,872 DEBUG : BROWSER_OUTPUT: 20:29:38 INFO - 2015-11-16 20:29:38,548 INFO : Browser exited with error code: 0 20:29:38 INFO - 2015-11-16 20:29:38,568 INFO : Completed test v8_7 (00:00:37) 20:29:38 INFO - 2015-11-16 20:29:38,964 INFO : Completed test suite (00:20:09) 20:29:38 INFO - 2015-11-16 20:29:38,965 DEBUG : Working with test: dromaeo_css 20:29:38 INFO - 2015-11-16 20:29:38,965 DEBUG : Generating results file: dromaeo_css 20:29:38 INFO - 2015-11-16 20:29:38,965 DEBUG : Working with test: kraken 20:29:38 INFO - 2015-11-16 20:29:38,965 DEBUG : Generating results file: kraken 20:29:38 INFO - 2015-11-16 20:29:38,966 INFO : javascript benchmark 20:29:38 INFO - 2015-11-16 20:29:38,966 DEBUG : Working with test: v8_7 20:29:38 INFO - 2015-11-16 20:29:38,966 DEBUG : Generating results file: v8_7 20:29:38 INFO - 2015-11-16 20:29:38,966 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:29:39 INFO - 2015-11-16 20:29:39,018 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,54,55]] 20:29:39 INFO - 2015-11-16 20:29:39,018 DEBUG : process_Request line: dromaeo_css 6477.39 graph.html#tests=[[72,54,55]] 20:29:39 INFO - 2015-11-16 20:29:39,018 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:29:39 INFO - 2015-11-16 20:29:39,162 DEBUG : process_Request line: kraken 1486.20 graph.html#tests=[[232,54,55]] 20:29:39 INFO - 2015-11-16 20:29:39,162 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:29:39 INFO - 2015-11-16 20:29:39,187 DEBUG : process_Request line: v8_7 18008.80 graph.html#tests=[[230,54,55]] 20:29:39 INFO - 2015-11-16 20:29:39,188 INFO : javascript benchmark 20:29:39 INFO - 2015-11-16 20:29:39,189 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [327.72307400246785, 332.0553026639212, 332.22591362126246, 335.6106915977464, 341.3548393536216, 13685.589432317047, 14344.28278586069, 16286.42997495088, 16446.506604801845, 17428.215730292137, 13736.313184340794, 14749.926250368733, 16812.41156559521, 17549.29802807886, 17575.560610984732, 5028.647994640386, 5175.715335656538, 5239.056969745444, 5242.449542798008, 5277.683338999653, 3708.42519409492, 5069.214271787879, 5131.820386286481, 5214.322138122039, 5233.136532472156, 3807.7524960877595, 5435.347758269013, 5645.379008309083, 5651.802186923438, 5661.433856614326, 5491.86086488587, 5557.888842223153, 5564.360098588633, 5671.8014869479575, 5676.716164191774, 4932.605391568702, 4934.5312195341385, 4978.203487442028, 4992.126377883892, 4992.650514463989, 20656.896715516476, 20773.16907323705, 20810.583788324147, 20855.0, 21120.683189752013, 1703.7529558214114, 1712.8287171282896, 1713.8200488948605, 1964.1946801811332, 1978.436145698469, 8989.640414383482, 9285.210757085588, 9295.814083718355, 9356.485393303366, 9460.053994600554, 1481.8962672612922, 1484.7104814561164, 1495.4915328788263, 1535.4625880941692, 1543.2592355669342, 53851.461485385036, 57078.143827842614, 57710.0, 57773.99999999958, 58300.0, 6338.746450141943, 6352.428281454599, 6382.776602818879, 6426.839329016812, 6464.870702585922, 7323.523970941872, 7337.376323012603, 7408.814779630445, 7409.851802964018, 7514.248575142551, 5288.550473209821, 5292.311999440049, 5293.973530132324, 5348.438413966477, 5547.667139971614, 5417.674939503642, 5428.972855135699, 5472.7263636818, 5577.386487486373, 5596.048671725816, 2874.6981566935588, 2884.7259510346485, 2898.6086878271585, 2915.883364665432, 2919.489089409345, 1000.3297790480395, 1003.603576587244, 1018.9439580823126, 1019.0421004256124, 1063.505469956474, 400.2235662814131, 422.84566133361716, 425.69350067951024, 429.6090557592638, 439.2291528367694, 10838.67483975482, 11123.332600044023, 11171.944140279247, 11279.887201127884, 11295.209335346612, 406.17343705559045, 433.0948318015363, 455.10571726557475, 460.62919349922964, 481.5641844131067, 5985.0, 6200.224971878515, 6209.5032397408095, 6229.504918819542, 6258.186435763321, 368719.0, 380136.0, 382531.0, 385095.0, 438185.0, 73818.26181738114, 74008.62995684987, 74324.0, 74521.0, 76737.61631191809, 471.1166562694947, 477.5248627615475, 486.8296096366314, 491.11108892903957, 491.87948952506866, 10410.68767936963, 10565.577376904837, 10627.09669678086, 10674.8932510677, 10876.564937402416, 33670.30637548941, 33889.0, 34025.149371265914, 34051.0, 34125.65874341324, 44567.55432445634, 45393.0, 45655.08689826251, 45955.0, 46057.539424605326, 6059.787907423395, 6089.056196289582, 6118.47992920589, 6123.173371594956, 6134.325224225242, 11083.94458027737, 11467.082633389142, 11557.133215009077, 11646.76706465849, 11820.054395648156, 9876.802463950824, 9913.355631883904, 10040.64857729976, 10088.596456141966, 10109.64616238428, 9584.233261339215, 9691.418514889128, 9799.265055120752, 9883.456409897524, 10084.042016008761, 8725.171108744658, 9863.309568330147, 9999.800003999733, 10219.897801022193, 10264.281500294908, 5593.384727679871, 5717.285339332583, 5936.614120082181, 6195.132681424694, 6252.5935814171935, 9811.313208075366, 10069.093781559695, 10192.592296308065, 10212.0, 10316.019978102067], "dojo.html": [3154.1483799374155, 3163.003653849039, 3182.777205595608, 3241.0438920518445, 3280.885169019084, 5138.665986710861, 5166.922496162551, 5241.921371179431, 5328.12086005809, 5346.251524786533, 5163.922541161885, 5193.091209038413, 5257.658252213603, 5282.762275697593, 5367.838964831051, 4799.496052914446, 4820.325154478376, 4857.854264372057, 4899.461059283476, 4991.625628077891, 4852.126617208901, 4912.410510738699, 4932.704037757746, 4948.1093403187415, 5060.39275286966, 4362.47650281965, 4660.347551342815, 4744.4069491313585, 4771.618270538349, 4816.87957801056, 4747.45404278509, 4755.310479980418, 4764.428268607755, 4789.353437285957, 4831.033793241366, 4699.060187962421, 4744.786484608201, 4786.401699787527, 4817.831375901862, 4892.633052521075, 4895.437024742165, 5020.623453241022, 5032.220005899091, 5073.898522029539, 5085.644004919657, 5458.0721277382545, 5492.066348720727, 5497.945020549823, 5514.972425137888, 5532.197831314477, 5534.75093620788, 5549.445055494418, 5611.887762244733, 5614.410486898858, 5693.060644993571, 5101.489851014906, 5145.3568303962, 5194.506521880453, 5215.426303106655, 5260.316158899319, 5651.406602306781, 5668.093105103246, 5712.200291959129, 5734.913976290359, 5781.392953739797, 5442.809501667422, 5445.0, 5469.234307196995, 5490.780368785284, 5530.695811730313, 5488.396276409591, 5561.082421400423, 5589.80435684749, 5611.7474713637985, 5696.060150075274, 5448.182772584065, 5570.220169176318, 5576.749046292926, 5592.524635406036, 5592.748326325325, 5501.477359650827, 5508.504234618904, 5539.14143307788, 5549.667019978814, 5561.916571251434, 4139.379093136054, 4209.305464598368, 4267.615914567704, 4278.122984788111, 4412.867613971586, 3921.235359105004, 3921.8235179416993, 3934.5868683788362, 3936.724429289922, 3971.1065010372436, 5141.665791723526, 5203.297554830126, 5205.167173252262, 5210.53105220532, 5212.087884620177, 5289.920651190235, 5389.83830485086, 5464.153056276284, 5468.7265636718, 5571.860703482445, 5157.716325602128, 5158.690478571298, 5221.034108689904, 5244.501772331622, 5247.02929957959, 4927.802887884444, 4947.282644016669, 4949.356583644103, 4949.48030456804, 5042.873928151752, 5251.054810134213, 5446.455354464681, 5492.203630473559, 5569.10894256917, 5720.199172115824, 5606.579506536945, 5607.3551541571605, 5644.238027866186, 5662.377138514677, 5697.601167918372, 5602.887942241214, 5646.802361917313, 5670.829875103754, 5687.090065589486, 5716.456936591017, 5477.0, 5486.341639003345, 5542.722863856871, 5553.139263414178, 5628.831135065954, 5563.332400112013, 5564.888702226014, 5618.2415373924, 5630.60585758993, 5675.205471233948, 5318.547923426552, 5377.973110134424, 5507.504324610804, 5507.807226747044, 5564.91652625219, 5332.33345831771, 5338.3060202173465, 5441.918371224514, 5446.782128714965, 5460.290162278879, 5298.682079075268, 5335.039692855168, 5367.919481207707, 5394.703291319015, 5451.264079349237, 5457.103231611226, 5461.208124821799, 5466.562674986071, 5474.671519708831, 5532.889342213214, 5233.869153271199, 5288.101022826206, 5330.893382132258, 5348.893022139613, 5358.758855851574], "mootools.html": [1478.2017710436364, 1673.4895856763685, 1760.155125539741, 1764.7441121037446, 1808.448423230914, 7025.367716905477, 7561.054868141482, 7734.8453030939345, 7775.961120194391, 7817.3355264802485, 7571.469997100206, 7665.271799179083, 7694.422918281138, 7752.108507521622, 7766.495177813452, 2017.062066139245, 2022.828059614927, 2177.8911054447294, 2180.324099529147, 2216.1910902520544, 2225.1766846266905, 2240.7759224077545, 2249.3701763506247, 2256.4133325335365, 2256.638937769957, 2092.048118106258, 2117.76704562498, 2141.957160856782, 2167.9566408671817, 2176.847620666546, 1964.3812199157219, 2005.7292265544183, 2180.0, 2235.7093577834776, 2238.3061251012236, 2168.414528077426, 2181.2692747929464, 2213.3581261434165, 2227.922022729213, 2232.720909886264, 7515.323620874147, 7669.271419215222, 7696.538207707499, 7714.267144621252, 7717.65270562826, 4625.190591646482, 4769.0, 4778.04439112179, 4855.927161092586, 4870.391201099863, 2764.060219525351, 2790.065328115084, 2826.1239015905135, 2839.971600284012, 2869.856507174633, 871.0723079919865, 875.8729984152262, 876.0407353947418, 880.8634661627458, 905.8777065096193, 10016.94991525045, 10057.69826905194, 10058.446785426799, 10058.547365368502, 10135.391876487434, 4293.957060429419, 4319.827206911751, 4357.433533640607, 4365.541618130114, 4430.091831174666, 8847.203751662253, 8900.287976961827, 8943.821123577492, 8948.73153805387, 8993.190612844875, 4860.586850117709, 4864.148773964542, 4917.852464426073, 4933.432655244621, 4936.938558210002, 4412.4705035395955, 4445.82216711328, 4449.555044495589, 4458.71018383804, 4500.482444518857, 3521.4033901338967, 3550.201204728967, 3557.768745031565, 3563.3051554947056, 3584.7311451640708, 1151.8502594662807, 1181.5214837990627, 1187.893089621938, 1193.176708071428, 1195.1693572966878, 997.8054279415444, 1220.5850010996126, 1291.3026965438746, 1296.714722760991, 1297.3124244150615, 6847.828804279933, 7158.2483839197175, 7167.4266058715175, 7198.892016619755, 7229.8554028919125, 460.3761902621966, 466.4915242385816, 1169.9941500292443, 1203.3742453924085, 1220.7436438348047, 5730.140478928194, 5795.13073039039, 5795.7971470999155, 5830.970845145832, 5835.153902684087, 8407.327413806881, 8432.072472028072, 8485.406021578554, 8541.273991710774, 8866.911330886609, 8919.420237684659, 8947.3736838422, 8954.910450895408, 8966.372353935161, 9013.369064165576, 7070.36366726997, 7098.432125429953, 7203.495755297079, 7269.527480713737, 7273.89089163663, 7101.396381307647, 7136.0, 7159.427245820218, 7178.928210718035, 7213.927860721536, 8024.478408903403, 8029.317508011651, 8073.35413166957, 8135.959320203361, 8176.345892328718, 8170.714025009096, 8278.420510564203, 8280.627371768165, 8300.0, 8307.003159620885, 6690.83272918181, 6805.829854253683, 6858.828529286808, 6868.381845633917, 6874.037634731041, 7355.374793142642, 7391.0, 7403.888941665771, 7419.629018549159, 7422.70309187648, 6789.355011273921, 6842.7605033823575, 6920.757773477904, 7004.7198112076985, 7043.0, 6123.08153776937, 6323.715432805443, 6695.0626912231355, 6749.662516874235, 6907.274736152833, 6947.340002699735, 6956.991236270611, 6960.825979350354, 7004.124484439445, 7010.75462358815, 6322.810315690536, 6329.936700632935, 6346.111544383883, 6378.0, 6380.074889141141, 6387.425131738166, 6415.166028416463, 6457.483401327976, 6462.321456247027, 6470.191226096738], "ext.html": [539.9676019438834, 540.4703390677137, 546.4726538889971, 546.4890327543746, 560.8709996700757, 30809.22976925578, 31150.688493115063, 35998.46002309967, 36301.63698363015, 36498.0, 40940.59059409405, 41215.0, 41549.37675934856, 41592.16815663685, 41681.37477937833, 8016.478928869634, 8959.507227102524, 9043.14090161437, 9081.091890810932, 9167.816643667156, 8103.0, 10886.4012479314, 11054.723631909226, 11085.83371249432, 11152.386618735965, 10684.572617095308, 10778.730531736692, 10807.783844323108, 10885.564577416893, 10908.945455272753, 8198.303144232746, 8448.619812108469, 10751.62369317074, 10806.29759065666, 10974.286671366335, 10484.842727359095, 10531.73670658232, 10625.73435664107, 10659.520321585547, 10697.625583104631, 39970.20059598821, 40213.0, 40288.395674064916, 40537.59462405368, 40607.39088913669, 3018.1850900257027, 3098.101550550338, 3429.416999110157, 3479.6172421033666, 3507.5440192774777, 26898.865505672347, 27133.151019142904, 27519.31201719953, 27727.445451090865, 28035.29911752202, 2276.226083131743, 2360.799332056777, 2421.418859473731, 2450.215930902112, 2460.90156393744, 279764.0, 282190.5890470555, 282378.0, 283147.0, 283287.0, 55792.442075579536, 56365.71817140888, 60308.39691603115, 60400.39599604036, 61020.38979610236, 62985.37014629795, 64786.35213647898, 64852.0, 64896.0, 65164.34835651678, 16350.672986540203, 16451.25969331383, 16536.586585335463, 16698.332066717194, 16720.498385048468, 12577.119601627981, 12592.622221333191, 12686.238825670489, 12803.935980320039, 12840.871591283967, 19603.705944410845, 19811.504712382306, 19843.30548430798, 19865.801341986684, 20078.397648070582, 7501.699932002768, 7750.573718445539, 7803.882941755878, 7804.726834560764, 7857.528548287121, 802.4583406200791, 825.9669613215405, 916.6562539047857, 971.7327734872825, 1108.152263518393, 27290.181294561196, 27673.72326276752, 27696.723032769816, 27873.442531149263, 28061.43877122446, 966.79213968997, 1022.8874823769379, 1030.160419258302, 1042.8852826189113, 1163.168334640719, 9854.802903941882, 10043.69868903934, 10217.489125543692, 10261.0, 10267.94866025665, 308288.0, 312544.0, 312679.0, 313527.0, 313800.0, 54026.72986635042, 54052.45947540474, 54098.72950635222, 54442.18336724952, 54577.45422545803, 1331.8202042724301, 1340.7720687483152, 1360.9860653812973, 1363.3932899859467, 1374.9381277842522, 19159.0, 19241.326553570558, 19501.51246218799, 19665.311714089938, 19706.014699265266, 46880.53119468898, 47111.0, 47268.7636561815, 47333.52666473291, 47388.52611473979, 257524.0, 260410.0, 281235.0, 287337.0, 293528.0, 28683.71316286894, 28790.568141477477, 28885.133445996653, 29013.56479652849, 29071.7092829069, 39059.41410878782, 39570.40644390394, 39725.0, 40546.0, 40652.59347406607, 32302.19244518906, 33581.83209083939, 34201.48697769585, 35823.46264806082, 35967.460488093224, 34808.47787283243, 34977.475337869444, 35135.47296790499, 35390.292194156485, 35661.821690892415, 35011.47482787709, 35609.64390356063, 35932.28135437329, 36052.27895442129, 36138.0, 30081.398372032, 31182.0, 31224.21939451441, 31239.375212496077, 31240.0, 22887.54224915459, 22887.542249155256, 23177.188798391977, 23295.883520582287, 23469.647955281027], "prototype.html": [315.78053252989184, 320.9486482162854, 323.3323187617571, 323.64884100750686, 323.7846831856817, 5859.296884373875, 5973.88052238955, 5978.58149929504, 5978.581499295051, 6001.369856165105, 5779.884402311962, 5876.853078673035, 5881.117832325153, 5892.528597712183, 5912.083627037805, 4258.446401967755, 4404.427424434819, 4435.689501734863, 4517.435320584927, 4555.407796986387, 4466.57567531084, 4473.351364052211, 4494.8202071917085, 4500.099980003996, 4521.457425108992, 4231.428757117796, 4413.9117217655785, 4455.1535208310315, 4473.530279320673, 4487.304467807478, 4323.200207961521, 4383.890402739925, 4402.537733537996, 4462.531434199394, 4529.977350113261, 3875.186210895687, 3881.4177873319227, 3890.0663840678317, 3890.144168282973, 3906.5507466641416, 5623.240862483594, 5676.233708449389, 5682.318121825366, 5688.800891968761, 5724.713764311809, 5055.747212639353, 5067.113255180366, 5070.239464080418, 5117.2068329409, 5119.385673719177, 6049.183360246355, 6089.634621922699, 6092.360302168253, 6100.389961003909, 6110.419510146573, 4120.938185927213, 4122.958770412288, 4145.108801607669, 4145.709800313979, 4170.9582904170875, 6276.937230627681, 6346.936530634727, 6361.300256971729, 6397.424231819158, 6413.262474815409, 4041.6766658667234, 4180.268453020709, 4207.642350400189, 4219.78901054946, 4232.534421213664, 4361.323994780814, 4362.1493808707, 4371.912561748747, 4384.978075109604, 4388.166248412791, 5053.797848086036, 5059.089363914531, 5065.164247899129, 5075.56857667095, 5098.031374038921, 6216.222972128484, 6253.0, 6269.811905642838, 6272.843178920563, 6287.2140982377205, 1504.3982407037272, 1536.9769453458207, 1539.853713897178, 1545.9845401546065, 1556.5486009057247, 986.6793292180071, 994.0, 1007.773251018515, 1011.8279892418307, 1020.0666390252835, 5843.5909486336395, 5869.706514674334, 5895.616784908967, 5898.764049437975, 5934.584579079423, 6355.713992870239, 6390.297067322591, 6411.51913606472, 6427.710753016126, 6472.385123413268, 5892.1161825726485, 5920.79277225295, 5936.1392598073035, 5944.197533332945, 5951.0, 3102.1779228504465, 3358.6809253120914, 3434.6050204226335, 3536.734744894143, 3571.8392672329287, 6451.677416129175, 6461.160049193575, 6526.869462610816, 6571.769988050491, 6573.638449885207, 6546.18172728409, 6549.083128362033, 6558.278589355167, 6562.310957349505, 6588.308227636125, 6456.128422662974, 6538.084668146464, 6546.967265163644, 6576.0464732612545, 6585.407313341726, 6423.839404014937, 6448.419642232222, 6450.290468048604, 6461.8061458156335, 6483.708233129615, 6146.8321019008035, 6188.752449901954, 6239.06414037898, 6256.249250090018, 6306.716197771019, 6471.902921456088, 6477.935220647922, 6482.157319548429, 6516.609003459807, 6528.445082168069, 4086.530049044398, 4150.52268989058, 4232.661387088964, 4248.426462427533, 4263.701540892108, 6271.153394291712, 6327.841803954938, 6357.841053973688, 6417.0695249187675, 6428.035794630843, 6188.0717892314715, 6216.7824126155365, 6229.813105606839, 6244.968775156277, 6284.0, 6000.21997140369, 6159.476444502267, 6234.750609975732, 6243.875122497616, 6252.812415627538, 6093.329733729375, 6099.054646529795, 6112.144299797943, 6135.049067394561, 6238.376162383907, 6285.717142728679, 6315.778947736807, 6328.841778955563, 6352.047192921099, 6364.07720880479, 6010.759569617167, 6097.908531371944, 6108.969455152695, 6180.289266734383, 6204.3795620437595], "yui.html": [680.1635583923405, 719.8416348403352, 756.8524137793131, 757.7650928212252, 776.119104816034, 12585.559505417312, 13024.0, 13213.999999999987, 13276.137051091684, 13353.799693004612, 11667.591634292801, 12365.938170309137, 12394.566190183345, 12462.252264864115, 12555.309457979807, 655.7672026430608, 822.8560001999656, 832.7418500264907, 847.0936098374741, 857.6440777077505, 850.783050322167, 854.3208149521115, 862.0173002776808, 862.8576284912982, 865.0484467086186, 690.4545409126808, 717.8707832590158, 899.8470260055774, 918.1323649151554, 918.4397517514311, 868.8870446841902, 902.1700035966926, 902.309733054214, 902.7607683963755, 903.0788595632483, 659.446065305146, 665.1785045468843, 665.7004348043351, 666.516775337881, 671.4225765841372, 13109.672258193526, 13115.47538098475, 13118.672033199151, 13144.737105257842, 13262.0, 10944.507497162647, 11076.169287303484, 11299.49152288149, 11358.43207839613, 11493.367864767435, 9025.864612030824, 9149.54252287383, 9156.404833685856, 9351.906480935171, 9368.85946710793, 3183.363327334519, 3244.23760416302, 3282.458394364927, 3284.4744840825592, 3424.8630054797777, 43961.34057989133, 44275.0, 44275.33586996198, 44336.55663443357, 44357.778211109064, 8386.161383861565, 8608.139186081342, 8618.827623447496, 8628.654853805903, 8752.168543988439, 17925.0, 18039.909800450914, 18125.637487250446, 18182.818171818377, 18236.36172733948, 6186.1648677427975, 6234.750609975641, 6260.655663938527, 6287.968560157261, 6527.281998980204, 3744.64425879541, 3833.1375440526217, 3854.5759966403675, 3854.9807250963568, 3866.8066596670055, 2711.986440067787, 2715.4433341165013, 2731.399092199713, 2739.2877851758685, 2745.5881617757095, 388.8075402675694, 390.6581740976645, 396.95633480317144, 397.4554859842035, 403.3969216022066, 510.8646208754683, 561.6489693941287, 580.8141394753638, 587.8595524682103, 593.3680630128899, 7715.112762032438, 7753.147153813076, 7909.406794490321, 7918.089419716691, 8045.235702608243, 489.889774800667, 565.2058857305492, 575.2320651929721, 584.7836300568816, 592.2301008688773, 3908.6677632401565, 3960.960390396117, 3970.285348637215, 3991.2815693174925, 4132.752034877917, 58053.419465805644, 59561.0, 60009.399906000384, 60132.699336503036, 60738.696306519065, 49450.0, 51182.0, 52358.47641523536, 52380.214296785576, 52667.47332526703, 47670.761646192244, 48040.519594803605, 48607.0, 49137.262941055196, 49386.753066234436, 7956.9602151988865, 7960.761177164694, 8186.713465028695, 8358.87461688063, 8409.327253819802, 32918.177045574055, 33171.33657326888, 34111.829440852634, 35624.0, 36149.27701446009, 42613.36079958865, 42671.57328426676, 42724.5727542733, 44666.0, 45296.773516132205, 10171.7457063574, 10365.9481702591, 10632.043116119587, 10741.140708743438, 10886.727831803952, 10848.233700406347, 10851.511681974487, 11327.207095503565, 11466.484008219817, 11668.941655292008, 10206.6427675034, 10279.0, 10301.690949271533, 10321.793564128826, 11204.719882003015, 10521.73695657584, 10541.20940929418, 10663.093637040938, 10699.679009629723, 11050.171237157085, 7030.790889988884, 9367.250619950251, 10012.649557265751, 10092.84860727075, 10179.38923664553, 8784.868226976729, 8785.121487851164, 8959.283257339528, 9047.054883200144, 9211.0, 7558.546487210785, 8789.296856251356, 8853.29173666118, 8999.697464154555, 9041.32190085733]}, "summary": {"suite": 6477.3881685032475, "subtests": {"jquery.html": {"filtered": 6674.42751878367, "value": 6674.42751878367}, "dojo.html": {"filtered": 5146.1071136748515, "value": 5146.1071136748515}, "mootools.html": {"filtered": 4377.517852751767, "value": 4377.517852751767}, "ext.html": {"filtered": 17944.78455847283, "value": 17944.78455847283}, "prototype.html": {"filtered": 4636.060038590371, "value": 4636.060038590371}, "yui.html": {"filtered": 5904.099410187924, "value": 5904.099410187924}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0016"}, "testrun": {"date": 1447733369, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116150236", "branch": "Alder", "revision": "5cec55768069f26a9d88569102081aa48c041309"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 162.0, 161.0, 163.0, 164.0, 162.0, 163.0, 164.0, 163.0, 160.0], "ai-astar": [106.0, 103.0, 108.0, 107.0, 107.0, 106.0, 111.0, 106.0, 107.0, 106.0], "imaging-gaussian-blur": [121.0, 121.0, 122.0, 115.0, 118.0, 121.0, 115.0, 118.0, 120.0, 119.0], "audio-beat-detection": [156.0, 130.0, 150.0, 164.0, 128.0, 149.0, 146.0, 125.0, 165.0, 125.0], "json-stringify-tinderbox": [67.0, 66.0, 66.0, 68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 67.0], "stanford-crypto-pbkdf2": [137.0, 151.0, 148.0, 147.0, 152.0, 136.0, 150.0, 147.0, 147.0, 148.0], "json-parse-financial": [58.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 65.0, 55.0, 56.0], "stanford-crypto-sha256-iterative": [69.0, 69.0, 70.0, 69.0, 68.0, 71.0, 69.0, 70.0, 68.0, 69.0], "audio-fft": [76.0, 80.0, 83.0, 84.0, 67.0, 69.0, 70.0, 78.0, 84.0, 68.0], "imaging-darkroom": [125.0, 125.0, 125.0, 125.0, 124.0, 125.0, 125.0, 125.0, 125.0, 125.0], "stanford-crypto-ccm": [124.0, 134.0, 119.0, 125.0, 123.0, 123.0, 124.0, 123.0, 122.0, 124.0], "audio-oscillator": [101.0, 98.0, 135.0, 88.0, 89.0, 94.0, 123.0, 89.0, 88.0, 125.0], "stanford-crypto-aes": [85.0, 84.0, 90.0, 84.0, 85.0, 84.0, 84.0, 85.0, 88.0, 85.0], "imaging-desaturate": [100.0, 101.0, 100.0, 100.0, 103.0, 106.0, 101.0, 100.0, 101.0, 100.0]}, "summary": {"suite": 1486.2, "subtests": {"audio-fft": {"filtered": 75.9, "value": 75.9}, "stanford-crypto-pbkdf2": {"filtered": 146.3, "value": 146.3}, "audio-beat-detection": {"filtered": 143.8, "value": 143.8}, "stanford-crypto-ccm": {"filtered": 124.1, "value": 124.1}, "imaging-darkroom": {"filtered": 124.9, "value": 124.9}, "json-parse-financial": {"filtered": 57.0, "value": 57.0}, "audio-oscillator": {"filtered": 103.0, "value": 103.0}, "ai-astar": {"filtered": 106.7, "value": 106.7}, "audio-dft": {"filtered": 162.4, "value": 162.4}, "stanford-crypto-sha256-iterative": {"filtered": 69.2, "value": 69.2}, "json-stringify-tinderbox": {"filtered": 67.3, "value": 67.3}, "imaging-gaussian-blur": {"filtered": 119.0, "value": 119.0}, "stanford-crypto-aes": {"filtered": 85.4, "value": 85.4}, "imaging-desaturate": {"filtered": 101.2, "value": 101.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0016"}, "testrun": {"date": 1447733369, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116150236", "branch": "Alder", "revision": "5cec55768069f26a9d88569102081aa48c041309"}}, {"talos_counters": {}, "results": {"DeltaBlue": [198.45207382417146], "Encrypt": [326.47730982696703], "NavierStokes": [5813.953488372093], "Decrypt": [5758.620689655172], "Splay": [613.1207847946046], "Richards": [168.6056314280897], "RegExp": [29764.70588235294], "Earley": [940.7337723424271], "Boyer": [13554.054054054053], "RayTrace": [2047.034764826176]}, "summary": {"suite": 18008.800074027025, "subtests": {"DeltaBlue": {"filtered": 333.16860200000013, "value": 333.16860200000013}, "Encrypt": {"filtered": 815.3124030000001, "value": 815.3124030000001}, "NavierStokes": {"filtered": 255.24799999999982, "value": 255.24799999999982}, "Decrypt": {"filtered": 46.22304790419163, "value": 46.22304790419163}, "Splay": {"filtered": 132.91182099999997, "value": 132.91182099999997}, "RegExp": {"filtered": 30.606215415019737, "value": 30.606215415019737}, "Richards": {"filtered": 209.3761619999999, "value": 209.3761619999999}, "Earley": {"filtered": 708.4501690000002, "value": 708.4501690000002}, "Boyer": {"filtered": 49.17074975074771, "value": 49.17074975074771}, "RayTrace": {"filtered": 361.49312787212784, "value": 361.49312787212784}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0016"}, "testrun": {"date": 1447733369, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116150236", "branch": "Alder", "revision": "5cec55768069f26a9d88569102081aa48c041309"}}] 20:29:39 INFO - RETURN: dromaeo_css: 6477.39 20:29:39 INFO - RETURN: kraken: 1486.20 20:29:39 INFO - RETURN: v8_7: 18008.80 20:29:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,54,55]]", "result": "18008.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,54,55]]", "result": "1486.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,54,55]]", "result": "6477.39"}}} 20:29:39 INFO - Return code: 0 20:29:39 INFO - # TBPL SUCCESS # 20:29:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:29:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:29:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:29:39 INFO - 2015-11-16 20:29:39.293 screenresolution[2240:19418] starting screenresolution argv=screenresolution get 20:29:39 INFO - 2015-11-16 20:29:39.296 screenresolution[2240:19418] Display 0: 1600x1200x32@60 20:29:39 INFO - 2015-11-16 20:29:39.302 screenresolution[2241:19422] starting screenresolution argv=screenresolution list 20:29:39 INFO - Available Modes on Display 0 20:29:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:29:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:29:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:29:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:29:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:29:39 INFO - Intel HD Graphics 3000: 20:29:39 INFO - Chipset Model: Intel HD Graphics 3000 20:29:39 INFO - Type: GPU 20:29:39 INFO - Bus: Built-In 20:29:39 INFO - VRAM (Total): 512 MB 20:29:39 INFO - VRAM (Dynamic, Max): 10 20:29:39 INFO - Vendor: Intel (0x8086) 20:29:39 INFO - Device ID: 0x0116 20:29:39 INFO - Revision ID: 0x0009 20:29:39 INFO - Displays: 20:29:39 INFO - Display: 20:29:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:29:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:29:39 INFO - Display Serial Number: 1600x1200 60 20:29:39 INFO - Main Display: Yes 20:29:39 INFO - Mirror: Off 20:29:39 INFO - Online: Yes 20:29:39 INFO - Rotation: Supported 20:29:39 INFO - Return code: 0 20:29:39 INFO - Running post-action listener: _resource_record_post_action 20:29:39 INFO - Running post-run listener: _resource_record_post_run 20:29:40 INFO - Total resource usage - Wall time: 1248s; CPU: 30.0%; Read bytes: 901120; Write bytes: 681521152; Read time: 202; Write time: 56070 20:29:40 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 333056512; Write bytes: 333666304; Read time: 32682; Write time: 5679 20:29:40 INFO - run-tests - Wall time: 1210s; CPU: 30.0%; Read bytes: 901120; Write bytes: 337487872; Read time: 202; Write time: 49177 20:29:40 INFO - Running post-run listener: _upload_blobber_files 20:29:40 INFO - Blob upload gear active. 20:29:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:29:40 INFO - Copying logs to upload dir... 20:29:40 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1301.323434 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2015-11-16 20:29:40.710289) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 20:29:40.713654) ========= 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.1TD8bnSeCO/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.9uoGquWrju/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010052 build_url: 'https://queue.taskcluster.net/v1/task/9vA9NoRUS2a747QJIx_7DQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 20:29:40.739664) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:29:40.740018) ========= 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.1TD8bnSeCO/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.9uoGquWrju/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/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.005417 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:29:40.789128) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 20:29:40.789483) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 20:29:40.789878) ========= ========= Total master_lag: 17.17 =========