builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0094 starttime: 1454573334.69 results: success (0) buildid: 20160203231628 builduid: 3274cf20395e4537a8920d40a51df7be revision: 03297f8c28a08d2b39a252c7b368524d9e69da69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:54.686720) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:54.687134) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:54.687417) ========= 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.8rYkfBvt7I/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.KLE7pVEefE/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005532 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:54.766460) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:54.766742) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:54.893314) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:54.893615) ========= 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.8rYkfBvt7I/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.KLE7pVEefE/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005448 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:54.949306) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:54.949575) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:54.949915) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:54.950191) ========= 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.8rYkfBvt7I/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.KLE7pVEefE/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-04 00:08:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 147M=0s 2016-02-04 00:08:55 (147 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.661769 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:55.684806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:55.685074) ========= 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.8rYkfBvt7I/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.KLE7pVEefE/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026508 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:55.761205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-04 00:08:55.761505) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 03297f8c28a08d2b39a252c7b368524d9e69da69 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 03297f8c28a08d2b39a252c7b368524d9e69da69 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8rYkfBvt7I/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.KLE7pVEefE/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-04 00:08:55,839 truncating revision to first 12 chars 2016-02-04 00:08:55,839 Setting DEBUG logging. 2016-02-04 00:08:55,839 attempt 1/10 2016-02-04 00:08:55,839 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/03297f8c28a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-04 00:08:57,554 unpacking tar archive at: fx-team-03297f8c28a0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.959336 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-04 00:08:57.742867) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:57.743286) ========= echo 03297f8c28a08d2b39a252c7b368524d9e69da69 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'03297f8c28a08d2b39a252c7b368524d9e69da69'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8rYkfBvt7I/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.KLE7pVEefE/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03297f8c28a08d2b39a252c7b368524d9e69da69 program finished with exit code 0 elapsedTime=0.005611 script_repo_revision: '03297f8c28a08d2b39a252c7b368524d9e69da69' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:57.792003) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:57.792280) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 00:08:57.806817) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-02-04 00:08:57.807114) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8rYkfBvt7I/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.KLE7pVEefE/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 00:08:57 INFO - MultiFileLogger online at 20160204 00:08:57 in /builds/slave/test 00:08:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:08:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:08:57 INFO - {'append_to_log': False, 00:08:57 INFO - 'base_work_dir': '/builds/slave/test', 00:08:57 INFO - 'blob_upload_branch': 'Fx-Team', 00:08:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:08:57 INFO - 'branch': 'Fx-Team', 00:08:57 INFO - 'buildbot_json_path': 'buildprops.json', 00:08:57 INFO - 'config_files': ('talos/mac_config.py',), 00:08:57 INFO - 'default_actions': ('clobber', 00:08:57 INFO - 'read-buildbot-config', 00:08:57 INFO - 'download-and-extract', 00:08:57 INFO - 'populate-webroot', 00:08:57 INFO - 'create-virtualenv', 00:08:57 INFO - 'install', 00:08:57 INFO - 'run-tests'), 00:08:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:08:57 INFO - 'download_minidump_stackwalk': True, 00:08:57 INFO - 'download_symbols': 'ondemand', 00:08:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:08:57 INFO - 'tooltool.py': '/tools/tooltool.py', 00:08:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:08:57 INFO - '/tools/misc-python/virtualenv.py')}, 00:08:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:08:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:08:57 INFO - 'installer_path': 'installer.exe', 00:08:57 INFO - 'log_level': 'info', 00:08:57 INFO - 'log_name': 'talos', 00:08:57 INFO - 'log_to_console': True, 00:08:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:08:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:08:57 INFO - 'opt_config_files': (), 00:08:57 INFO - 'pip_index': False, 00:08:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:08:57 INFO - 'cmd': ('bash', 00:08:57 INFO - '-c', 00:08:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:08:57 INFO - 'enabled': True, 00:08:57 INFO - 'halt_on_failure': False, 00:08:57 INFO - 'name': 'check_screen_resolution'},), 00:08:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:08:57 INFO - 'cmd': ('bash', 00:08:57 INFO - '-c', 00:08:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:08:57 INFO - 'enabled': True, 00:08:57 INFO - 'halt_on_failure': False, 00:08:57 INFO - 'name': 'check_screen_resolution'},), 00:08:57 INFO - 'run_cmd_checks_enabled': True, 00:08:57 INFO - 'sps_profile': False, 00:08:57 INFO - 'sps_profile_interval': 0, 00:08:57 INFO - 'suite': 'dromaeojs-e10s', 00:08:57 INFO - 'system_bits': '32', 00:08:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:08:57 INFO - 'title': 't-yosemite-r7-0094', 00:08:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:08:57 INFO - 'use_talos_json': True, 00:08:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:08:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:08:57 INFO - 'work_dir': 'build'} 00:08:57 INFO - ##### 00:08:57 INFO - ##### Running clobber step. 00:08:57 INFO - ##### 00:08:57 INFO - Running pre-action listener: _resource_record_pre_action 00:08:57 INFO - Running main action method: clobber 00:08:57 INFO - rmtree: /builds/slave/test/build 00:08:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:08:59 INFO - Running post-action listener: _resource_record_post_action 00:08:59 INFO - ##### 00:08:59 INFO - ##### Running read-buildbot-config step. 00:08:59 INFO - ##### 00:08:59 INFO - Running pre-action listener: _resource_record_pre_action 00:08:59 INFO - Running main action method: read_buildbot_config 00:08:59 INFO - Using buildbot properties: 00:08:59 INFO - { 00:08:59 INFO - "project": "", 00:08:59 INFO - "product": "firefox", 00:08:59 INFO - "script_repo_revision": "production", 00:08:59 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 00:08:59 INFO - "repository": "", 00:08:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 00:08:59 INFO - "buildid": "20160203231628", 00:08:59 INFO - "pgo_build": "False", 00:08:59 INFO - "basedir": "/builds/slave/test", 00:08:59 INFO - "buildnumber": 310, 00:08:59 INFO - "slavename": "t-yosemite-r7-0094", 00:08:59 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 00:08:59 INFO - "platform": "yosemite_r7", 00:08:59 INFO - "scheduler": "tests-fx-team-macosx64-talos", 00:08:59 INFO - "branch": "fx-team", 00:08:59 INFO - "repo_path": "integration/fx-team", 00:08:59 INFO - "revision": "03297f8c28a08d2b39a252c7b368524d9e69da69", 00:08:59 INFO - "stage_platform": "macosx64", 00:08:59 INFO - "builduid": "3274cf20395e4537a8920d40a51df7be", 00:08:59 INFO - "slavebuilddir": "test" 00:08:59 INFO - } 00:08:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 00:08:59 INFO - Running post-action listener: _resource_record_post_action 00:08:59 INFO - ##### 00:08:59 INFO - ##### Running download-and-extract step. 00:08:59 INFO - ##### 00:08:59 INFO - Running pre-action listener: _resource_record_pre_action 00:08:59 INFO - Running main action method: download_and_extract 00:08:59 INFO - mkdir: /builds/slave/test/build/tests 00:08:59 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')]} 00:08:59 INFO - https://queue.taskcluster.net/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:08:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/test_packages.json 00:08:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/test_packages.json 00:08:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 00:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 00:09:15 INFO - Downloaded 1277 bytes. 00:09:15 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:09:15 INFO - Using the following test package requirements: 00:09:15 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 00:09:15 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:09:15 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 00:09:15 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:09:15 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 00:09:15 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:09:15 INFO - u'jsshell-mac.zip'], 00:09:15 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:09:15 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 00:09:15 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 00:09:15 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:09:15 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 00:09:15 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:09:15 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 00:09:15 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:09:15 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 00:09:15 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 00:09:15 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 00:09:15 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 00:09:15 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:09:15 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')]} 00:09:15 INFO - https://queue.taskcluster.net/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:09:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 00:09:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 00:09:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 00:09:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:09:21 INFO - Downloaded 17118720 bytes. 00:09:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:09:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 00:09:24 INFO - Return code: 0 00:09:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 00:09:24 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')]} 00:09:24 INFO - https://queue.taskcluster.net/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:09:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 00:09:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 00:09:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 00:09:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:09:26 INFO - Downloaded 17118720 bytes. 00:09:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:09:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 00:09:30 INFO - Return code: 0 00:09:30 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')]} 00:09:30 INFO - https://queue.taskcluster.net/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 00:09:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 00:09:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 00:09:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 00:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:09:30 INFO - Downloaded 10706582 bytes. 00:09:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:09:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 00:09:31 INFO - Return code: 0 00:09: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')]} 00:09:31 INFO - https://queue.taskcluster.net/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 00:09:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 00:09:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 00:09:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 00:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 00:09:37 INFO - Downloaded 111118715 bytes. 00:09:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 00:09:37 INFO - mkdir: /builds/slave/test/properties 00:09:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:09:37 INFO - Writing to file /builds/slave/test/properties/build_url 00:09:37 INFO - Contents: 00:09:37 INFO - build_url:https://queue.taskcluster.net/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 00:09:38 INFO - Running post-action listener: _resource_record_post_action 00:09:38 INFO - Running post-action listener: set_extra_try_arguments 00:09:38 INFO - ##### 00:09:38 INFO - ##### Running populate-webroot step. 00:09:38 INFO - ##### 00:09:38 INFO - Running pre-action listener: _resource_record_pre_action 00:09:38 INFO - Running main action method: populate_webroot 00:09:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:09:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:09:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:09:38 INFO - '--tppagecycles', 00:09:38 INFO - '7'], 00:09:38 INFO - 'tests': ['tsvgm']}}, 00:09:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:09:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:09:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:09:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 00:09:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:09:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:09:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:09:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:09:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:09:38 INFO - 'talos_options': ['--e10s'], 00:09:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:09:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:09:38 INFO - 'tests': ['damp', 'tps']}, 00:09:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:09:38 INFO - 'talos_options': ['--e10s'], 00:09:38 INFO - 'tests': ['damp', 'tps']}, 00:09:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:09:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:09:38 INFO - 'other': {'tests': ['a11yr', 00:09:38 INFO - 'ts_paint', 00:09:38 INFO - 'tpaint', 00:09:38 INFO - 'sessionrestore', 00:09:38 INFO - 'sessionrestore_no_auto_restore']}, 00:09:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:09:38 INFO - 'tests': ['a11yr', 00:09:38 INFO - 'ts_paint', 00:09:38 INFO - 'tpaint', 00:09:38 INFO - 'sessionrestore', 00:09:38 INFO - 'sessionrestore_no_auto_restore']}, 00:09:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:09:38 INFO - 'tests': ['a11yr', 00:09:38 INFO - 'ts_paint', 00:09:38 INFO - 'tpaint', 00:09:38 INFO - 'sessionrestore', 00:09:38 INFO - 'sessionrestore_no_auto_restore']}, 00:09:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:09:38 INFO - 'tests': ['a11yr', 00:09:38 INFO - 'ts_paint', 00:09:38 INFO - 'tpaint', 00:09:38 INFO - 'sessionrestore', 00:09:38 INFO - 'sessionrestore_no_auto_restore']}, 00:09:38 INFO - 'other_l64': {'tests': ['a11yr', 00:09:38 INFO - 'ts_paint', 00:09:38 INFO - 'tpaint', 00:09:38 INFO - 'sessionrestore', 00:09:38 INFO - 'sessionrestore_no_auto_restore']}, 00:09:38 INFO - 'other_nol64': {'tests': ['a11yr', 00:09:38 INFO - 'ts_paint', 00:09:38 INFO - 'tpaint', 00:09:38 INFO - 'sessionrestore', 00:09:38 INFO - 'sessionrestore_no_auto_restore']}, 00:09:38 INFO - 'svgr': {'tests': ['tsvgx', 00:09:38 INFO - 'tsvgr_opacity', 00:09:38 INFO - 'tart', 00:09:38 INFO - 'tscrollx', 00:09:38 INFO - 'cart']}, 00:09:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:09:38 INFO - 'tests': ['tsvgx', 00:09:38 INFO - 'tsvgr_opacity', 00:09:38 INFO - 'tart', 00:09:38 INFO - 'tscrollx', 00:09:38 INFO - 'cart']}, 00:09:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:09:38 INFO - 'tests': ['tp5o']}, 00:09:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:09:38 INFO - 'talos_options': ['--e10s'], 00:09:38 INFO - 'tests': ['tp5o']}, 00:09:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:09:38 INFO - 'talos_options': ['--xperf_path', 00:09:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:09:38 INFO - 'tests': ['tp5n']}, 00:09:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:09:38 INFO - 'talos_options': ['--e10s', 00:09:38 INFO - '--xperf_path', 00:09:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:09:38 INFO - 'tests': ['tp5n']}}, 00:09:38 INFO - 'talos.zip': {'path': '', 00:09:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:09:38 INFO - Running post-action listener: _resource_record_post_action 00:09:38 INFO - ##### 00:09:38 INFO - ##### Running create-virtualenv step. 00:09:38 INFO - ##### 00:09:38 INFO - Running pre-action listener: _resource_record_pre_action 00:09:38 INFO - Running main action method: create_virtualenv 00:09:38 INFO - Creating virtualenv /builds/slave/test/build/venv 00:09:38 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 00:09:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:09:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:09:38 INFO - Using real prefix '/tools/python27' 00:09:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:09:39 INFO - Installing distribute.............................................................................................................................................................................................done. 00:09:41 INFO - Installing pip.................done. 00:09:41 INFO - Return code: 0 00:09:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:09:41 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')]} 00:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:41 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')]} 00:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10fe1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe214c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec1d51190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbfd30>, '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 0x10fb22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcb5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/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.KLE7pVEefE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 00:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 00:09:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/Render', 00:09:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:09:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:09:41 INFO - 'HOME': '/Users/cltbld', 00:09:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:09:41 INFO - 'LOGNAME': 'cltbld', 00:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:09:41 INFO - 'MOZ_NO_REMOTE': '1', 00:09:41 INFO - 'NO_EM_RESTART': '1', 00:09:41 INFO - 'PAGER': '/bin/cat', 00:09:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:09:41 INFO - 'PWD': '/builds/slave/test', 00:09:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:09:41 INFO - 'SHELL': '/bin/bash', 00:09:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KLE7pVEefE/Listeners', 00:09:41 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 00:09:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:09:41 INFO - 'USER': 'cltbld', 00:09:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:09:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:09:41 INFO - 'XPC_FLAGS': '0x0', 00:09:41 INFO - 'XPC_SERVICE_NAME': '0', 00:09:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:09:42 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 00:09:42 INFO - Cleaning up... 00:09:42 INFO - Return code: 0 00:09:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10fe1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe214c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec1d51190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbfd30>, '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 0x10fb22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcb5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/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.KLE7pVEefE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 00:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 00:09:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/Render', 00:09:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:09:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:09:42 INFO - 'HOME': '/Users/cltbld', 00:09:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:09:42 INFO - 'LOGNAME': 'cltbld', 00:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:09:42 INFO - 'MOZ_NO_REMOTE': '1', 00:09:42 INFO - 'NO_EM_RESTART': '1', 00:09:42 INFO - 'PAGER': '/bin/cat', 00:09:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:09:42 INFO - 'PWD': '/builds/slave/test', 00:09:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:09:42 INFO - 'SHELL': '/bin/bash', 00:09:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KLE7pVEefE/Listeners', 00:09:42 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 00:09:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:09:42 INFO - 'USER': 'cltbld', 00:09:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:09:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:09:42 INFO - 'XPC_FLAGS': '0x0', 00:09:42 INFO - 'XPC_SERVICE_NAME': '0', 00:09:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:09:42 INFO - Downloading/unpacking psutil>=0.7.1 00:09:42 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 00:09:42 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 00:09:42 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 00:09:42 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 00:09:42 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 00:09:42 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 00:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:09:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:09:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:09:45 INFO - Installing collected packages: psutil 00:09:45 INFO - Running setup.py install for psutil 00:09:45 INFO - building 'psutil._psutil_osx' extension 00:09:45 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 00:09:46 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 00:09:46 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 00:09:46 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 00:09:46 INFO - building 'psutil._psutil_posix' extension 00:09:46 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 00:09:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:09:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:09:46 INFO - ^ 00:09:46 INFO - 1 warning generated. 00:09:46 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 00:09:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:09:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:09:46 INFO - Successfully installed psutil 00:09:46 INFO - Cleaning up... 00:09:46 INFO - Return code: 0 00:09:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10fe1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe214c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec1d51190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbfd30>, '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 0x10fb22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcb5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/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.KLE7pVEefE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 00:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 00:09:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/Render', 00:09:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:09:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:09:46 INFO - 'HOME': '/Users/cltbld', 00:09:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:09:46 INFO - 'LOGNAME': 'cltbld', 00:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:09:46 INFO - 'MOZ_NO_REMOTE': '1', 00:09:46 INFO - 'NO_EM_RESTART': '1', 00:09:46 INFO - 'PAGER': '/bin/cat', 00:09:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:09:46 INFO - 'PWD': '/builds/slave/test', 00:09:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:09:46 INFO - 'SHELL': '/bin/bash', 00:09:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KLE7pVEefE/Listeners', 00:09:46 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 00:09:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:09:46 INFO - 'USER': 'cltbld', 00:09:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:09:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:09:46 INFO - 'XPC_FLAGS': '0x0', 00:09:46 INFO - 'XPC_SERVICE_NAME': '0', 00:09:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:09:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:09: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 00:09: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 00:09: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 00:09: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 00:09: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 00:09: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 00:09:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:09:49 INFO - Installing collected packages: mozsystemmonitor 00:09:49 INFO - Running setup.py install for mozsystemmonitor 00:09:49 INFO - Successfully installed mozsystemmonitor 00:09:49 INFO - Cleaning up... 00:09:49 INFO - Return code: 0 00:09:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10fe1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe214c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec1d51190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbfd30>, '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 0x10fb22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcb5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/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.KLE7pVEefE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:09:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 00:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 00:09:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/Render', 00:09:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:09:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:09:49 INFO - 'HOME': '/Users/cltbld', 00:09:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:09:49 INFO - 'LOGNAME': 'cltbld', 00:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:09:49 INFO - 'MOZ_NO_REMOTE': '1', 00:09:49 INFO - 'NO_EM_RESTART': '1', 00:09:49 INFO - 'PAGER': '/bin/cat', 00:09:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:09:49 INFO - 'PWD': '/builds/slave/test', 00:09:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:09:49 INFO - 'SHELL': '/bin/bash', 00:09:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KLE7pVEefE/Listeners', 00:09:49 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 00:09:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:09:49 INFO - 'USER': 'cltbld', 00:09:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:09:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:09:49 INFO - 'XPC_FLAGS': '0x0', 00:09:49 INFO - 'XPC_SERVICE_NAME': '0', 00:09:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:09:49 INFO - Downloading/unpacking blobuploader==1.2.4 00:09:49 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 00:09:49 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 00:09:49 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 00:09:49 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 00:09:49 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 00:09:49 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 00:09:52 INFO - Downloading blobuploader-1.2.4.tar.gz 00:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:09:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:09:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:09:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:09:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:09:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:09:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:09:53 INFO - Downloading docopt-0.6.1.tar.gz 00:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:09:53 INFO - Installing collected packages: blobuploader, requests, docopt 00:09:53 INFO - Running setup.py install for blobuploader 00:09:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:09:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:09:53 INFO - Running setup.py install for requests 00:09:54 INFO - Running setup.py install for docopt 00:09:54 INFO - Successfully installed blobuploader requests docopt 00:09:54 INFO - Cleaning up... 00:09:54 INFO - Return code: 0 00:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:09:54 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')]} 00:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:54 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')]} 00:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x10fe1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe214c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec1d51190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbfd30>, '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 0x10fb22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcb5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/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.KLE7pVEefE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 00:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 00:09:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/Render', 00:09:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:09:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:09:54 INFO - 'HOME': '/Users/cltbld', 00:09:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:09:54 INFO - 'LOGNAME': 'cltbld', 00:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:09:54 INFO - 'MOZ_NO_REMOTE': '1', 00:09:54 INFO - 'NO_EM_RESTART': '1', 00:09:54 INFO - 'PAGER': '/bin/cat', 00:09:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:09:54 INFO - 'PWD': '/builds/slave/test', 00:09:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:09:54 INFO - 'SHELL': '/bin/bash', 00:09:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KLE7pVEefE/Listeners', 00:09:54 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 00:09:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:09:54 INFO - 'USER': 'cltbld', 00:09:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:09:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:09:54 INFO - 'XPC_FLAGS': '0x0', 00:09:54 INFO - 'XPC_SERVICE_NAME': '0', 00:09:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:09:54 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-mNrf3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:09:54 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-xYWoHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:09:54 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-w_4Twc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:09:54 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-cuvs2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:09:54 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Vx7pTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:09:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-QuGdd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:09:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-0SKrt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:09:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-0dzW7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:09:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-eRljVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:09:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-jn5b60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:09:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-hIAdWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:09:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-oTTwKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:09:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-F72W7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:09:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-_TntRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:09:55 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-6MWd6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:09:56 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-SiqazV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:09:56 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-_MtVQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:09:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:09:56 INFO - Running setup.py install for manifestparser 00:09:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:09:56 INFO - Running setup.py install for mozcrash 00:09:56 INFO - Running setup.py install for mozdebug 00:09:56 INFO - Running setup.py install for mozdevice 00:09:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:09:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:09:56 INFO - Running setup.py install for mozfile 00:09:57 INFO - Running setup.py install for mozhttpd 00:09:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:09:57 INFO - Running setup.py install for mozinfo 00:09:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:09:57 INFO - Running setup.py install for mozInstall 00:09:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:09:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:09:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:09:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:09:57 INFO - Running setup.py install for mozleak 00:09:57 INFO - Running setup.py install for mozlog 00:09:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:09:57 INFO - Running setup.py install for moznetwork 00:09:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:09:57 INFO - Running setup.py install for mozprocess 00:09:58 INFO - Running setup.py install for mozprofile 00:09:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:09:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:09:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:09:58 INFO - Running setup.py install for mozrunner 00:09:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:09:58 INFO - Running setup.py install for mozscreenshot 00:09:58 INFO - Running setup.py install for moztest 00:09:58 INFO - Running setup.py install for mozversion 00:09:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:09:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:09:58 INFO - Cleaning up... 00:09:58 INFO - Return code: 0 00:09:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:09:58 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')]} 00:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:58 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')]} 00:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10fe1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe214c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec1d51190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbfd30>, '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 0x10fb22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcb5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/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.KLE7pVEefE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:09:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 00:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 00:09:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/Render', 00:09:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:09:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:09:58 INFO - 'HOME': '/Users/cltbld', 00:09:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:09:58 INFO - 'LOGNAME': 'cltbld', 00:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:09:58 INFO - 'MOZ_NO_REMOTE': '1', 00:09:58 INFO - 'NO_EM_RESTART': '1', 00:09:58 INFO - 'PAGER': '/bin/cat', 00:09:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:09:58 INFO - 'PWD': '/builds/slave/test', 00:09:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:09:58 INFO - 'SHELL': '/bin/bash', 00:09:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KLE7pVEefE/Listeners', 00:09:58 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 00:09:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:09:58 INFO - 'USER': 'cltbld', 00:09:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:09:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:09:58 INFO - 'XPC_FLAGS': '0x0', 00:09:58 INFO - 'XPC_SERVICE_NAME': '0', 00:09:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:09:59 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-gO4T02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:09:59 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)) 00:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:09:59 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-hrisNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:09:59 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)) 00:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:09:59 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-jJKL1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:09:59 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)) 00:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:09:59 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-ZKMzue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 00:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:09:59 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-iz_MUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:09:59 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)) 00:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:09:59 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Ga_ipU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:09:59 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)) 00:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:09:59 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Pk1DZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:09:59 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)) 00:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:09:59 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-jwARNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:09:59 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)) 00:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:09:59 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-ludPuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:10:00 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)) 00:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:10:00 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Gi_ICQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:10:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:10:00 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-jZI_Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:10:00 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)) 00:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:10:00 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-isDNRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:10:00 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)) 00:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:10:00 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-2L7cwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:10:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 00:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:10:00 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-wV6eCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:10:00 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)) 00:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:10:00 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-fEY4lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:10:00 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)) 00:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:10:00 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Pa33NP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:10:00 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)) 00:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:10:00 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-BZ7pug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:10:00 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)) 00:10:00 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)) 00:10:00 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)) 00:10:00 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)) 00:10:00 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:10:00 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:10:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:10:00 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 00:10:00 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 00:10:00 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 00:10:00 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 00:10:00 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 00:10:00 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 00:10:03 INFO - Downloading blessings-1.6.tar.gz 00:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:10:03 INFO - Installing collected packages: blessings 00:10:03 INFO - Running setup.py install for blessings 00:10:03 INFO - Successfully installed blessings 00:10:03 INFO - Cleaning up... 00:10:04 INFO - Return code: 0 00:10:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:10:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:10:04 INFO - Reading from file tmpfile_stdout 00:10:04 INFO - Current package versions: 00:10:04 INFO - blessings == 1.6 00:10:04 INFO - blobuploader == 1.2.4 00:10:04 INFO - docopt == 0.6.1 00:10:04 INFO - manifestparser == 1.1 00:10:04 INFO - mozInstall == 1.12 00:10:04 INFO - mozcrash == 0.16 00:10:04 INFO - mozdebug == 0.1 00:10:04 INFO - mozdevice == 0.48 00:10:04 INFO - mozfile == 1.2 00:10:04 INFO - mozhttpd == 0.7 00:10:04 INFO - mozinfo == 0.9 00:10:04 INFO - mozleak == 0.1 00:10:04 INFO - mozlog == 3.1 00:10:04 INFO - moznetwork == 0.27 00:10:04 INFO - mozprocess == 0.22 00:10:04 INFO - mozprofile == 0.28 00:10:04 INFO - mozrunner == 6.11 00:10:04 INFO - mozscreenshot == 0.1 00:10:04 INFO - mozsystemmonitor == 0.0 00:10:04 INFO - moztest == 0.7 00:10:04 INFO - mozversion == 1.4 00:10:04 INFO - psutil == 3.1.1 00:10:04 INFO - requests == 1.2.3 00:10:04 INFO - wsgiref == 0.1.2 00:10:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:10:04 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')]} 00:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:04 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')]} 00:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10fe1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe214c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec1d51190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbfd30>, '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 0x10fb22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcb5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/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.KLE7pVEefE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 00:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 00:10:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/Render', 00:10:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:10:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:10:04 INFO - 'HOME': '/Users/cltbld', 00:10:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:10:04 INFO - 'LOGNAME': 'cltbld', 00:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:10:04 INFO - 'MOZ_NO_REMOTE': '1', 00:10:04 INFO - 'NO_EM_RESTART': '1', 00:10:04 INFO - 'PAGER': '/bin/cat', 00:10:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:10:04 INFO - 'PWD': '/builds/slave/test', 00:10:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:10:04 INFO - 'SHELL': '/bin/bash', 00:10:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KLE7pVEefE/Listeners', 00:10:04 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 00:10:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:10:04 INFO - 'USER': 'cltbld', 00:10:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:10:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:10:04 INFO - 'XPC_FLAGS': '0x0', 00:10:04 INFO - 'XPC_SERVICE_NAME': '0', 00:10:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:10:05 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 2)) 00:10:05 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 3)) 00:10:05 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 4)) 00:10:05 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 5)) 00:10:05 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 6)) 00:10:05 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 7)) 00:10:05 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 8)) 00:10:05 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 9)) 00:10:05 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:10:05 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 4)) 00:10:05 INFO - Cleaning up... 00:10:05 INFO - Return code: 0 00:10:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe214c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec1d51190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbfd30>, '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 0x10fb22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcb5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/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.KLE7pVEefE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test/build 00:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema 00:10:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/Render', 00:10:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:10:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:10:05 INFO - 'HOME': '/Users/cltbld', 00:10:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:10:05 INFO - 'LOGNAME': 'cltbld', 00:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:10:05 INFO - 'MOZ_NO_REMOTE': '1', 00:10:05 INFO - 'NO_EM_RESTART': '1', 00:10:05 INFO - 'PAGER': '/bin/cat', 00:10:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:10:05 INFO - 'PWD': '/builds/slave/test', 00:10:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:10:05 INFO - 'SHELL': '/bin/bash', 00:10:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KLE7pVEefE/Listeners', 00:10:05 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 00:10:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:10:05 INFO - 'USER': 'cltbld', 00:10:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:10:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:10:05 INFO - 'XPC_FLAGS': '0x0', 00:10:05 INFO - 'XPC_SERVICE_NAME': '0', 00:10:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:10:05 INFO - Downloading/unpacking jsonschema 00:10:05 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 00:10:05 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 00:10:05 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 00:10:05 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 00:10:05 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 00:10:05 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 00:10:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:10:07 INFO - Downloading/unpacking functools32 (from jsonschema) 00:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:10:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:10:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:10:08 INFO - Downloading functools32-3.2.3-2.tar.gz 00:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:10:08 INFO - warning: no files found matching '*.txt' 00:10:08 INFO - no previously-included directories found matching 'build' 00:10:08 INFO - no previously-included directories found matching 'dist' 00:10:08 INFO - no previously-included directories found matching '.git*' 00:10:08 INFO - Installing collected packages: jsonschema, functools32 00:10:08 INFO - Running setup.py install for functools32 00:10:08 INFO - warning: no files found matching '*.txt' 00:10:08 INFO - no previously-included directories found matching 'build' 00:10:08 INFO - no previously-included directories found matching 'dist' 00:10:08 INFO - no previously-included directories found matching '.git*' 00:10:08 INFO - Successfully installed jsonschema functools32 00:10:08 INFO - Cleaning up... 00:10:08 INFO - Return code: 0 00:10:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:10:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fe1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe214c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec1d51190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcbfd30>, '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 0x10fb22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcb5b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/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.KLE7pVEefE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:10:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'flake8'] in /builds/slave/test/build 00:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 flake8 00:10:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/Render', 00:10:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:10:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:10:08 INFO - 'HOME': '/Users/cltbld', 00:10:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:10:08 INFO - 'LOGNAME': 'cltbld', 00:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:10:08 INFO - 'MOZ_NO_REMOTE': '1', 00:10:08 INFO - 'NO_EM_RESTART': '1', 00:10:08 INFO - 'PAGER': '/bin/cat', 00:10:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:10:08 INFO - 'PWD': '/builds/slave/test', 00:10:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:10:08 INFO - 'SHELL': '/bin/bash', 00:10:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KLE7pVEefE/Listeners', 00:10:08 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 00:10:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:10:08 INFO - 'USER': 'cltbld', 00:10:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:10:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:10:08 INFO - 'XPC_FLAGS': '0x0', 00:10:08 INFO - 'XPC_SERVICE_NAME': '0', 00:10:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:10:08 INFO - Downloading/unpacking flake8 00:10:08 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 00:10:08 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 00:10:08 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 00:10:08 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 00:10:08 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 00:10:08 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 00:10:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:10:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:10:10 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 00:10:10 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 00:10:10 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 00:10:10 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 00:10:10 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 00:10:10 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 00:10:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:10:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:10:11 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 00:10:11 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 00:10:11 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 00:10:11 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 00:10:11 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 00:10:11 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 00:10:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:10:11 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 00:10:11 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 00:10:11 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 00:10:11 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 00:10:11 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 00:10:11 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 00:10:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:10:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:10:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:10:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:10:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:10:12 INFO - no previously-included directories found matching 'docs/_build' 00:10:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:10:12 INFO - Running setup.py install for pep8 00:10:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:10:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:10:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:10:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:10:12 INFO - no previously-included directories found matching 'docs/_build' 00:10:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:10:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:10:12 INFO - Cleaning up... 00:10:12 INFO - Return code: 0 00:10:12 INFO - Running post-action listener: _resource_record_post_action 00:10:12 INFO - Running post-action listener: _start_resource_monitoring 00:10:12 INFO - Starting resource monitoring. 00:10:12 INFO - ##### 00:10:12 INFO - ##### Running install step. 00:10:12 INFO - ##### 00:10:12 INFO - Running pre-action listener: _resource_record_pre_action 00:10:12 INFO - Running main action method: install 00:10:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:10:12 INFO - Reading from file tmpfile_stdout 00:10:12 INFO - Detecting whether we're running mozinstall >=1.0... 00:10:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:10:12 INFO - Reading from file tmpfile_stdout 00:10:12 INFO - Output received: 00:10:12 INFO - Usage: mozinstall [options] installer 00:10:12 INFO - Options: 00:10:12 INFO - -h, --help show this help message and exit 00:10:12 INFO - -d DEST, --destination=DEST 00:10:12 INFO - Directory to install application into. [default: 00:10:12 INFO - "/builds/slave/test"] 00:10:12 INFO - --app=APP Application being installed. [default: firefox] 00:10:12 INFO - mkdir: /builds/slave/test/build/application 00:10:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 00:10:46 INFO - Reading from file tmpfile_stdout 00:10:46 INFO - Output received: 00:10:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:10:46 INFO - Running post-action listener: _resource_record_post_action 00:10:46 INFO - ##### 00:10:46 INFO - ##### Running run-tests step. 00:10:46 INFO - ##### 00:10:46 INFO - Running pre-action listener: _resource_record_pre_action 00:10:46 INFO - Running main action method: run_tests 00:10:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:10:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:10:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:10:46 INFO - 2016-02-04 00:10:46.818 screenresolution[1654:8559] starting screenresolution argv=screenresolution get 00:10:46 INFO - 2016-02-04 00:10:46.821 screenresolution[1654:8559] Display 0: 1600x1200x32@60 00:10:46 INFO - 2016-02-04 00:10:46.827 screenresolution[1655:8561] starting screenresolution argv=screenresolution list 00:10:46 INFO - Available Modes on Display 0 00:10:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:10:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:10:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:10:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:10:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:10:47 INFO - Intel Iris: 00:10:47 INFO - Chipset Model: Intel Iris 00:10:47 INFO - Type: GPU 00:10:47 INFO - Bus: Built-In 00:10:47 INFO - VRAM (Dynamic, Max): 1536 MB 00:10:47 INFO - Vendor: Intel (0x8086) 00:10:47 INFO - Device ID: 0x0a2e 00:10:47 INFO - Revision ID: 0x0009 00:10:47 INFO - Displays: 00:10:47 INFO - Display: 00:10:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:10:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:10:47 INFO - Display Serial Number: 1600x1200 60 00:10:47 INFO - Main Display: Yes 00:10:47 INFO - Mirror: Off 00:10:47 INFO - Online: Yes 00:10:47 INFO - Rotation: Supported 00:10:47 INFO - Return code: 0 00:10:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:10:47 INFO - Python 2.7.3 00:10:47 INFO - Return code: 0 00:10:47 INFO - grabbing minidump binary from tooltool 00:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:10:47 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 0x10fcbfd30>, '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 0x10fb22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fcb5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:10:47 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 00:10:47 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 00:10:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:10:47 INFO - Return code: 0 00:10:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:10:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:10:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:10:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:10:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:10:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:10:48 INFO - Return code: 0 00:10:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 00:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0094 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:10:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8rYkfBvt7I/Render', 00:10:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:10:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:10:48 INFO - 'HOME': '/Users/cltbld', 00:10:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:10:48 INFO - 'LOGNAME': 'cltbld', 00:10:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:10:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:10:48 INFO - 'MOZ_NO_REMOTE': '1', 00:10:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:10:48 INFO - 'NO_EM_RESTART': '1', 00:10:48 INFO - 'PAGER': '/bin/cat', 00:10:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:10:48 INFO - 'PWD': '/builds/slave/test', 00:10:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:10:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:10:48 INFO - 'SHELL': '/bin/bash', 00:10:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KLE7pVEefE/Listeners', 00:10:48 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 00:10:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:10:48 INFO - 'USER': 'cltbld', 00:10:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:10:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:10:48 INFO - 'XPC_FLAGS': '0x0', 00:10:48 INFO - 'XPC_SERVICE_NAME': '0', 00:10:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:10:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:10:48 INFO - mozversion application_buildid: 20160203231628 00:10:48 INFO - mozversion application_changeset: 03297f8c28a08d2b39a252c7b368524d9e69da69 00:10:48 INFO - mozversion application_display_name: Nightly 00:10:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:10:48 INFO - mozversion application_name: Firefox 00:10:48 INFO - mozversion application_remotingname: firefox 00:10:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:10:48 INFO - mozversion application_vendor: Mozilla 00:10:48 INFO - mozversion application_version: 47.0a1 00:10:48 INFO - mozversion platform_buildid: 20160203231628 00:10:48 INFO - mozversion platform_changeset: 03297f8c28a08d2b39a252c7b368524d9e69da69 00:10:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:10:48 INFO - mozversion platform_version: 47.0a1 00:10:48 INFO - using testdate: 1454573448 00:10:48 INFO - actual date: 1454573448 00:10:48 INFO - starting webserver on 'localhost:49274' 00:10:48 INFO - SUITE-START | Running 2 tests 00:10:48 INFO - TEST-START | dromaeo_css 00:10:48 INFO - operating with platform_type : mac_ 00:10:48 INFO - Initialising browser for dromaeo_css test... 00:10:48 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpnBS4WX/profile http://localhost:49274/getInfo.html) 00:10:48 INFO - PROCESS | 1673 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 00:10:51 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 00:10:51 INFO - PROCESS | 1673 | colorDepth:24 00:10:51 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 00:10:51 INFO - PROCESS | 1673 | __metrics 00:10:52 INFO - PROCESS | 1673 | 00:10:52 INFO - PROCESS | 1673 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 00:10:52 INFO - PROCESS | 1673 | 00:10:52 INFO - TEST-INFO | 1673: exit 0 00:10:52 INFO - Browser initialized. 00:10:52 INFO - Running cycle 1/1 for dromaeo_css test... 00:10:52 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpnBS4WX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:11:04 INFO - PROCESS | 1678 | RSS: Main: 256020480 00:11:04 INFO - PROCESS | 1678 | 00:11:54 INFO - PROCESS | 1678 | 1454573514105 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] 00:14:05 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 00:14:06 INFO - PROCESS | 1678 | RSS: Main: 269099008 00:14:06 INFO - PROCESS | 1678 | 00:17:08 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 00:17:08 INFO - PROCESS | 1678 | RSS: Main: 281579520 00:17:08 INFO - PROCESS | 1678 | 00:20:10 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 00:20:11 INFO - PROCESS | 1678 | RSS: Main: 283299840 00:20:11 INFO - PROCESS | 1678 | 00:23:12 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 00:23:13 INFO - PROCESS | 1678 | RSS: Main: 288129024 00:23:13 INFO - PROCESS | 1678 | 00:26:15 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 00:26:16 INFO - PROCESS | 1678 | RSS: Main: 286760960 00:26:16 INFO - PROCESS | 1678 | 00:29:19 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 00:29:19 INFO - PROCESS | 1678 | RSS: Main: 290369536 00:29:19 INFO - PROCESS | 1678 | 00:29:19 INFO - PROCESS | 1678 | __start_tp_report 00:29:19 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 00:29:19 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 00:29:19 INFO - PROCESS | 1678 | |i|pagename|runs| 00:29:19 INFO - PROCESS | 1678 | |0;dojo.html;3375.1730825947648;3521.5421995140628;3553.769005014672;3574.1064733816547;3580.4808302796096;5701.486866182043;5743.684097374643;5756.136579513075;5761.884762304751;5765.6540607563575;4780.593649539785;5582.441755824426;5708.600397972144;5733.254676892008;5781.78582497675;5172.40517340505;5219.921701174486;5259.815906443275;5260.658057226287;5323.973380133094;4316.309390497521;5222.190560463116;5288.92066619001;5291.28567643367;5292.444293349201;4134.297169481196;4140.979295103535;5206.479352064801;5232.790688372461;5249.370075590915;5194.896102077975;5205.791768329263;5210.062188806013;5231.738413079331;5241.318628578299;4285.871423857289;5219.451957544441;5233.947660523384;5258.13240815265;5268.736563171864;5438.83683489492;5523.696196709179;5551.8889622207325;5653.208550802891;5689.374168841466;5331.493508116761;6240.843978900519;6248.437640612321;6252.187215661935;6272.529560282951;6074.088886667036;6179.412955769195;6197.473214776749;6219.440250377443;6234.906476402857;5783.161441590946;5811.27359080115;5874.265716785402;5898.938191125553;5949.672767997715;6256.374362563798;6262.2172228471445;6262.5929314594405;6274.215723034621;6295.433410993032;6019.367966363557;6052.788152414732;6191.226096737908;6200.348963358872;6203.16257305267;5257.237700533401;6153.230846144232;6221.47117495018;6263.4362907338555;6310.810675679737;6159.29168145669;6227.034809604518;6239.937600623935;6240.032794916795;6241.126242326078;6141.293751218578;6144.7264512129905;6201.472874805602;6260.342664020303;6266.905996410058;4887.169181239198;4897.5592196701755;4909.116359055333;4916.532929371704;4936.086823937583;4368.584984426474;4382;4408.603225709701;4424.469063712375;4462.196804575207;5693.914591281134;5740.339860915965;5771.68255745938;5824.504917082011;5902.114682797529;6180.536459765535;6213.340642364157;6257.124002639634;6259.374062593704;6260.311365749764;4851;5608.607397482218;5835.883282334329;5865.736041878125;5871.794487192928;5260.210968354778;5331.866703332447;5362.249285100089;5403.675779453167;5425.159100339453;6323.557350985387;6345.524085693592;6356.555041147075;6363.013732871227;6367.681615919279;6110.40687992437;6196.86923302677;6249.1563638908165;6260.060990851409;6261.718222680081;6220.906686399617;6276.780312689034;6329.240491141092;6361.300256971637;6363.204599425072;6166.568340216142;6230.00319948806;6230.937690623035;6240.906386404116;6243.687815609111;6087.786927457518;6196.1635179250225;6233.563650544418;6238.376162383725;6247.781327653511;6103.91351630514;6157.384261573986;6165.84585385369;6169.691515424301;6183.690815459299;6101.969490152521;6106.786262480792;6150.661713605795;6155.446009859134;6159.476444502267;5751.1373294006235;5773.769049237983;5923.496502797138;6022.307434644897;6074.544409169242;6079.057547418048;6101.661245064722;6110.042400473335;6118.101457354478;6164.568480206342;5309.893802123858;6006;6066.514678825772;6070.3019152798;6086.908696369646 00:29:19 INFO - PROCESS | 1678 | |1;ext.html;445.22975252812614;464.9744264065476;483.61069339181967;518.3002946022872;554.7753159970212;38006;38864.834054978324;38866.417003744966;38888;39010;41370.37944430828;41439.75680729575;41745.373819392655;41996.790016049956;42175;9031.548422578877;9493.003234660366;9582.472963986995;9741.464219467927;9796.216302695768;9832.90167098327;9984.90015099847;9986.600535978552;10004.949975250114;10006.099451049404;9882.407055576688;9992.650257240997;10005.44970026652;10027.097561219489;10057.245706572;9873.555689993967;9958.751031224205;9967.501624918797;9972.252081093911;9999.2000639949;9639.421634701941;9750.609975600968;9753.414795112316;9772.31593788435;9802.36284641496;39558.40662390037;39864;39960.000999974945;40013.59986400128;40116.79941600273;3233.159378561591;3401.200717831308;3418.1967237699123;3625.4199328107375;3638.8362523686496;28441.571357533565;28666.85666571654;29373.412531749247;29421.70578294211;29797.255068623243;2821.271554821987;2852.857357132135;2854.957175642367;2867.5411934090653;2915.839628820414;467898;469338;473057;474095;474393.6280318576;43144;57349.71325143431;64683;64727.67636161789;67728.66135669389;69586.30413695799;69957.95063074058;70199.64900175466;70443;70826.291737083;15922.522324330288;16433.753493697604;16578.419755308507;16579.6684066318;16603.916980415263;12850;12930.353482325847;12950;13019.609411717664;13038.869611303955;20373.796262037486;20419.183232670526;20686.275980340615;20767.58464830695;20770.48073798137;7735.878297646922;8305.134728518651;8331.126026397633;8339.166083391734;8406.915930840736;974.3228456222857;1006.6577363696379;1031.3605564550028;1126.099120703434;1128.2440764687678;25676.614850777252;27425.725742742317;29571.373574453613;30126;30263.546046809315;964.8614634731084;1076.784643071389;1080.3895798873612;1122.550979608147;1149.7298134938283;15120.621984450478;15170.696586068218;15539.766903496457;15684.372625095097;15856.762148567781;409756;412695;413048.9347553243;415989;417630;57389.71305143531;57486.71256643774;57786.422135778106;57993.71003144957;58429.41570584325;1377.572952384744;1406.465543093618;1408.499982506216;1439.0933711761732;1571.5442521668588;23994.880025600458;25945.870270648527;29513.85243073771;30718.23204419818;30775.846120769253;50292;51216.46350609488;51618;51643.967120658126;51667.96664066773;475092;475227;476668;478076;479128;28077.859610701817;32163.51754723728;33212.50181247332;33535.83232083824;33780.98657040195;38517.61482385252;43566;45081;45171.870703232686;45783;29348.853255733586;34098.48852267169;35262;35491.290174195856;35528.46707299341;26009;34279;34922.301553969286;34944.82527587346;36924;34536;35218.11954701153;35307.646923531465;35501.82249088738;35629;24805.118217543895;30804.84597576998;31744.365112697156;32070;32211.67788322087;24420.26739197827;24436.26691199267;24603.50792984166;24656.753432466165;24712.629310559998 00:29:19 INFO - PROCESS | 1678 | |2;jquery.html;330.616484877542;363.34416378436913;367.3615674093543;367.9742418030737;372.1644907183374;15490.845091549081;18693.158807853644;18859.52851178721;19870.602587948233;20210.494737631547;11657.591984280552;18845.434636960912;19234.519137021547;19330.613387732235;19356.3225287115;5242.213667949819;5296.947030529704;5308.389535203462;5406.83779486616;5412.431694672042;4387.605115539601;5342.412334643186;5346.609881430836;5846.88306233875;6053.667048312341;5948.940510594882;6006.7897623583185;6027.457528822405;6269.811905642838;6315.179026726519;6103.267607887082;6416;6428.292887782341;6450.032495125745;6470.967645161768;5664.801731939404;5689.260396148516;5689.687067211302;5711.086226203787;5776.42235776419;12828.486860525662;13251;13421.39603717835;13423.597292081253;13426.992975526875;2232.5311684546264;2286.0284379138966;2439.658447817307;2498.650188973545;2643.7488438598493;9065.59204835784;9242.815143697155;9644.469554174517;9990.400575965465;10262.897371026269;1755.3768412213608;1772.1936518883876;1785.4108144312345;1795.838374546297;1805.2778888444595;81457;81564;84769.30461390737;86535;95206.52396738042;8741.562921853882;10648.414337211529;11127;11146.832797508045;11265.042471390023;11132.554697812158;12619;13351.132176408502;13446.32768361578;13521.459141634225;7774.455788094779;7915.248051435105;7955.801104972306;7992.560409177551;8020.719274825353;7905.525668459911;7987.3610111190965;8019.438639295194;8056.154103819132;8068.798280043045;3907.33575292201;4072.450219220427;4131.5248746393945;4329.588689074533;4477.417935668407;1748.379325339486;1893.384649988759;1898;1901;1907.523119220195;852.3692467573951;893.4058850864103;927.8144371125802;993.4238141877838;1071.8552995345685;17901.910490447724;17960.742748007513;18954.052297385075;19435.931023793546;19505.707414388795;946.8769060022291;948.8197242523898;974.7075877236942;975.4683697384942;976.097110173087;10103.646372376932;10325.432101234353;10464.372137671764;10573;10601.151907847354;610073;622155;626789;630549;632834;63814.042789358195;67849.66075169592;87635.1236487627;103603.96396036094;106319.4684026575;491.5109466081272;503.7053323805541;511.19742005052456;516.1277441124563;1203.4764877278412;11034.117270618171;11170.720731981766;11188.720281993015;11308.604198853001;11312.434378280888;42108.57891421046;48945;50819.74590127026;52314.738426307624;53523.19715204197;64369.67815161082;65966.67016664887;66473.66763166153;74866.25133748593;75935;7433.219511951167;7596.316331530189;7632.465727399029;7640.885386719093;7653.732119375795;9474.289428293043;11486.712832179262;11762.70593235176;11855.34795586251;11886.405679716152;8105.230003149692;9893.554790034323;10063.647772327933;10066.043725846033;10159.84760228612;9357.485338306458;9706.466144361846;9961.708687652468;10386.376817390981;10490.790184196427;8204.671813127647;9901.653442129491;10441.060304572626;10517.842232366675;10673.839892401465;7619.161892191743;7750.612469376621;7751.457397982087;7778.377729781717;7793.376529877482;8563.486190828571;8571.742847714579;9112.362134650512;9300.255979521487;10355.223358248311 00:29:19 INFO - PROCESS | 1678 | |3;mootools.html;1374.1823614949108;1511.969760604788;1698.2612563534856;1698.7621732957389;1939.854510911682;7151.4993950423495;7772.494787838787;7940.960295198531;8767.736967890965;8792;8408.285295749869;8513.318934485242;8620.267277281422;8649.740507784762;8664.436811607256;2468.333549941515;2504.7745702886737;2506.7117281512587;2507.2979565721625;2512.5351809915132;2265.9350105450494;2379.5597814404305;2422.103821586016;2485.5898776701824;2498.100683753856;2035.5013021809602;2398.388410955204;2446.657467954488;2462.4213309872166;2481.2928315430104;2155.299527653519;2382.7855493005713;2466.901323947049;2472.5178590174924;2491.0783010286127;2457.594496908008;2474.8391354562077;2477.355887469253;2477.7150627677865;2487.6890388701413;8688.261497772697;8762;8806.471611703255;8808.295336373074;8811;5339;5361.544268737162;5475.370332411784;5476.424975377608;5511.614187006911;3656.213914008474;3695.870644527429;3749.850005999757;3770.1517158639363;3777.1690228149764;1049.0872940541701;1065.2277099103167;1074.5003573338356;1089.1667874076338;1109.2346281066039;11683.766324673545;12060.914517693362;12112.81830772539;12117.33354665493;12126.029917606571;4157.542670306264;4789.760511974457;4902.803887844446;4963.213243232433;4998.825041123616;10201.897981020244;10234.130098941674;10259.384436933658;10261.9486902565;10263.178945684327;5430.456954304538;5456;5467.535259502987;5495.395506494282;5510.614257002052;4346.826126954949;4478.238699421041;4845.1278769821065;4945.184044632595;4990.5508504234795;3325.434676105068;3884.2814079395403;3949.881503554898;3961.782101984361;4007.998000499875;1243.3720970909633;1319.327143156997;1324.576135636587;1331.8268625078679;1334.3461703765086;1318.5055604148445;1327.6415367850627;1335.6660834791303;1340.8659134086513;1356.6811799227173;7847.097583777939;8115.188481151956;8281.420300578902;8310.168983101641;8335.49987000782;1175.3183153770792;1177.581958404754;1193.3436609864714;1194;1214.726686495549;6212.254529456403;6239.095331176954;6251.187345645037;6318.052292156121;6332.366763323631;10321.94839025815;10538.31500952451;10555.313904596176;10601.098906593026;10602.628907988183;7778.8833167502535;10435.269531132899;10516.316439431412;10637.734056648645;10667.19996000303;7962.044554653363;8092.069412017693;8158.061822890443;8177.182281771775;8201.056878458934;6768.763093291711;7927.762167134995;7982.600869956363;7991.64037618297;8048.5170889746805;7857.33212676906;9079.54602269897;9476.857847132436;9516.33385662997;9672.661456848977;9409.764755881159;9648.903510964801;9650.179734722627;10027.29808913369;10029.29794914349;6210.192674952227;6754.93245067543;6950.687219075053;7217.67520461591;7659.617019148909;7965.004374453193;8134.877976830234;8185.71350002747;8231.547264900488;8235.094139644514;7333.4499912507845;7764.805879853049;7788.182240864628;7795.181505942021;7807.063152421746;7567.243275672388;7568.697252109854;7576.924230757842;7666.233376662289;7699.26856948589;6468.353164683682;7648.847023059619;7667.654955526903;7694;7709.845803084019;6881.518293719391;7017.614031228331;7033.261507541839;7038.120234970629;7093.042439270633;7102.857942841218;7115.53749006313;7164.140303163445;7180;7180.389666878374 00:29:19 INFO - PROCESS | 1678 | |4;prototype.html;320.31133063912586;323.71351354051654;325.7475456521196;326.1308612547558;330.99338013239736;6385.106085148083;6512.185976752906;6580.901286480706;6591.868162636744;6656.367645073717;6345.619262844232;6502.707378167982;6514.055461958013;6536.281009089008;6569.704363303651;4839.693282813638;4851.951480485185;4864.221724524077;4867.440244371898;4887.095887260851;4857.951420485785;4873.342098816667;4874.098291816008;4882.535239428175;4884.780184891689;4533.727976321431;4706.835260765857;4714.764261786914;4716.882077948062;4718.740469274188;4720.1975664136835;4720.98498822753;4724.90550188996;4731.455882573497;4764.475907650156;3849.8267577958777;3935.05558665921;3947.052707350244;4046.979765101185;4052.9392059119136;6135.962698464245;6163.414475624809;6183.319834818167;6184.226971628546;6195.87608247837;5506.972465137648;5535.557155427556;5544.722763861791;5554.416786237427;5562.582806289504;5591.776328946838;6725.361090696376;6893.931060689379;6934.47991400642;6944.548604340702;3691.8523259069607;4456;4466.285394336891;4483;4500.662450316239;5407.594430417735;7206.49554531183;7270.236625154388;7344.4491663124945;7358.521696089791;3426.777259478176;4541.250693635513;4557.977210113994;4564.881604006973;4570.497245303014;4455.1980643484485;4627.583517483443;4638.582527572467;4659.161350956792;4681.695689780154;5525.309336332958;5550.278463799761;5554.2779438672715;5580;5581.860453488614;6068.666223357669;6451.129097571861;6884.139482564679;6926.376626103574;6946.444284457332;1586.8968517046355;1618.368836153901;1618.8623966962705;1620.959476013109;1622.2861940746034;998.9150922171551;1029.4904022508906;1034.9016843399866;1038.6209033702644;1049.3074570783247;6402.743890244338;6462.967685161544;6471;6517.478601711851;6527.314631963575;7114.893276600855;7122;7127.394171495377;7167.641617919083;7179;6249.406306400975;6397.488200943913;6430;6440;6466.094746735461;3620;3708.1100535871738;3737.1404576947452;3748.194138260287;3753;7367.963160184272;7470.6264686766535;7567.659455324413;7573.431992600577;7601.163871974079;6111.236095488064;7155.676199903035;7492.737754178577;7601.733939312208;7633.6564854581675;7452.552846829208;7716.459847810599;7739.226077392215;7750.418718596128;7755.612219389008;7254.492185546961;7264.963675181591;7277.199508054216;7291.708331666674;7333.523320984119;7108.537945033556;7190.892136618059;7193.712251509881;7203.855922881408;7218.602976836324;7415;7688.769336919901;7710.8843367350655;7719.922800772145;7754.34088102495;4592.173408786451;4598.678092533491;4599.149157405891;4613.861584152481;4622.907541849077;7248.927510724825;7279.526830755984;7296.124465064227;7309.305615966475;7343.70625174987;6722.462203023844;6973.6164510952385;6999.930000700131;7008.789736307919;7013.859722805618;7023.33278338557;7148.714051437884;7151.463640227108;7164.641767911688;7187.712491500491;5666.631668941505;6653.101831252912;6773.356531129535;6858.2455929848675;6874.346937040973;7021.192562855337;7024.613646249505;7046.4010559101;7057.435405167677;7064.116985376828;6835.07726456922;6878.27778083294;6895.275996020346;6922.307769223037;6939.028536005064 00:29:19 INFO - PROCESS | 1678 | |5;yui.html;734.4858598980715;736.554384597319;739.0785295705717;755.4862693368509;755.701497908326;12211.755764884698;13015.804762928552;14813.92593037036;14878.330475128618;15064.2467876606;12504.06219533534;13435.865641343584;13550.525731599397;13570.592882213525;13620;769.6690423118071;891.8394688955985;893.8882639670041;894.061235702513;897.2373482539854;704.5737328916009;716.4018044932487;863.7365603490932;887.2547060469204;901.2249465459699;922.9985465769648;926.865604487349;927.0868194828089;934.5047125023714;937.3719607862714;909.4588719711761;913.4793167894303;924.958376873039;927.7819712367589;929.1916033051222;614.0114415790573;623.3019018699041;686.5983399711175;686.6875571614903;692.9203141638726;15023.248837558078;15156.1664108474;15170.24148792567;15199.012064215902;15216.695666086727;12043.277403355827;12103.608085070242;12979.805302920464;12980.28608426536;13196.934015329958;10021.89978100217;10197.541110650038;10366.896331036669;10464.267501274913;10859.511321990529;3584.9641503585153;3599.848048624441;3661.5972243053243;3663.7435379523445;3726.571444283915;78031;78320;78650.82023769648;78897;79520.99999999942;9687.273454490942;9769.951150244346;9841.261905357127;9949.253805964438;10374.533146008447;21699.45751356197;21901.12395504162;21925.671114933288;21956.79237641913;22005.559888802134;7118.466115041289;7405.1854296027395;7414.295641914009;7674.654640541077;7817.921820781719;4060.5127384713433;4121.8969525761495;4129.876103716893;4134.503859536815;4280.657547396201;3525.8765943191866;3562.5190599269285;3591.892243232707;3603.4234522476804;3606.386914224588;650.391883588846;659.0904551718694;662.2582707367683;665.1486097794831;674.8380388706773;513.7585334892594;543.6792292547337;560.7840981222258;573.6730063863641;640.7340953504337;8392.412531122764;8491.95754021226;8675.002374726988;8679.956600216958;8797.912020879838;507.58631715152035;516.3004129404678;579.1978110317241;625.6996641612052;625.7590827531433;3914.7651140931634;3930.449737036817;4325.956740432555;4340.153670034376;4388.670849686287;71375;90722;91254;92206.15587688342;92598;77523;78367.216327836;79019.60490197512;79126.4174716514;80099.59950200212;65091.67454162794;65208.347916521176;65652.67173664196;72704.90942635864;73092;8742.868856967278;8828.779280518038;8869.955650221707;8883.73348799537;8906.777330566787;49023.754881225366;49040.5095949036;49358.506414936826;49841.75079124581;50469.49530504648;67744;68447;68470.63058738897;68614;68715.31284687089;10849.349039057683;10882.45587720595;10954.616588419685;11028.062614677521;11124.944375278072;10084.647037353658;12196.90227879495;12406.751864962469;12443.564475243324;12683.048771342003;9692.273079518924;11288.548458061585;11540.365279909685;11676.474558644712;11805.114616403633;9423.57593908262;11623.895729905646;11657.708557286136;11668.533258669559;11696.766064678828;11478;11514.424278786195;11554.942225289156;11566.42167891619;11605.477753500943;9332.253419726541;9347.719568412958;9634.373765705486;9753.609855605697;9800.852987205055;8266.958665206635;9337.71986840396;9844.261680374144;9851.556679949275;9938 00:29:19 INFO - PROCESS | 1678 | __end_tp_report 00:29:19 INFO - PROCESS | 1678 | __start_cc_report 00:29:19 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,339 00:29:19 INFO - PROCESS | 1678 | __end_cc_report 00:29:19 INFO - PROCESS | 1678 | __startTimestamp1454574559529__endTimestamp 00:29:19 INFO - PROCESS | 1678 | 00:29:19 INFO - PROCESS | 1678 | ------- Summary: start ------- 00:29:19 INFO - PROCESS | 1678 | Number of tests: 6 00:29:19 INFO - PROCESS | 1678 | 00:29:19 INFO - PROCESS | 1678 | [#0] dojo.html Cycles:165 Average:5713.82 Median:6019.37 stddev:669.19 (11.1%) stddev-sans-first:645.60 00:29:19 INFO - PROCESS | 1678 | Values: 3375.2 3521.5 3553.8 3574.1 3580.5 5701.5 5743.7 5756.1 5761.9 5765.7 4780.6 5582.4 5708.6 5733.3 5781.8 5172.4 5219.9 5259.8 5260.7 5324.0 4316.3 5222.2 5288.9 5291.3 5292.4 4134.3 4141.0 5206.5 5232.8 5249.4 5194.9 5205.8 5210.1 5231.7 5241.3 4285.9 5219.5 5233.9 5258.1 5268.7 5438.8 5523.7 5551.9 5653.2 5689.4 5331.5 6240.8 6248.4 6252.2 6272.5 6074.1 6179.4 6197.5 6219.4 6234.9 5783.2 5811.3 5874.3 5898.9 5949.7 6256.4 6262.2 6262.6 6274.2 6295.4 6019.4 6052.8 6191.2 6200.3 6203.2 5257.2 6153.2 6221.5 6263.4 6310.8 6159.3 6227.0 6239.9 6240.0 6241.1 6141.3 6144.7 6201.5 6260.3 6266.9 4887.2 4897.6 4909.1 4916.5 4936.1 4368.6 4382.0 4408.6 4424.5 4462.2 5693.9 5740.3 5771.7 5824.5 5902.1 6180.5 6213.3 6257.1 6259.4 6260.3 4851.0 5608.6 5835.9 5865.7 5871.8 5260.2 5331.9 5362.2 5403.7 5425.2 6323.6 6345.5 6356.6 6363.0 6367.7 6110.4 6196.9 6249.2 6260.1 6261.7 6220.9 6276.8 6329.2 6361.3 6363.2 6166.6 6230.0 6230.9 6240.9 6243.7 6087.8 6196.2 6233.6 6238.4 6247.8 6103.9 6157.4 6165.8 6169.7 6183.7 6102.0 6106.8 6150.7 6155.4 6159.5 5751.1 5773.8 5923.5 6022.3 6074.5 6079.1 6101.7 6110.0 6118.1 6164.6 5309.9 6006.0 6066.5 6070.3 6086.9 00:29:19 INFO - PROCESS | 1678 | 00:29:19 INFO - PROCESS | 1678 | [#1] ext.html Cycles:180 Average:60391.65 Median:3632.13 stddev:120684.73 (3322.7%) stddev-sans-first:120939.36 00:29:19 INFO - PROCESS | 1678 | Values: 445.2 465.0 483.6 518.3 554.8 38006.0 38864.8 38866.4 38888.0 39010.0 41370.4 41439.8 41745.4 41996.8 42175.0 9031.5 9493.0 9582.5 9741.5 9796.2 9832.9 9984.9 9986.6 10004.9 10006.1 9882.4 9992.7 10005.4 10027.1 10057.2 9873.6 9958.8 9967.5 9972.3 9999.2 9639.4 9750.6 9753.4 9772.3 9802.4 39558.4 39864.0 39960.0 40013.6 40116.8 3233.2 3401.2 3418.2 3625.4 3638.8 28441.6 28666.9 29373.4 29421.7 29797.3 2821.3 2852.9 2855.0 2867.5 2915.8 467898.0 469338.0 473057.0 474095.0 474393.6 43144.0 57349.7 64683.0 64727.7 67728.7 69586.3 69958.0 70199.6 70443.0 70826.3 15922.5 16433.8 16578.4 16579.7 16603.9 12850.0 12930.4 12950.0 13019.6 13038.9 20373.8 20419.2 20686.3 20767.6 20770.5 7735.9 8305.1 8331.1 8339.2 8406.9 974.3 1006.7 1031.4 1126.1 1128.2 25676.6 27425.7 29571.4 30126.0 30263.5 964.9 1076.8 1080.4 1122.6 1149.7 15120.6 15170.7 15539.8 15684.4 15856.8 409756.0 412695.0 413048.9 415989.0 417630.0 57389.7 57486.7 57786.4 57993.7 58429.4 1377.6 1406.5 1408.5 1439.1 1571.5 23994.9 25945.9 29513.9 30718.2 30775.8 50292.0 51216.5 51618.0 51644.0 51668.0 475092.0 475227.0 476668.0 478076.0 479128.0 28077.9 32163.5 33212.5 33535.8 33781.0 38517.6 43566.0 45081.0 45171.9 45783.0 29348.9 34098.5 35262.0 35491.3 35528.5 26009.0 34279.0 34922.3 34944.8 36924.0 34536.0 35218.1 35307.6 35501.8 35629.0 24805.1 30804.8 31744.4 32070.0 32211.7 24420.3 24436.3 24603.5 24656.8 24712.6 00:29:19 INFO - PROCESS | 1678 | 00:29:19 INFO - PROCESS | 1678 | [#2] jquery.html Cycles:180 Average:32269.72 Median:28778.48 stddev:102717.38 (356.9%) stddev-sans-first:102977.53 00:29:19 INFO - PROCESS | 1678 | Values: 330.6 363.3 367.4 368.0 372.2 15490.8 18693.2 18859.5 19870.6 20210.5 11657.6 18845.4 19234.5 19330.6 19356.3 5242.2 5296.9 5308.4 5406.8 5412.4 4387.6 5342.4 5346.6 5846.9 6053.7 5948.9 6006.8 6027.5 6269.8 6315.2 6103.3 6416.0 6428.3 6450.0 6471.0 5664.8 5689.3 5689.7 5711.1 5776.4 12828.5 13251.0 13421.4 13423.6 13427.0 2232.5 2286.0 2439.7 2498.7 2643.7 9065.6 9242.8 9644.5 9990.4 10262.9 1755.4 1772.2 1785.4 1795.8 1805.3 81457.0 81564.0 84769.3 86535.0 95206.5 8741.6 10648.4 11127.0 11146.8 11265.0 11132.6 12619.0 13351.1 13446.3 13521.5 7774.5 7915.2 7955.8 7992.6 8020.7 7905.5 7987.4 8019.4 8056.2 8068.8 3907.3 4072.5 4131.5 4329.6 4477.4 1748.4 1893.4 1898.0 1901.0 1907.5 852.4 893.4 927.8 993.4 1071.9 17901.9 17960.7 18954.1 19435.9 19505.7 946.9 948.8 974.7 975.5 976.1 10103.6 10325.4 10464.4 10573.0 10601.2 610073.0 622155.0 626789.0 630549.0 632834.0 63814.0 67849.7 87635.1 103604.0 106319.5 491.5 503.7 511.2 516.1 1203.5 11034.1 11170.7 11188.7 11308.6 11312.4 42108.6 48945.0 50819.7 52314.7 53523.2 64369.7 65966.7 66473.7 74866.3 75935.0 7433.2 7596.3 7632.5 7640.9 7653.7 9474.3 11486.7 11762.7 11855.3 11886.4 8105.2 9893.6 10063.6 10066.0 10159.8 9357.5 9706.5 9961.7 10386.4 10490.8 8204.7 9901.7 10441.1 10517.8 10673.8 7619.2 7750.6 7751.5 7778.4 7793.4 8563.5 8571.7 9112.4 9300.3 10355.2 00:29:19 INFO - PROCESS | 1678 | 00:29:19 INFO - PROCESS | 1678 | [#3] mootools.html Cycles:180 Average:6002.21 Median:5168.91 stddev:3135.07 (60.7%) stddev-sans-first:3124.56 00:29:19 INFO - PROCESS | 1678 | Values: 1374.2 1512.0 1698.3 1698.8 1939.9 7151.5 7772.5 7941.0 8767.7 8792.0 8408.3 8513.3 8620.3 8649.7 8664.4 2468.3 2504.8 2506.7 2507.3 2512.5 2265.9 2379.6 2422.1 2485.6 2498.1 2035.5 2398.4 2446.7 2462.4 2481.3 2155.3 2382.8 2466.9 2472.5 2491.1 2457.6 2474.8 2477.4 2477.7 2487.7 8688.3 8762.0 8806.5 8808.3 8811.0 5339.0 5361.5 5475.4 5476.4 5511.6 3656.2 3695.9 3749.9 3770.2 3777.2 1049.1 1065.2 1074.5 1089.2 1109.2 11683.8 12060.9 12112.8 12117.3 12126.0 4157.5 4789.8 4902.8 4963.2 4998.8 10201.9 10234.1 10259.4 10261.9 10263.2 5430.5 5456.0 5467.5 5495.4 5510.6 4346.8 4478.2 4845.1 4945.2 4990.6 3325.4 3884.3 3949.9 3961.8 4008.0 1243.4 1319.3 1324.6 1331.8 1334.3 1318.5 1327.6 1335.7 1340.9 1356.7 7847.1 8115.2 8281.4 8310.2 8335.5 1175.3 1177.6 1193.3 1194.0 1214.7 6212.3 6239.1 6251.2 6318.1 6332.4 10321.9 10538.3 10555.3 10601.1 10602.6 7778.9 10435.3 10516.3 10637.7 10667.2 7962.0 8092.1 8158.1 8177.2 8201.1 6768.8 7927.8 7982.6 7991.6 8048.5 7857.3 9079.5 9476.9 9516.3 9672.7 9409.8 9648.9 9650.2 10027.3 10029.3 6210.2 6754.9 6950.7 7217.7 7659.6 7965.0 8134.9 8185.7 8231.5 8235.1 7333.4 7764.8 7788.2 7795.2 7807.1 7567.2 7568.7 7576.9 7666.2 7699.3 6468.4 7648.8 7667.7 7694.0 7709.8 6881.5 7017.6 7033.3 7038.1 7093.0 7102.9 7115.5 7164.1 7180.0 7180.4 00:29:19 INFO - PROCESS | 1678 | 00:29:19 INFO - PROCESS | 1678 | [#4] prototype.html Cycles:180 Average:5682.83 Median:6445.56 stddev:1845.45 (28.6%) stddev-sans-first:1806.20 00:29:19 INFO - PROCESS | 1678 | Values: 320.3 323.7 325.7 326.1 331.0 6385.1 6512.2 6580.9 6591.9 6656.4 6345.6 6502.7 6514.1 6536.3 6569.7 4839.7 4852.0 4864.2 4867.4 4887.1 4858.0 4873.3 4874.1 4882.5 4884.8 4533.7 4706.8 4714.8 4716.9 4718.7 4720.2 4721.0 4724.9 4731.5 4764.5 3849.8 3935.1 3947.1 4047.0 4052.9 6136.0 6163.4 6183.3 6184.2 6195.9 5507.0 5535.6 5544.7 5554.4 5562.6 5591.8 6725.4 6893.9 6934.5 6944.5 3691.9 4456.0 4466.3 4483.0 4500.7 5407.6 7206.5 7270.2 7344.4 7358.5 3426.8 4541.3 4558.0 4564.9 4570.5 4455.2 4627.6 4638.6 4659.2 4681.7 5525.3 5550.3 5554.3 5580.0 5581.9 6068.7 6451.1 6884.1 6926.4 6946.4 1586.9 1618.4 1618.9 1621.0 1622.3 998.9 1029.5 1034.9 1038.6 1049.3 6402.7 6463.0 6471.0 6517.5 6527.3 7114.9 7122.0 7127.4 7167.6 7179.0 6249.4 6397.5 6430.0 6440.0 6466.1 3620.0 3708.1 3737.1 3748.2 3753.0 7368.0 7470.6 7567.7 7573.4 7601.2 6111.2 7155.7 7492.7 7601.7 7633.7 7452.6 7716.5 7739.2 7750.4 7755.6 7254.5 7265.0 7277.2 7291.7 7333.5 7108.5 7190.9 7193.7 7203.9 7218.6 7415.0 7688.8 7710.9 7719.9 7754.3 4592.2 4598.7 4599.1 4613.9 4622.9 7248.9 7279.5 7296.1 7309.3 7343.7 6722.5 6973.6 6999.9 7008.8 7013.9 7023.3 7148.7 7151.5 7164.6 7187.7 5666.6 6653.1 6773.4 6858.2 6874.3 7021.2 7024.6 7046.4 7057.4 7064.1 6835.1 6878.3 6895.3 6922.3 6939.0 00:29:19 INFO - PROCESS | 1678 | 00:29:19 INFO - PROCESS | 1678 | [#5] yui.html Cycles:180 Average:18109.15 Median:645.56 stddev:25193.28 (3902.5%) stddev-sans-first:25230.17 00:29:19 INFO - PROCESS | 1678 | Values: 734.5 736.6 739.1 755.5 755.7 12211.8 13015.8 14813.9 14878.3 15064.2 12504.1 13435.9 13550.5 13570.6 13620.0 769.7 891.8 893.9 894.1 897.2 704.6 716.4 863.7 887.3 901.2 923.0 926.9 927.1 934.5 937.4 909.5 913.5 925.0 927.8 929.2 614.0 623.3 686.6 686.7 692.9 15023.2 15156.2 15170.2 15199.0 15216.7 12043.3 12103.6 12979.8 12980.3 13196.9 10021.9 10197.5 10366.9 10464.3 10859.5 3585.0 3599.8 3661.6 3663.7 3726.6 78031.0 78320.0 78650.8 78897.0 79521.0 9687.3 9770.0 9841.3 9949.3 10374.5 21699.5 21901.1 21925.7 21956.8 22005.6 7118.5 7405.2 7414.3 7674.7 7817.9 4060.5 4121.9 4129.9 4134.5 4280.7 3525.9 3562.5 3591.9 3603.4 3606.4 650.4 659.1 662.3 665.1 674.8 513.8 543.7 560.8 573.7 640.7 8392.4 8492.0 8675.0 8680.0 8797.9 507.6 516.3 579.2 625.7 625.8 3914.8 3930.4 4326.0 4340.2 4388.7 71375.0 90722.0 91254.0 92206.2 92598.0 77523.0 78367.2 79019.6 79126.4 80099.6 65091.7 65208.3 65652.7 72704.9 73092.0 8742.9 8828.8 8870.0 8883.7 8906.8 49023.8 49040.5 49358.5 49841.8 50469.5 67744.0 68447.0 68470.6 68614.0 68715.3 10849.3 10882.5 10954.6 11028.1 11124.9 10084.6 12196.9 12406.8 12443.6 12683.0 9692.3 11288.5 11540.4 11676.5 11805.1 9423.6 11623.9 11657.7 11668.5 11696.8 11478.0 11514.4 11554.9 11566.4 11605.5 9332.3 9347.7 9634.4 9753.6 9800.9 8267.0 9337.7 9844.3 9851.6 9938.0 00:29:19 INFO - PROCESS | 1678 | -------- Summary: end -------- 00:29:19 INFO - PROCESS | 1678 | 00:29:19 INFO - TEST-INFO | 1678: exit 0 00:29:19 INFO - TEST-OK | dromaeo_css | took 1111359ms 00:29:20 INFO - TEST-START | kraken 00:29:20 INFO - operating with platform_type : mac_ 00:29:20 INFO - Initialising browser for kraken test... 00:29:20 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmplqqc4u/profile http://localhost:49274/getInfo.html) 00:29:20 INFO - PROCESS | 1686 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 00:29:22 INFO - PROCESS | 1686 | __metrics Screen width/height:1600/1200 00:29:22 INFO - PROCESS | 1686 | colorDepth:24 00:29:22 INFO - PROCESS | 1686 | Browser inner width/height: 1024/689 00:29:22 INFO - PROCESS | 1686 | __metrics 00:29:23 INFO - TEST-INFO | 1686: exit 0 00:29:23 INFO - Browser initialized. 00:29:23 INFO - Running cycle 1/1 for kraken test... 00:29:23 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmplqqc4u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:29:35 INFO - PROCESS | 1689 | RSS: Main: 257916928 00:29:35 INFO - PROCESS | 1689 | 00:29:38 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 00:29:38 INFO - PROCESS | 1689 | RSS: Main: 269111296 00:29:38 INFO - PROCESS | 1689 | 00:29:41 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 00:29:42 INFO - PROCESS | 1689 | RSS: Main: 277864448 00:29:42 INFO - PROCESS | 1689 | 00:29:45 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 00:29:46 INFO - PROCESS | 1689 | RSS: Main: 281939968 00:29:46 INFO - PROCESS | 1689 | 00:29:48 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 00:29:48 INFO - PROCESS | 1689 | RSS: Main: 283045888 00:29:48 INFO - PROCESS | 1689 | 00:29:51 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:29:51 INFO - PROCESS | 1689 | RSS: Main: 282972160 00:29:51 INFO - PROCESS | 1689 | 00:29:54 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 00:29:55 INFO - PROCESS | 1689 | RSS: Main: 285097984 00:29:55 INFO - PROCESS | 1689 | 00:29:58 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 00:29:59 INFO - PROCESS | 1689 | RSS: Main: 284569600 00:29:59 INFO - PROCESS | 1689 | 00:30:02 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 00:30:02 INFO - PROCESS | 1689 | RSS: Main: 285278208 00:30:02 INFO - PROCESS | 1689 | 00:30:04 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:30:04 INFO - PROCESS | 1689 | RSS: Main: 284082176 00:30:04 INFO - PROCESS | 1689 | 00:30:06 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:30:07 INFO - PROCESS | 1689 | RSS: Main: 283795456 00:30:07 INFO - PROCESS | 1689 | 00:30:09 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:30:10 INFO - PROCESS | 1689 | RSS: Main: 284483584 00:30:10 INFO - PROCESS | 1689 | 00:30:12 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:30:13 INFO - PROCESS | 1689 | RSS: Main: 283324416 00:30:13 INFO - PROCESS | 1689 | 00:30:15 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:30:16 INFO - PROCESS | 1689 | RSS: Main: 284073984 00:30:16 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 00:30:18 INFO - PROCESS | 1689 | RSS: Main: 285868032 00:30:18 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | __start_tp_report 00:30:18 INFO - PROCESS | 1689 | _x_x_mozilla_page_load 00:30:18 INFO - PROCESS | 1689 | _x_x_mozilla_page_load_details 00:30:18 INFO - PROCESS | 1689 | |i|pagename|runs| 00:30:18 INFO - PROCESS | 1689 | |0;ai-astar;117;161;115;115;117;125;115;114;113;116 00:30:18 INFO - PROCESS | 1689 | |1;audio-beat-detection;150;122;147;151;122;142;142;137;195;153 00:30:18 INFO - PROCESS | 1689 | |2;audio-dft;195;200;194;193;193;254;265;276;260;196 00:30:18 INFO - PROCESS | 1689 | |3;audio-fft;71;97;72;109;84;76;57;55;133;87 00:30:18 INFO - PROCESS | 1689 | |4;audio-oscillator;84;87;113;77;65;118;156;125;119;122 00:30:18 INFO - PROCESS | 1689 | |5;imaging-gaussian-blur;132;140;93;93;86;81;134;140;87;102 00:30:18 INFO - PROCESS | 1689 | |6;imaging-darkroom;96;111;126;152;151;96;96;102;132;95 00:30:18 INFO - PROCESS | 1689 | |7;imaging-desaturate;150;83;145;147;92;149;140;91;85;146 00:30:18 INFO - PROCESS | 1689 | |8;json-parse-financial;56;57;54;55;56;55;56;62;53;52 00:30:18 INFO - PROCESS | 1689 | |9;json-stringify-tinderbox;66;68;63;79;72;65;65;93;65;69 00:30:18 INFO - PROCESS | 1689 | |10;stanford-crypto-aes;87;83;86;83;88;84;86;85;85;85 00:30:18 INFO - PROCESS | 1689 | |11;stanford-crypto-ccm;129;132;126;128;126;122;132;129;144;137 00:30:18 INFO - PROCESS | 1689 | |12;stanford-crypto-pbkdf2;138;178;126;184;121;176;125;168;182;150 00:30:18 INFO - PROCESS | 1689 | |13;stanford-crypto-sha256-iterative;68;65;67;68;97;55;86;66;58;72 00:30:18 INFO - PROCESS | 1689 | __end_tp_report 00:30:18 INFO - PROCESS | 1689 | __start_cc_report 00:30:18 INFO - PROCESS | 1689 | _x_x_mozilla_cycle_collect,901 00:30:18 INFO - PROCESS | 1689 | __end_cc_report 00:30:18 INFO - PROCESS | 1689 | __startTimestamp1454574618417__endTimestamp 00:30:18 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | ------- Summary: start ------- 00:30:18 INFO - PROCESS | 1689 | Number of tests: 14 00:30:18 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | [#0] ai-astar Cycles:10 Average:120.80 Median:116.50 stddev:14.51 (12.5%) stddev-sans-first:15.32 00:30:18 INFO - PROCESS | 1689 | Values: 117.0 161.0 115.0 115.0 117.0 125.0 115.0 114.0 113.0 116.0 00:30:18 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:148.50 stddev:20.43 (13.8%) stddev-sans-first:21.62 00:30:18 INFO - PROCESS | 1689 | Values: 150.0 122.0 147.0 151.0 122.0 142.0 142.0 137.0 195.0 153.0 00:30:18 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | [#2] audio-dft Cycles:10 Average:222.60 Median:227.00 stddev:35.88 (15.8%) stddev-sans-first:36.64 00:30:18 INFO - PROCESS | 1689 | Values: 195.0 200.0 194.0 193.0 193.0 254.0 265.0 276.0 260.0 196.0 00:30:18 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | [#3] audio-fft Cycles:10 Average:84.10 Median:74.00 stddev:23.92 (32.3%) stddev-sans-first:24.90 00:30:18 INFO - PROCESS | 1689 | Values: 71.0 97.0 72.0 109.0 84.0 76.0 57.0 55.0 133.0 87.0 00:30:18 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | [#4] audio-oscillator Cycles:10 Average:106.60 Median:110.50 stddev:27.57 (25.0%) stddev-sans-first:28.01 00:30:18 INFO - PROCESS | 1689 | Values: 84.0 87.0 113.0 77.0 65.0 118.0 156.0 125.0 119.0 122.0 00:30:18 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | [#5] imaging-gaussian-blur Cycles:10 Average:108.80 Median:83.50 stddev:24.57 (29.4%) stddev-sans-first:24.59 00:30:18 INFO - PROCESS | 1689 | Values: 132.0 140.0 93.0 93.0 86.0 81.0 134.0 140.0 87.0 102.0 00:30:18 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | [#6] imaging-darkroom Cycles:10 Average:115.70 Median:123.50 stddev:22.94 (18.6%) stddev-sans-first:23.20 00:30:18 INFO - PROCESS | 1689 | Values: 96.0 111.0 126.0 152.0 151.0 96.0 96.0 102.0 132.0 95.0 00:30:18 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | [#7] imaging-desaturate Cycles:10 Average:122.80 Median:116.50 stddev:30.39 (26.1%) stddev-sans-first:30.60 00:30:18 INFO - PROCESS | 1689 | Values: 150.0 83.0 145.0 147.0 92.0 149.0 140.0 91.0 85.0 146.0 00:30:18 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:2.72 (4.9%) stddev-sans-first:2.88 00:30:18 INFO - PROCESS | 1689 | Values: 56.0 57.0 54.0 55.0 56.0 55.0 56.0 62.0 53.0 52.0 00:30:18 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:68.50 stddev:9.17 (13.4%) stddev-sans-first:9.58 00:30:18 INFO - PROCESS | 1689 | Values: 66.0 68.0 63.0 79.0 72.0 65.0 65.0 93.0 65.0 69.0 00:30:18 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.50 stddev:1.62 (1.9%) stddev-sans-first:1.58 00:30:18 INFO - PROCESS | 1689 | Values: 87.0 83.0 86.0 83.0 88.0 84.0 86.0 85.0 85.0 85.0 00:30:18 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:130.50 stddev:6.26 (4.8%) stddev-sans-first:6.61 00:30:18 INFO - PROCESS | 1689 | Values: 129.0 132.0 126.0 128.0 126.0 122.0 132.0 129.0 144.0 137.0 00:30:18 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:172.00 stddev:25.65 (14.9%) stddev-sans-first:26.47 00:30:18 INFO - PROCESS | 1689 | Values: 138.0 178.0 126.0 184.0 121.0 176.0 125.0 168.0 182.0 150.0 00:30:18 INFO - PROCESS | 1689 | 00:30:18 INFO - PROCESS | 1689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:68.00 stddev:12.54 (18.4%) stddev-sans-first:13.28 00:30:18 INFO - PROCESS | 1689 | Values: 68.0 65.0 67.0 68.0 97.0 55.0 86.0 66.0 58.0 72.0 00:30:18 INFO - PROCESS | 1689 | -------- Summary: end -------- 00:30:18 INFO - PROCESS | 1689 | 00:30:19 INFO - TEST-INFO | 1689: exit 0 00:30:19 INFO - TEST-OK | kraken | took 59209ms 00:30:19 INFO - SUITE-END | took 1170s 00:30:19 INFO - Completed test suite (00:19:30) 00:30:19 INFO - Working with test: dromaeo_css 00:30:19 INFO - Generating results file: dromaeo_css 00:30:19 INFO - Working with test: kraken 00:30:19 INFO - Generating results file: kraken 00:30:19 INFO - javascript benchmark 00:30:19 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:30:20 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 00:30:20 INFO - process_Request line: dromaeo_css 7388.01 graph.html#tests=[[72,64,61]] 00:30:20 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:30:20 INFO - process_Request line: kraken 1594.30 graph.html#tests=[[232,64,61]] 00:30:20 INFO - RETURN: dromaeo_css: 7388.01 00:30:20 INFO - RETURN: kraken: 1594.30 00:30:20 INFO - javascript benchmark 00:30:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3375.1730825947648, 3521.5421995140628, 3553.769005014672, 3574.1064733816547, 3580.4808302796096, 5701.486866182043, 5743.684097374643, 5756.136579513075, 5761.884762304751, 5765.6540607563575, 4780.593649539785, 5582.441755824426, 5708.600397972144, 5733.254676892008, 5781.78582497675, 5172.40517340505, 5219.921701174486, 5259.815906443275, 5260.658057226287, 5323.973380133094, 4316.309390497521, 5222.190560463116, 5288.92066619001, 5291.28567643367, 5292.444293349201, 4134.297169481196, 4140.979295103535, 5206.479352064801, 5232.790688372461, 5249.370075590915, 5194.896102077975, 5205.791768329263, 5210.062188806013, 5231.738413079331, 5241.318628578299, 4285.871423857289, 5219.451957544441, 5233.947660523384, 5258.13240815265, 5268.736563171864, 5438.83683489492, 5523.696196709179, 5551.8889622207325, 5653.208550802891, 5689.374168841466, 5331.493508116761, 6240.843978900519, 6248.437640612321, 6252.187215661935, 6272.529560282951, 6074.088886667036, 6179.412955769195, 6197.473214776749, 6219.440250377443, 6234.906476402857, 5783.161441590946, 5811.27359080115, 5874.265716785402, 5898.938191125553, 5949.672767997715, 6256.374362563798, 6262.2172228471445, 6262.5929314594405, 6274.215723034621, 6295.433410993032, 6019.367966363557, 6052.788152414732, 6191.226096737908, 6200.348963358872, 6203.16257305267, 5257.237700533401, 6153.230846144232, 6221.47117495018, 6263.4362907338555, 6310.810675679737, 6159.29168145669, 6227.034809604518, 6239.937600623935, 6240.032794916795, 6241.126242326078, 6141.293751218578, 6144.7264512129905, 6201.472874805602, 6260.342664020303, 6266.905996410058, 4887.169181239198, 4897.5592196701755, 4909.116359055333, 4916.532929371704, 4936.086823937583, 4368.584984426474, 4382.0, 4408.603225709701, 4424.469063712375, 4462.196804575207, 5693.914591281134, 5740.339860915965, 5771.68255745938, 5824.504917082011, 5902.114682797529, 6180.536459765535, 6213.340642364157, 6257.124002639634, 6259.374062593704, 6260.311365749764, 4851.0, 5608.607397482218, 5835.883282334329, 5865.736041878125, 5871.794487192928, 5260.210968354778, 5331.866703332447, 5362.249285100089, 5403.675779453167, 5425.159100339453, 6323.557350985387, 6345.524085693592, 6356.555041147075, 6363.013732871227, 6367.681615919279, 6110.40687992437, 6196.86923302677, 6249.1563638908165, 6260.060990851409, 6261.718222680081, 6220.906686399617, 6276.780312689034, 6329.240491141092, 6361.300256971637, 6363.204599425072, 6166.568340216142, 6230.00319948806, 6230.937690623035, 6240.906386404116, 6243.687815609111, 6087.786927457518, 6196.1635179250225, 6233.563650544418, 6238.376162383725, 6247.781327653511, 6103.91351630514, 6157.384261573986, 6165.84585385369, 6169.691515424301, 6183.690815459299, 6101.969490152521, 6106.786262480792, 6150.661713605795, 6155.446009859134, 6159.476444502267, 5751.1373294006235, 5773.769049237983, 5923.496502797138, 6022.307434644897, 6074.544409169242, 6079.057547418048, 6101.661245064722, 6110.042400473335, 6118.101457354478, 6164.568480206342, 5309.893802123858, 6006.0, 6066.514678825772, 6070.3019152798, 6086.908696369646], "unit": "score", "name": "dojo.html", "value": 5672.919668929146}, {"lowerIsBetter": false, "replicates": [445.22975252812614, 464.9744264065476, 483.61069339181967, 518.3002946022872, 554.7753159970212, 38006.0, 38864.834054978324, 38866.417003744966, 38888.0, 39010.0, 41370.37944430828, 41439.75680729575, 41745.373819392655, 41996.790016049956, 42175.0, 9031.548422578877, 9493.003234660366, 9582.472963986995, 9741.464219467927, 9796.216302695768, 9832.90167098327, 9984.90015099847, 9986.600535978552, 10004.949975250114, 10006.099451049404, 9882.407055576688, 9992.650257240997, 10005.44970026652, 10027.097561219489, 10057.245706572, 9873.555689993967, 9958.751031224205, 9967.501624918797, 9972.252081093911, 9999.2000639949, 9639.421634701941, 9750.609975600968, 9753.414795112316, 9772.31593788435, 9802.36284641496, 39558.40662390037, 39864.0, 39960.000999974945, 40013.59986400128, 40116.79941600273, 3233.159378561591, 3401.200717831308, 3418.1967237699123, 3625.4199328107375, 3638.8362523686496, 28441.571357533565, 28666.85666571654, 29373.412531749247, 29421.70578294211, 29797.255068623243, 2821.271554821987, 2852.857357132135, 2854.957175642367, 2867.5411934090653, 2915.839628820414, 467898.0, 469338.0, 473057.0, 474095.0, 474393.6280318576, 43144.0, 57349.71325143431, 64683.0, 64727.67636161789, 67728.66135669389, 69586.30413695799, 69957.95063074058, 70199.64900175466, 70443.0, 70826.291737083, 15922.522324330288, 16433.753493697604, 16578.419755308507, 16579.6684066318, 16603.916980415263, 12850.0, 12930.353482325847, 12950.0, 13019.609411717664, 13038.869611303955, 20373.796262037486, 20419.183232670526, 20686.275980340615, 20767.58464830695, 20770.48073798137, 7735.878297646922, 8305.134728518651, 8331.126026397633, 8339.166083391734, 8406.915930840736, 974.3228456222857, 1006.6577363696379, 1031.3605564550028, 1126.099120703434, 1128.2440764687678, 25676.614850777252, 27425.725742742317, 29571.373574453613, 30126.0, 30263.546046809315, 964.8614634731084, 1076.784643071389, 1080.3895798873612, 1122.550979608147, 1149.7298134938283, 15120.621984450478, 15170.696586068218, 15539.766903496457, 15684.372625095097, 15856.762148567781, 409756.0, 412695.0, 413048.9347553243, 415989.0, 417630.0, 57389.71305143531, 57486.71256643774, 57786.422135778106, 57993.71003144957, 58429.41570584325, 1377.572952384744, 1406.465543093618, 1408.499982506216, 1439.0933711761732, 1571.5442521668588, 23994.880025600458, 25945.870270648527, 29513.85243073771, 30718.23204419818, 30775.846120769253, 50292.0, 51216.46350609488, 51618.0, 51643.967120658126, 51667.96664066773, 475092.0, 475227.0, 476668.0, 478076.0, 479128.0, 28077.859610701817, 32163.51754723728, 33212.50181247332, 33535.83232083824, 33780.98657040195, 38517.61482385252, 43566.0, 45081.0, 45171.870703232686, 45783.0, 29348.853255733586, 34098.48852267169, 35262.0, 35491.290174195856, 35528.46707299341, 26009.0, 34279.0, 34922.301553969286, 34944.82527587346, 36924.0, 34536.0, 35218.11954701153, 35307.646923531465, 35501.82249088738, 35629.0, 24805.118217543895, 30804.84597576998, 31744.365112697156, 32070.0, 32211.67788322087, 24420.26739197827, 24436.26691199267, 24603.50792984166, 24656.753432466165, 24712.629310559998], "unit": "score", "name": "ext.html", "value": 19548.067482024253}, {"lowerIsBetter": false, "replicates": [330.616484877542, 363.34416378436913, 367.3615674093543, 367.9742418030737, 372.1644907183374, 15490.845091549081, 18693.158807853644, 18859.52851178721, 19870.602587948233, 20210.494737631547, 11657.591984280552, 18845.434636960912, 19234.519137021547, 19330.613387732235, 19356.3225287115, 5242.213667949819, 5296.947030529704, 5308.389535203462, 5406.83779486616, 5412.431694672042, 4387.605115539601, 5342.412334643186, 5346.609881430836, 5846.88306233875, 6053.667048312341, 5948.940510594882, 6006.7897623583185, 6027.457528822405, 6269.811905642838, 6315.179026726519, 6103.267607887082, 6416.0, 6428.292887782341, 6450.032495125745, 6470.967645161768, 5664.801731939404, 5689.260396148516, 5689.687067211302, 5711.086226203787, 5776.42235776419, 12828.486860525662, 13251.0, 13421.39603717835, 13423.597292081253, 13426.992975526875, 2232.5311684546264, 2286.0284379138966, 2439.658447817307, 2498.650188973545, 2643.7488438598493, 9065.59204835784, 9242.815143697155, 9644.469554174517, 9990.400575965465, 10262.897371026269, 1755.3768412213608, 1772.1936518883876, 1785.4108144312345, 1795.838374546297, 1805.2778888444595, 81457.0, 81564.0, 84769.30461390737, 86535.0, 95206.52396738042, 8741.562921853882, 10648.414337211529, 11127.0, 11146.832797508045, 11265.042471390023, 11132.554697812158, 12619.0, 13351.132176408502, 13446.32768361578, 13521.459141634225, 7774.455788094779, 7915.248051435105, 7955.801104972306, 7992.560409177551, 8020.719274825353, 7905.525668459911, 7987.3610111190965, 8019.438639295194, 8056.154103819132, 8068.798280043045, 3907.33575292201, 4072.450219220427, 4131.5248746393945, 4329.588689074533, 4477.417935668407, 1748.379325339486, 1893.384649988759, 1898.0, 1901.0, 1907.523119220195, 852.3692467573951, 893.4058850864103, 927.8144371125802, 993.4238141877838, 1071.8552995345685, 17901.910490447724, 17960.742748007513, 18954.052297385075, 19435.931023793546, 19505.707414388795, 946.8769060022291, 948.8197242523898, 974.7075877236942, 975.4683697384942, 976.097110173087, 10103.646372376932, 10325.432101234353, 10464.372137671764, 10573.0, 10601.151907847354, 610073.0, 622155.0, 626789.0, 630549.0, 632834.0, 63814.042789358195, 67849.66075169592, 87635.1236487627, 103603.96396036094, 106319.4684026575, 491.5109466081272, 503.7053323805541, 511.19742005052456, 516.1277441124563, 1203.4764877278412, 11034.117270618171, 11170.720731981766, 11188.720281993015, 11308.604198853001, 11312.434378280888, 42108.57891421046, 48945.0, 50819.74590127026, 52314.738426307624, 53523.19715204197, 64369.67815161082, 65966.67016664887, 66473.66763166153, 74866.25133748593, 75935.0, 7433.219511951167, 7596.316331530189, 7632.465727399029, 7640.885386719093, 7653.732119375795, 9474.289428293043, 11486.712832179262, 11762.70593235176, 11855.34795586251, 11886.405679716152, 8105.230003149692, 9893.554790034323, 10063.647772327933, 10066.043725846033, 10159.84760228612, 9357.485338306458, 9706.466144361846, 9961.708687652468, 10386.376817390981, 10490.790184196427, 8204.671813127647, 9901.653442129491, 10441.060304572626, 10517.842232366675, 10673.839892401465, 7619.161892191743, 7750.612469376621, 7751.457397982087, 7778.377729781717, 7793.376529877482, 8563.486190828571, 8571.742847714579, 9112.362134650512, 9300.255979521487, 10355.223358248311], "unit": "score", "name": "jquery.html", "value": 8539.317256799262}, {"lowerIsBetter": false, "replicates": [1374.1823614949108, 1511.969760604788, 1698.2612563534856, 1698.7621732957389, 1939.854510911682, 7151.4993950423495, 7772.494787838787, 7940.960295198531, 8767.736967890965, 8792.0, 8408.285295749869, 8513.318934485242, 8620.267277281422, 8649.740507784762, 8664.436811607256, 2468.333549941515, 2504.7745702886737, 2506.7117281512587, 2507.2979565721625, 2512.5351809915132, 2265.9350105450494, 2379.5597814404305, 2422.103821586016, 2485.5898776701824, 2498.100683753856, 2035.5013021809602, 2398.388410955204, 2446.657467954488, 2462.4213309872166, 2481.2928315430104, 2155.299527653519, 2382.7855493005713, 2466.901323947049, 2472.5178590174924, 2491.0783010286127, 2457.594496908008, 2474.8391354562077, 2477.355887469253, 2477.7150627677865, 2487.6890388701413, 8688.261497772697, 8762.0, 8806.471611703255, 8808.295336373074, 8811.0, 5339.0, 5361.544268737162, 5475.370332411784, 5476.424975377608, 5511.614187006911, 3656.213914008474, 3695.870644527429, 3749.850005999757, 3770.1517158639363, 3777.1690228149764, 1049.0872940541701, 1065.2277099103167, 1074.5003573338356, 1089.1667874076338, 1109.2346281066039, 11683.766324673545, 12060.914517693362, 12112.81830772539, 12117.33354665493, 12126.029917606571, 4157.542670306264, 4789.760511974457, 4902.803887844446, 4963.213243232433, 4998.825041123616, 10201.897981020244, 10234.130098941674, 10259.384436933658, 10261.9486902565, 10263.178945684327, 5430.456954304538, 5456.0, 5467.535259502987, 5495.395506494282, 5510.614257002052, 4346.826126954949, 4478.238699421041, 4845.1278769821065, 4945.184044632595, 4990.5508504234795, 3325.434676105068, 3884.2814079395403, 3949.881503554898, 3961.782101984361, 4007.998000499875, 1243.3720970909633, 1319.327143156997, 1324.576135636587, 1331.8268625078679, 1334.3461703765086, 1318.5055604148445, 1327.6415367850627, 1335.6660834791303, 1340.8659134086513, 1356.6811799227173, 7847.097583777939, 8115.188481151956, 8281.420300578902, 8310.168983101641, 8335.49987000782, 1175.3183153770792, 1177.581958404754, 1193.3436609864714, 1194.0, 1214.726686495549, 6212.254529456403, 6239.095331176954, 6251.187345645037, 6318.052292156121, 6332.366763323631, 10321.94839025815, 10538.31500952451, 10555.313904596176, 10601.098906593026, 10602.628907988183, 7778.8833167502535, 10435.269531132899, 10516.316439431412, 10637.734056648645, 10667.19996000303, 7962.044554653363, 8092.069412017693, 8158.061822890443, 8177.182281771775, 8201.056878458934, 6768.763093291711, 7927.762167134995, 7982.600869956363, 7991.64037618297, 8048.5170889746805, 7857.33212676906, 9079.54602269897, 9476.857847132436, 9516.33385662997, 9672.661456848977, 9409.764755881159, 9648.903510964801, 9650.179734722627, 10027.29808913369, 10029.29794914349, 6210.192674952227, 6754.93245067543, 6950.687219075053, 7217.67520461591, 7659.617019148909, 7965.004374453193, 8134.877976830234, 8185.71350002747, 8231.547264900488, 8235.094139644514, 7333.4499912507845, 7764.805879853049, 7788.182240864628, 7795.181505942021, 7807.063152421746, 7567.243275672388, 7568.697252109854, 7576.924230757842, 7666.233376662289, 7699.26856948589, 6468.353164683682, 7648.847023059619, 7667.654955526903, 7694.0, 7709.845803084019, 6881.518293719391, 7017.614031228331, 7033.261507541839, 7038.120234970629, 7093.042439270633, 7102.857942841218, 7115.53749006313, 7164.140303163445, 7180.0, 7180.389666878374], "unit": "score", "name": "mootools.html", "value": 4923.629024266594}, {"lowerIsBetter": false, "replicates": [320.31133063912586, 323.71351354051654, 325.7475456521196, 326.1308612547558, 330.99338013239736, 6385.106085148083, 6512.185976752906, 6580.901286480706, 6591.868162636744, 6656.367645073717, 6345.619262844232, 6502.707378167982, 6514.055461958013, 6536.281009089008, 6569.704363303651, 4839.693282813638, 4851.951480485185, 4864.221724524077, 4867.440244371898, 4887.095887260851, 4857.951420485785, 4873.342098816667, 4874.098291816008, 4882.535239428175, 4884.780184891689, 4533.727976321431, 4706.835260765857, 4714.764261786914, 4716.882077948062, 4718.740469274188, 4720.1975664136835, 4720.98498822753, 4724.90550188996, 4731.455882573497, 4764.475907650156, 3849.8267577958777, 3935.05558665921, 3947.052707350244, 4046.979765101185, 4052.9392059119136, 6135.962698464245, 6163.414475624809, 6183.319834818167, 6184.226971628546, 6195.87608247837, 5506.972465137648, 5535.557155427556, 5544.722763861791, 5554.416786237427, 5562.582806289504, 5591.776328946838, 6725.361090696376, 6893.931060689379, 6934.47991400642, 6944.548604340702, 3691.8523259069607, 4456.0, 4466.285394336891, 4483.0, 4500.662450316239, 5407.594430417735, 7206.49554531183, 7270.236625154388, 7344.4491663124945, 7358.521696089791, 3426.777259478176, 4541.250693635513, 4557.977210113994, 4564.881604006973, 4570.497245303014, 4455.1980643484485, 4627.583517483443, 4638.582527572467, 4659.161350956792, 4681.695689780154, 5525.309336332958, 5550.278463799761, 5554.2779438672715, 5580.0, 5581.860453488614, 6068.666223357669, 6451.129097571861, 6884.139482564679, 6926.376626103574, 6946.444284457332, 1586.8968517046355, 1618.368836153901, 1618.8623966962705, 1620.959476013109, 1622.2861940746034, 998.9150922171551, 1029.4904022508906, 1034.9016843399866, 1038.6209033702644, 1049.3074570783247, 6402.743890244338, 6462.967685161544, 6471.0, 6517.478601711851, 6527.314631963575, 7114.893276600855, 7122.0, 7127.394171495377, 7167.641617919083, 7179.0, 6249.406306400975, 6397.488200943913, 6430.0, 6440.0, 6466.094746735461, 3620.0, 3708.1100535871738, 3737.1404576947452, 3748.194138260287, 3753.0, 7367.963160184272, 7470.6264686766535, 7567.659455324413, 7573.431992600577, 7601.163871974079, 6111.236095488064, 7155.676199903035, 7492.737754178577, 7601.733939312208, 7633.6564854581675, 7452.552846829208, 7716.459847810599, 7739.226077392215, 7750.418718596128, 7755.612219389008, 7254.492185546961, 7264.963675181591, 7277.199508054216, 7291.708331666674, 7333.523320984119, 7108.537945033556, 7190.892136618059, 7193.712251509881, 7203.855922881408, 7218.602976836324, 7415.0, 7688.769336919901, 7710.8843367350655, 7719.922800772145, 7754.34088102495, 4592.173408786451, 4598.678092533491, 4599.149157405891, 4613.861584152481, 4622.907541849077, 7248.927510724825, 7279.526830755984, 7296.124465064227, 7309.305615966475, 7343.70625174987, 6722.462203023844, 6973.6164510952385, 6999.930000700131, 7008.789736307919, 7013.859722805618, 7023.33278338557, 7148.714051437884, 7151.463640227108, 7164.641767911688, 7187.712491500491, 5666.631668941505, 6653.101831252912, 6773.356531129535, 6858.2455929848675, 6874.346937040973, 7021.192562855337, 7024.613646249505, 7046.4010559101, 7057.435405167677, 7064.116985376828, 6835.07726456922, 6878.27778083294, 6895.275996020346, 6922.307769223037, 6939.028536005064], "unit": "score", "name": "prototype.html", "value": 5065.8136492535305}, {"lowerIsBetter": false, "replicates": [734.4858598980715, 736.554384597319, 739.0785295705717, 755.4862693368509, 755.701497908326, 12211.755764884698, 13015.804762928552, 14813.92593037036, 14878.330475128618, 15064.2467876606, 12504.06219533534, 13435.865641343584, 13550.525731599397, 13570.592882213525, 13620.0, 769.6690423118071, 891.8394688955985, 893.8882639670041, 894.061235702513, 897.2373482539854, 704.5737328916009, 716.4018044932487, 863.7365603490932, 887.2547060469204, 901.2249465459699, 922.9985465769648, 926.865604487349, 927.0868194828089, 934.5047125023714, 937.3719607862714, 909.4588719711761, 913.4793167894303, 924.958376873039, 927.7819712367589, 929.1916033051222, 614.0114415790573, 623.3019018699041, 686.5983399711175, 686.6875571614903, 692.9203141638726, 15023.248837558078, 15156.1664108474, 15170.24148792567, 15199.012064215902, 15216.695666086727, 12043.277403355827, 12103.608085070242, 12979.805302920464, 12980.28608426536, 13196.934015329958, 10021.89978100217, 10197.541110650038, 10366.896331036669, 10464.267501274913, 10859.511321990529, 3584.9641503585153, 3599.848048624441, 3661.5972243053243, 3663.7435379523445, 3726.571444283915, 78031.0, 78320.0, 78650.82023769648, 78897.0, 79520.99999999942, 9687.273454490942, 9769.951150244346, 9841.261905357127, 9949.253805964438, 10374.533146008447, 21699.45751356197, 21901.12395504162, 21925.671114933288, 21956.79237641913, 22005.559888802134, 7118.466115041289, 7405.1854296027395, 7414.295641914009, 7674.654640541077, 7817.921820781719, 4060.5127384713433, 4121.8969525761495, 4129.876103716893, 4134.503859536815, 4280.657547396201, 3525.8765943191866, 3562.5190599269285, 3591.892243232707, 3603.4234522476804, 3606.386914224588, 650.391883588846, 659.0904551718694, 662.2582707367683, 665.1486097794831, 674.8380388706773, 513.7585334892594, 543.6792292547337, 560.7840981222258, 573.6730063863641, 640.7340953504337, 8392.412531122764, 8491.95754021226, 8675.002374726988, 8679.956600216958, 8797.912020879838, 507.58631715152035, 516.3004129404678, 579.1978110317241, 625.6996641612052, 625.7590827531433, 3914.7651140931634, 3930.449737036817, 4325.956740432555, 4340.153670034376, 4388.670849686287, 71375.0, 90722.0, 91254.0, 92206.15587688342, 92598.0, 77523.0, 78367.216327836, 79019.60490197512, 79126.4174716514, 80099.59950200212, 65091.67454162794, 65208.347916521176, 65652.67173664196, 72704.90942635864, 73092.0, 8742.868856967278, 8828.779280518038, 8869.955650221707, 8883.73348799537, 8906.777330566787, 49023.754881225366, 49040.5095949036, 49358.506414936826, 49841.75079124581, 50469.49530504648, 67744.0, 68447.0, 68470.63058738897, 68614.0, 68715.31284687089, 10849.349039057683, 10882.45587720595, 10954.616588419685, 11028.062614677521, 11124.944375278072, 10084.647037353658, 12196.90227879495, 12406.751864962469, 12443.564475243324, 12683.048771342003, 9692.273079518924, 11288.548458061585, 11540.365279909685, 11676.474558644712, 11805.114616403633, 9423.57593908262, 11623.895729905646, 11657.708557286136, 11668.533258669559, 11696.766064678828, 11478.0, 11514.424278786195, 11554.942225289156, 11566.42167891619, 11605.477753500943, 9332.253419726541, 9347.719568412958, 9634.373765705486, 9753.609855605697, 9800.852987205055, 8266.958665206635, 9337.71986840396, 9844.261680374144, 9851.556679949275, 9938.0], "unit": "score", "name": "yui.html", "value": 6884.356598339655}], "name": "dromaeo_css", "value": 7388.011691972614}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 161.0, 115.0, 115.0, 117.0, 125.0, 115.0, 114.0, 113.0, 116.0], "unit": "score", "name": "ai-astar", "value": 120.8}, {"lowerIsBetter": true, "replicates": [150.0, 122.0, 147.0, 151.0, 122.0, 142.0, 142.0, 137.0, 195.0, 153.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [195.0, 200.0, 194.0, 193.0, 193.0, 254.0, 265.0, 276.0, 260.0, 196.0], "unit": "score", "name": "audio-dft", "value": 222.6}, {"lowerIsBetter": true, "replicates": [71.0, 97.0, 72.0, 109.0, 84.0, 76.0, 57.0, 55.0, 133.0, 87.0], "unit": "score", "name": "audio-fft", "value": 84.1}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 113.0, 77.0, 65.0, 118.0, 156.0, 125.0, 119.0, 122.0], "unit": "score", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [132.0, 140.0, 93.0, 93.0, 86.0, 81.0, 134.0, 140.0, 87.0, 102.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.8}, {"lowerIsBetter": true, "replicates": [96.0, 111.0, 126.0, 152.0, 151.0, 96.0, 96.0, 102.0, 132.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 115.7}, {"lowerIsBetter": true, "replicates": [150.0, 83.0, 145.0, 147.0, 92.0, 149.0, 140.0, 91.0, 85.0, 146.0], "unit": "score", "name": "imaging-desaturate", "value": 122.8}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 54.0, 55.0, 56.0, 55.0, 56.0, 62.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 63.0, 79.0, 72.0, 65.0, 65.0, 93.0, 65.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.5}, {"lowerIsBetter": true, "replicates": [87.0, 83.0, 86.0, 83.0, 88.0, 84.0, 86.0, 85.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [129.0, 132.0, 126.0, 128.0, 126.0, 122.0, 132.0, 129.0, 144.0, 137.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.5}, {"lowerIsBetter": true, "replicates": [138.0, 178.0, 126.0, 184.0, 121.0, 176.0, 125.0, 168.0, 182.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.8}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 67.0, 68.0, 97.0, 55.0, 86.0, 66.0, 58.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1594.3}]} 00:30:20 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1594.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7388.01"}}} 00:30:20 INFO - Return code: 0 00:30:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:30:20 INFO - # TBPL SUCCESS # 00:30:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:30:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:30:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:30:20 INFO - 2016-02-04 00:30:20.357 screenresolution[1695:11423] starting screenresolution argv=screenresolution get 00:30:20 INFO - 2016-02-04 00:30:20.359 screenresolution[1695:11423] Display 0: 1600x1200x32@60 00:30:20 INFO - 2016-02-04 00:30:20.365 screenresolution[1696:11426] starting screenresolution argv=screenresolution list 00:30:20 INFO - Available Modes on Display 0 00:30:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:30:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:30:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:30:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:30:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:30:20 INFO - Intel Iris: 00:30:20 INFO - Chipset Model: Intel Iris 00:30:20 INFO - Type: GPU 00:30:20 INFO - Bus: Built-In 00:30:20 INFO - VRAM (Dynamic, Max): 1536 MB 00:30:20 INFO - Vendor: Intel (0x8086) 00:30:20 INFO - Device ID: 0x0a2e 00:30:20 INFO - Revision ID: 0x0009 00:30:20 INFO - Displays: 00:30:20 INFO - Display: 00:30:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:30:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:30:20 INFO - Display Serial Number: 1600x1200 60 00:30:20 INFO - Main Display: Yes 00:30:20 INFO - Mirror: Off 00:30:20 INFO - Online: Yes 00:30:20 INFO - Rotation: Supported 00:30:20 INFO - Return code: 0 00:30:20 INFO - Running post-action listener: _resource_record_post_action 00:30:20 INFO - Running post-run listener: _resource_record_post_run 00:30:21 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 33877504; Write bytes: 711687168; Read time: 355; Write time: 2188 00:30:21 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401426944; Write bytes: 396322816; Read time: 30320; Write time: 718 00:30:21 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 32075264; Write bytes: 303830016; Read time: 336; Write time: 1439 00:30:21 INFO - Running post-run listener: _upload_blobber_files 00:30:21 INFO - Blob upload gear active. 00:30:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:30:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:30:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:30:22 INFO - (blobuploader) - INFO - Open directory for files ... 00:30:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:30:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:30:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:30:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:30:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:30:23 INFO - (blobuploader) - INFO - Done attempting. 00:30:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:30:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:30:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:30:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:30:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:30:24 INFO - (blobuploader) - INFO - Done attempting. 00:30:24 INFO - (blobuploader) - INFO - Iteration through files over. 00:30:24 INFO - Return code: 0 00:30:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:30:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:30:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d94809ce1b03c2f4fbfc426753ff3048fa92e0bf6c192a3144775995c3bcd726dd27f0fc756f1dc7745e57795fa2fc98bc9223a47a46a90c091f6de85fea3e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a615c5198d290c6b6f72f866ae117f8b102cb45049a1d89022ae3fe286e9cfffd18b30f905563eba8c7655382223f31c8faa25ffa923f6203349b5e493e202c2"} 00:30:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:30:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:30:24 INFO - Contents: 00:30:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d94809ce1b03c2f4fbfc426753ff3048fa92e0bf6c192a3144775995c3bcd726dd27f0fc756f1dc7745e57795fa2fc98bc9223a47a46a90c091f6de85fea3e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a615c5198d290c6b6f72f866ae117f8b102cb45049a1d89022ae3fe286e9cfffd18b30f905563eba8c7655382223f31c8faa25ffa923f6203349b5e493e202c2"} 00:30:24 INFO - Running post-run listener: copy_logs_to_upload_dir 00:30:24 INFO - Copying logs to upload dir... 00:30:24 INFO - mkdir: /builds/slave/test/build/upload/logs 00:30:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.686876 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-02-04 00:30:24.525040) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-04 00:30:24.528317) ========= 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.8rYkfBvt7I/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.KLE7pVEefE/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d94809ce1b03c2f4fbfc426753ff3048fa92e0bf6c192a3144775995c3bcd726dd27f0fc756f1dc7745e57795fa2fc98bc9223a47a46a90c091f6de85fea3e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a615c5198d290c6b6f72f866ae117f8b102cb45049a1d89022ae3fe286e9cfffd18b30f905563eba8c7655382223f31c8faa25ffa923f6203349b5e493e202c2"} build_url:https://queue.taskcluster.net/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011385 build_url: 'https://queue.taskcluster.net/v1/task/EBRzIsRyTAuxKXBvIuBBwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d94809ce1b03c2f4fbfc426753ff3048fa92e0bf6c192a3144775995c3bcd726dd27f0fc756f1dc7745e57795fa2fc98bc9223a47a46a90c091f6de85fea3e7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a615c5198d290c6b6f72f866ae117f8b102cb45049a1d89022ae3fe286e9cfffd18b30f905563eba8c7655382223f31c8faa25ffa923f6203349b5e493e202c2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-04 00:30:24.555243) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 00:30:24.555570) ========= 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.8rYkfBvt7I/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.KLE7pVEefE/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005129 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 00:30:24.603744) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 00:30:24.604062) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 00:30:24.604471) ========= ========= Total master_lag: 0.40 =========